builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1453615212.62 results: success (0) buildid: 20160123193118 builduid: 4b880af1b8884befa5f5e2b749af3623 revision: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.615555) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.616045) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.616388) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006537 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.642976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.643300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.667456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.667841) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004743 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.716946) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.717270) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.717687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.717995) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 22:00:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-23 22:00:13 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151170 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.881411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.881726) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015529 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.932260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.932648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 22:00:13,338 truncating revision to first 12 chars 2016-01-23 22:00:13,339 Setting DEBUG logging. 2016-01-23 22:00:13,339 attempt 1/10 2016-01-23 22:00:13,339 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6d81655dd9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 22:00:13,598 unpacking tar archive at: mozilla-central-d6d81655dd9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.486651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.486993) ========= echo d6d81655dd9e146c300a64c0fcaeb04ca3300a19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6d81655dd9e146c300a64c0fcaeb04ca3300a19'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6d81655dd9e146c300a64c0fcaeb04ca3300a19 program finished with exit code 0 elapsedTime=0.003837 script_repo_revision: 'd6d81655dd9e146c300a64c0fcaeb04ca3300a19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.536392) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.536756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.547231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-23 22:00:13.547559) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:14 INFO - MultiFileLogger online at 20160123 22:00:14 in /builds/slave/test-pgo 22:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:14 INFO - {'append_to_log': False, 22:00:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:14 INFO - 'blob_upload_branch': 'Firefox', 22:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:14 INFO - 'branch': 'Firefox', 22:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:14 INFO - 'config_files': ('talos/linux_config.py',), 22:00:14 INFO - 'default_actions': ('clobber', 22:00:14 INFO - 'read-buildbot-config', 22:00:14 INFO - 'download-and-extract', 22:00:14 INFO - 'populate-webroot', 22:00:14 INFO - 'create-virtualenv', 22:00:14 INFO - 'install', 22:00:14 INFO - 'run-tests'), 22:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:14 INFO - 'download_minidump_stackwalk': True, 22:00:14 INFO - 'download_symbols': 'ondemand', 22:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:14 INFO - 'installer_path': 'installer.exe', 22:00:14 INFO - 'log_level': 'info', 22:00:14 INFO - 'log_name': 'talos', 22:00:14 INFO - 'log_to_console': True, 22:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:14 INFO - 'opt_config_files': (), 22:00:14 INFO - 'pip_index': False, 22:00:14 INFO - 'sps_profile': False, 22:00:14 INFO - 'sps_profile_interval': 0, 22:00:14 INFO - 'suite': 'dromaeojs', 22:00:14 INFO - 'system_bits': '32', 22:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:14 INFO - 'title': 'talos-linux64-ix-037', 22:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:14 INFO - 'use_talos_json': True, 22:00:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:14 INFO - 'work_dir': 'build'} 22:00:14 INFO - ##### 22:00:14 INFO - ##### Running clobber step. 22:00:14 INFO - ##### 22:00:14 INFO - Running pre-action listener: _resource_record_pre_action 22:00:14 INFO - Running main action method: clobber 22:00:14 INFO - rmtree: /builds/slave/test-pgo/build 22:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:00:14 INFO - Running post-action listener: _resource_record_post_action 22:00:14 INFO - ##### 22:00:14 INFO - ##### Running read-buildbot-config step. 22:00:14 INFO - ##### 22:00:14 INFO - Running pre-action listener: _resource_record_pre_action 22:00:14 INFO - Running main action method: read_buildbot_config 22:00:14 INFO - Using buildbot properties: 22:00:14 INFO - { 22:00:14 INFO - "project": "", 22:00:14 INFO - "product": "firefox", 22:00:14 INFO - "script_repo_revision": "production", 22:00:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:00:14 INFO - "repository": "", 22:00:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:00:14 INFO - "buildid": "20160123193118", 22:00:14 INFO - "pgo_build": "True", 22:00:14 INFO - "basedir": "/builds/slave/test-pgo", 22:00:14 INFO - "buildnumber": 322, 22:00:14 INFO - "slavename": "talos-linux64-ix-037", 22:00:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:14 INFO - "platform": "ubuntu64_hw", 22:00:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:00:14 INFO - "branch": "mozilla-central", 22:00:14 INFO - "repo_path": "mozilla-central", 22:00:14 INFO - "revision": "d6d81655dd9e146c300a64c0fcaeb04ca3300a19", 22:00:14 INFO - "stage_platform": "linux64-pgo", 22:00:14 INFO - "builduid": "4b880af1b8884befa5f5e2b749af3623", 22:00:14 INFO - "slavebuilddir": "test" 22:00:14 INFO - } 22:00:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:00:14 INFO - Running post-action listener: _resource_record_post_action 22:00:14 INFO - ##### 22:00:14 INFO - ##### Running download-and-extract step. 22:00:14 INFO - ##### 22:00:14 INFO - Running pre-action listener: _resource_record_pre_action 22:00:14 INFO - Running main action method: download_and_extract 22:00:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:14 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json 22:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json 22:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:00:20 INFO - Downloaded 1448 bytes. 22:00:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:00:20 INFO - Using the following test package requirements: 22:00:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'jsshell-linux-x86_64.zip'], 22:00:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:20 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:21 INFO - Downloaded 22490362 bytes. 22:00:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:22 INFO - Return code: 0 22:00:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:22 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:23 INFO - Downloaded 22490362 bytes. 22:00:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:25 INFO - Return code: 0 22:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:25 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:00:26 INFO - Downloaded 10706572 bytes. 22:00:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:26 INFO - Return code: 0 22:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:26 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:00:27 INFO - Downloaded 55968050 bytes. 22:00:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:27 INFO - mkdir: /builds/slave/test-pgo/properties 22:00:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:00:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:00:27 INFO - Contents: 22:00:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:27 INFO - Running post-action listener: _resource_record_post_action 22:00:27 INFO - Running post-action listener: set_extra_try_arguments 22:00:27 INFO - ##### 22:00:27 INFO - ##### Running populate-webroot step. 22:00:27 INFO - ##### 22:00:27 INFO - Running pre-action listener: _resource_record_pre_action 22:00:27 INFO - Running main action method: populate_webroot 22:00:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:27 INFO - '--tppagecycles', 22:00:27 INFO - '7'], 22:00:27 INFO - 'tests': ['tsvgm']}}, 22:00:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:00:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'tests': ['damp', 'tps']}, 22:00:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['damp', 'tps']}, 22:00:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:00:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:27 INFO - 'other': {'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'other_l64': {'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'other_nol64': {'tests': ['a11yr', 22:00:27 INFO - 'ts_paint', 22:00:27 INFO - 'tpaint', 22:00:27 INFO - 'sessionrestore', 22:00:27 INFO - 'sessionrestore_no_auto_restore']}, 22:00:27 INFO - 'svgr': {'tests': ['tsvgx', 22:00:27 INFO - 'tsvgr_opacity', 22:00:27 INFO - 'tart', 22:00:27 INFO - 'tscrollx', 22:00:27 INFO - 'cart']}, 22:00:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['tsvgx', 22:00:27 INFO - 'tsvgr_opacity', 22:00:27 INFO - 'tart', 22:00:27 INFO - 'tscrollx', 22:00:27 INFO - 'cart']}, 22:00:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'tests': ['tp5o']}, 22:00:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'talos_options': ['--e10s'], 22:00:27 INFO - 'tests': ['tp5o']}, 22:00:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'talos_options': ['--xperf_path', 22:00:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:27 INFO - 'tests': ['tp5n']}, 22:00:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:27 INFO - 'talos_options': ['--e10s', 22:00:27 INFO - '--xperf_path', 22:00:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:27 INFO - 'tests': ['tp5n']}}, 22:00:27 INFO - 'talos.zip': {'path': '', 22:00:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:27 INFO - Running post-action listener: _resource_record_post_action 22:00:27 INFO - ##### 22:00:27 INFO - ##### Running create-virtualenv step. 22:00:27 INFO - ##### 22:00:27 INFO - Running pre-action listener: _resource_record_pre_action 22:00:27 INFO - Running main action method: create_virtualenv 22:00:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:00:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:00:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:00:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:27 INFO - Using real prefix '/usr' 22:00:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:00:28 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:30 INFO - Installing pip.................done. 22:00:30 INFO - Return code: 0 22:00:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:00:30 INFO - Using env: {'DISPLAY': ':0', 22:00:30 INFO - 'HOME': '/home/cltbld', 22:00:30 INFO - 'LANG': 'en_US.UTF-8', 22:00:30 INFO - 'LANGUAGE': 'en_US:en', 22:00:30 INFO - 'LOGNAME': 'cltbld', 22:00:30 INFO - 'MAIL': '/var/mail/cltbld', 22:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:30 INFO - 'MOZ_NO_REMOTE': '1', 22:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:30 INFO - 'NO_EM_RESTART': '1', 22:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:30 INFO - 'SHELL': '/bin/bash', 22:00:30 INFO - 'SHLVL': '1', 22:00:30 INFO - 'TERM': 'linux', 22:00:30 INFO - 'TMOUT': '86400', 22:00:30 INFO - 'USER': 'cltbld', 22:00:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:30 INFO - '_': '/tools/buildbot/bin/python'} 22:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:00:30 INFO - Cleaning up... 22:00:30 INFO - Return code: 0 22:00:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:00:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:00:30 INFO - Using env: {'DISPLAY': ':0', 22:00:30 INFO - 'HOME': '/home/cltbld', 22:00:30 INFO - 'LANG': 'en_US.UTF-8', 22:00:30 INFO - 'LANGUAGE': 'en_US:en', 22:00:30 INFO - 'LOGNAME': 'cltbld', 22:00:30 INFO - 'MAIL': '/var/mail/cltbld', 22:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:30 INFO - 'MOZ_NO_REMOTE': '1', 22:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:30 INFO - 'NO_EM_RESTART': '1', 22:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:30 INFO - 'SHELL': '/bin/bash', 22:00:30 INFO - 'SHLVL': '1', 22:00:30 INFO - 'TERM': 'linux', 22:00:30 INFO - 'TMOUT': '86400', 22:00:30 INFO - 'USER': 'cltbld', 22:00:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:30 INFO - '_': '/tools/buildbot/bin/python'} 22:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:30 INFO - Downloading/unpacking psutil>=0.7.1 22:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:32 INFO - Installing collected packages: psutil 22:00:32 INFO - Running setup.py install for psutil 22:00:32 INFO - building 'psutil._psutil_linux' extension 22:00:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:00:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:00:33 INFO - building 'psutil._psutil_posix' extension 22:00:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:00:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:00:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:33 INFO - Successfully installed psutil 22:00:33 INFO - Cleaning up... 22:00:33 INFO - Return code: 0 22:00:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:00:33 INFO - Using env: {'DISPLAY': ':0', 22:00:33 INFO - 'HOME': '/home/cltbld', 22:00:33 INFO - 'LANG': 'en_US.UTF-8', 22:00:33 INFO - 'LANGUAGE': 'en_US:en', 22:00:33 INFO - 'LOGNAME': 'cltbld', 22:00:33 INFO - 'MAIL': '/var/mail/cltbld', 22:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:33 INFO - 'MOZ_NO_REMOTE': '1', 22:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:33 INFO - 'NO_EM_RESTART': '1', 22:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:33 INFO - 'SHELL': '/bin/bash', 22:00:33 INFO - 'SHLVL': '1', 22:00:33 INFO - 'TERM': 'linux', 22:00:33 INFO - 'TMOUT': '86400', 22:00:33 INFO - 'USER': 'cltbld', 22:00:33 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:33 INFO - '_': '/tools/buildbot/bin/python'} 22:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:00:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:35 INFO - Installing collected packages: mozsystemmonitor 22:00:35 INFO - Running setup.py install for mozsystemmonitor 22:00:35 INFO - Successfully installed mozsystemmonitor 22:00:35 INFO - Cleaning up... 22:00:35 INFO - Return code: 0 22:00:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:00:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:35 INFO - Using env: {'DISPLAY': ':0', 22:00:35 INFO - 'HOME': '/home/cltbld', 22:00:35 INFO - 'LANG': 'en_US.UTF-8', 22:00:35 INFO - 'LANGUAGE': 'en_US:en', 22:00:35 INFO - 'LOGNAME': 'cltbld', 22:00:35 INFO - 'MAIL': '/var/mail/cltbld', 22:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:35 INFO - 'MOZ_NO_REMOTE': '1', 22:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:35 INFO - 'NO_EM_RESTART': '1', 22:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:35 INFO - 'SHELL': '/bin/bash', 22:00:35 INFO - 'SHLVL': '1', 22:00:35 INFO - 'TERM': 'linux', 22:00:35 INFO - 'TMOUT': '86400', 22:00:35 INFO - 'USER': 'cltbld', 22:00:35 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:35 INFO - '_': '/tools/buildbot/bin/python'} 22:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:37 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:38 INFO - Downloading docopt-0.6.1.tar.gz 22:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:38 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:38 INFO - Running setup.py install for blobuploader 22:00:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:38 INFO - Running setup.py install for requests 22:00:38 INFO - Running setup.py install for docopt 22:00:38 INFO - Successfully installed blobuploader requests docopt 22:00:38 INFO - Cleaning up... 22:00:39 INFO - Return code: 0 22:00:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:39 INFO - Using env: {'DISPLAY': ':0', 22:00:39 INFO - 'HOME': '/home/cltbld', 22:00:39 INFO - 'LANG': 'en_US.UTF-8', 22:00:39 INFO - 'LANGUAGE': 'en_US:en', 22:00:39 INFO - 'LOGNAME': 'cltbld', 22:00:39 INFO - 'MAIL': '/var/mail/cltbld', 22:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:39 INFO - 'MOZ_NO_REMOTE': '1', 22:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:39 INFO - 'NO_EM_RESTART': '1', 22:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:39 INFO - 'SHELL': '/bin/bash', 22:00:39 INFO - 'SHLVL': '1', 22:00:39 INFO - 'TERM': 'linux', 22:00:39 INFO - 'TMOUT': '86400', 22:00:39 INFO - 'USER': 'cltbld', 22:00:39 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:39 INFO - '_': '/tools/buildbot/bin/python'} 22:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:39 INFO - Running setup.py (path:/tmp/pip-5T906a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:39 INFO - Running setup.py (path:/tmp/pip-WxmWDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:39 INFO - Running setup.py (path:/tmp/pip-9xHUGr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:39 INFO - Running setup.py (path:/tmp/pip-jaRx9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:39 INFO - Running setup.py (path:/tmp/pip-cfAHK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:39 INFO - Running setup.py (path:/tmp/pip-z3VfCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:39 INFO - Running setup.py (path:/tmp/pip-p5Rjr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:39 INFO - Running setup.py (path:/tmp/pip-f3kfoO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:39 INFO - Running setup.py (path:/tmp/pip-VL8h0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:39 INFO - Running setup.py (path:/tmp/pip-L8Kgf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:39 INFO - Running setup.py (path:/tmp/pip-XtypNk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:40 INFO - Running setup.py (path:/tmp/pip-kJ5uN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:40 INFO - Running setup.py (path:/tmp/pip-g4eTOt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:40 INFO - Running setup.py (path:/tmp/pip-GcmVZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:40 INFO - Running setup.py (path:/tmp/pip-Ta1OnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:40 INFO - Running setup.py (path:/tmp/pip-NwEA85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:40 INFO - Running setup.py (path:/tmp/pip-r3i35L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:40 INFO - Running setup.py install for manifestparser 22:00:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:40 INFO - Running setup.py install for mozcrash 22:00:40 INFO - Running setup.py install for mozdebug 22:00:40 INFO - Running setup.py install for mozdevice 22:00:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:40 INFO - Running setup.py install for mozfile 22:00:40 INFO - Running setup.py install for mozhttpd 22:00:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozinfo 22:00:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozInstall 22:00:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozleak 22:00:41 INFO - Running setup.py install for mozlog 22:00:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for moznetwork 22:00:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozprocess 22:00:41 INFO - Running setup.py install for mozprofile 22:00:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozrunner 22:00:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:41 INFO - Running setup.py install for mozscreenshot 22:00:42 INFO - Running setup.py install for moztest 22:00:42 INFO - Running setup.py install for mozversion 22:00:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:42 INFO - Cleaning up... 22:00:42 INFO - Return code: 0 22:00:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:42 INFO - Using env: {'DISPLAY': ':0', 22:00:42 INFO - 'HOME': '/home/cltbld', 22:00:42 INFO - 'LANG': 'en_US.UTF-8', 22:00:42 INFO - 'LANGUAGE': 'en_US:en', 22:00:42 INFO - 'LOGNAME': 'cltbld', 22:00:42 INFO - 'MAIL': '/var/mail/cltbld', 22:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:42 INFO - 'MOZ_NO_REMOTE': '1', 22:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:42 INFO - 'NO_EM_RESTART': '1', 22:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:42 INFO - 'SHELL': '/bin/bash', 22:00:42 INFO - 'SHLVL': '1', 22:00:42 INFO - 'TERM': 'linux', 22:00:42 INFO - 'TMOUT': '86400', 22:00:42 INFO - 'USER': 'cltbld', 22:00:42 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:42 INFO - '_': '/tools/buildbot/bin/python'} 22:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:42 INFO - Running setup.py (path:/tmp/pip-oFNPyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:42 INFO - Running setup.py (path:/tmp/pip-d4D0hj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:42 INFO - Running setup.py (path:/tmp/pip-VCk6vq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:42 INFO - Running setup.py (path:/tmp/pip-fRRbyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:42 INFO - Running setup.py (path:/tmp/pip-BOPuN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:42 INFO - Running setup.py (path:/tmp/pip-vR0Lmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:42 INFO - Running setup.py (path:/tmp/pip-4TRgvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:42 INFO - Running setup.py (path:/tmp/pip-vRdvIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:43 INFO - Running setup.py (path:/tmp/pip-EAw7nZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:43 INFO - Running setup.py (path:/tmp/pip-saIkzb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:43 INFO - Running setup.py (path:/tmp/pip-nBYef3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:43 INFO - Running setup.py (path:/tmp/pip-nWeNXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:43 INFO - Running setup.py (path:/tmp/pip-C4nGqO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:43 INFO - Running setup.py (path:/tmp/pip-dDz3FK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:43 INFO - Running setup.py (path:/tmp/pip-f1efwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:43 INFO - Running setup.py (path:/tmp/pip-rSVIzD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:43 INFO - Running setup.py (path:/tmp/pip-V8mVgK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:45 INFO - Downloading blessings-1.6.tar.gz 22:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:45 INFO - Installing collected packages: blessings 22:00:45 INFO - Running setup.py install for blessings 22:00:45 INFO - Successfully installed blessings 22:00:45 INFO - Cleaning up... 22:00:45 INFO - Return code: 0 22:00:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:45 INFO - Reading from file tmpfile_stdout 22:00:45 INFO - Current package versions: 22:00:45 INFO - argparse == 1.2.1 22:00:45 INFO - blessings == 1.6 22:00:45 INFO - blobuploader == 1.2.4 22:00:45 INFO - docopt == 0.6.1 22:00:45 INFO - manifestparser == 1.1 22:00:45 INFO - mozInstall == 1.12 22:00:45 INFO - mozcrash == 0.16 22:00:45 INFO - mozdebug == 0.1 22:00:45 INFO - mozdevice == 0.48 22:00:45 INFO - mozfile == 1.2 22:00:45 INFO - mozhttpd == 0.7 22:00:45 INFO - mozinfo == 0.9 22:00:45 INFO - mozleak == 0.1 22:00:45 INFO - mozlog == 3.1 22:00:45 INFO - moznetwork == 0.27 22:00:45 INFO - mozprocess == 0.22 22:00:45 INFO - mozprofile == 0.28 22:00:45 INFO - mozrunner == 6.11 22:00:45 INFO - mozscreenshot == 0.1 22:00:45 INFO - mozsystemmonitor == 0.0 22:00:45 INFO - moztest == 0.7 22:00:45 INFO - mozversion == 1.4 22:00:45 INFO - psutil == 3.1.1 22:00:45 INFO - requests == 1.2.3 22:00:45 INFO - wsgiref == 0.1.2 22:00:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:45 INFO - Using env: {'DISPLAY': ':0', 22:00:45 INFO - 'HOME': '/home/cltbld', 22:00:45 INFO - 'LANG': 'en_US.UTF-8', 22:00:45 INFO - 'LANGUAGE': 'en_US:en', 22:00:45 INFO - 'LOGNAME': 'cltbld', 22:00:45 INFO - 'MAIL': '/var/mail/cltbld', 22:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:45 INFO - 'MOZ_NO_REMOTE': '1', 22:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:45 INFO - 'NO_EM_RESTART': '1', 22:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:45 INFO - 'SHELL': '/bin/bash', 22:00:45 INFO - 'SHLVL': '1', 22:00:45 INFO - 'TERM': 'linux', 22:00:45 INFO - 'TMOUT': '86400', 22:00:45 INFO - 'USER': 'cltbld', 22:00:45 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:45 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:46 INFO - Using env: {'DISPLAY': ':0', 22:00:46 INFO - 'HOME': '/home/cltbld', 22:00:46 INFO - 'LANG': 'en_US.UTF-8', 22:00:46 INFO - 'LANGUAGE': 'en_US:en', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MAIL': '/var/mail/cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SHLVL': '1', 22:00:46 INFO - 'TERM': 'linux', 22:00:46 INFO - 'TMOUT': '86400', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Downloading/unpacking jsonschema 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:48 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:48 INFO - warning: no files found matching '*.txt' 22:00:48 INFO - no previously-included directories found matching 'build' 22:00:48 INFO - no previously-included directories found matching 'dist' 22:00:48 INFO - no previously-included directories found matching '.git*' 22:00:48 INFO - Installing collected packages: jsonschema, functools32 22:00:48 INFO - Running setup.py install for functools32 22:00:48 INFO - warning: no files found matching '*.txt' 22:00:48 INFO - no previously-included directories found matching 'build' 22:00:48 INFO - no previously-included directories found matching 'dist' 22:00:48 INFO - no previously-included directories found matching '.git*' 22:00:48 INFO - Successfully installed jsonschema functools32 22:00:48 INFO - Cleaning up... 22:00:48 INFO - Return code: 0 22:00:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f65518a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2426630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:00:48 INFO - Using env: {'DISPLAY': ':0', 22:00:48 INFO - 'HOME': '/home/cltbld', 22:00:48 INFO - 'LANG': 'en_US.UTF-8', 22:00:48 INFO - 'LANGUAGE': 'en_US:en', 22:00:48 INFO - 'LOGNAME': 'cltbld', 22:00:48 INFO - 'MAIL': '/var/mail/cltbld', 22:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:48 INFO - 'MOZ_NO_REMOTE': '1', 22:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:48 INFO - 'NO_EM_RESTART': '1', 22:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:48 INFO - 'SHELL': '/bin/bash', 22:00:48 INFO - 'SHLVL': '1', 22:00:48 INFO - 'TERM': 'linux', 22:00:48 INFO - 'TMOUT': '86400', 22:00:48 INFO - 'USER': 'cltbld', 22:00:48 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:48 INFO - '_': '/tools/buildbot/bin/python'} 22:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:48 INFO - Downloading/unpacking flake8 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:51 INFO - no previously-included directories found matching 'docs/_build' 22:00:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:51 INFO - Running setup.py install for pep8 22:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:51 INFO - no previously-included directories found matching 'docs/_build' 22:00:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:51 INFO - Cleaning up... 22:00:51 INFO - Return code: 0 22:00:51 INFO - Running post-action listener: _resource_record_post_action 22:00:51 INFO - Running post-action listener: _start_resource_monitoring 22:00:51 INFO - Starting resource monitoring. 22:00:51 INFO - ##### 22:00:51 INFO - ##### Running install step. 22:00:51 INFO - ##### 22:00:51 INFO - Running pre-action listener: _resource_record_pre_action 22:00:51 INFO - Running main action method: install 22:00:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:51 INFO - Reading from file tmpfile_stdout 22:00:51 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:51 INFO - Reading from file tmpfile_stdout 22:00:51 INFO - Output received: 22:00:51 INFO - Usage: mozinstall [options] installer 22:00:51 INFO - Options: 22:00:51 INFO - -h, --help show this help message and exit 22:00:51 INFO - -d DEST, --destination=DEST 22:00:51 INFO - Directory to install application into. [default: 22:00:51 INFO - "/builds/slave/test-pgo"] 22:00:51 INFO - --app=APP Application being installed. [default: firefox] 22:00:51 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:01:07 INFO - Reading from file tmpfile_stdout 22:01:07 INFO - Output received: 22:01:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:07 INFO - Running post-action listener: _resource_record_post_action 22:01:07 INFO - ##### 22:01:07 INFO - ##### Running run-tests step. 22:01:07 INFO - ##### 22:01:07 INFO - Running pre-action listener: _resource_record_pre_action 22:01:07 INFO - Running main action method: run_tests 22:01:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:07 INFO - Python 2.7.3 22:01:07 INFO - Return code: 0 22:01:07 INFO - grabbing minidump binary from tooltool 22:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:07 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b7840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2424b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:01:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:01:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:07 INFO - Return code: 0 22:01:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:01:08 INFO - Return code: 0 22:01:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:01:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:01:08 INFO - Using env: {'DISPLAY': ':0', 22:01:08 INFO - 'HOME': '/home/cltbld', 22:01:08 INFO - 'LANG': 'en_US.UTF-8', 22:01:08 INFO - 'LANGUAGE': 'en_US:en', 22:01:08 INFO - 'LOGNAME': 'cltbld', 22:01:08 INFO - 'MAIL': '/var/mail/cltbld', 22:01:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:08 INFO - 'MOZ_NO_REMOTE': '1', 22:01:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:08 INFO - 'NO_EM_RESTART': '1', 22:01:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:08 INFO - 'SHELL': '/bin/bash', 22:01:08 INFO - 'SHLVL': '1', 22:01:08 INFO - 'TERM': 'linux', 22:01:08 INFO - 'TMOUT': '86400', 22:01:08 INFO - 'USER': 'cltbld', 22:01:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307', 22:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:08 INFO - '_': '/tools/buildbot/bin/python'} 22:01:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:01:09 INFO - mozversion application_buildid: 20160123193118 22:01:09 INFO - mozversion application_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 22:01:09 INFO - mozversion application_display_name: Nightly 22:01:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:09 INFO - mozversion application_name: Firefox 22:01:09 INFO - mozversion application_remotingname: firefox 22:01:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:01:09 INFO - mozversion application_vendor: Mozilla 22:01:09 INFO - mozversion application_version: 46.0a1 22:01:09 INFO - mozversion platform_buildid: 20160123193118 22:01:09 INFO - mozversion platform_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 22:01:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:01:09 INFO - mozversion platform_version: 46.0a1 22:01:09 INFO - using testdate: 1453615269 22:01:09 INFO - actual date: 1453615269 22:01:09 INFO - starting webserver on 'localhost:56278' 22:01:09 INFO - SUITE-START | Running 3 tests 22:01:09 INFO - TEST-START | dromaeo_css 22:01:09 INFO - operating with platform_type : linux_ 22:01:09 INFO - Initialising browser for dromaeo_css test... 22:01:09 INFO - TEST-INFO | started process 29052 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKjY4ah/profile http://localhost:56278/getInfo.html) 22:01:13 INFO - PROCESS | 29052 | __metrics Screen width/height:1600/1200 22:01:13 INFO - PROCESS | 29052 | colorDepth:24 22:01:13 INFO - PROCESS | 29052 | Browser inner width/height: 1024/697 22:01:13 INFO - PROCESS | 29052 | __metrics 22:01:13 INFO - PROCESS | 29052 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:01:13 INFO - PROCESS | 29052 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:14 INFO - TEST-INFO | 29052: exit 0 22:01:14 INFO - Browser initialized. 22:01:14 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:14 INFO - TEST-INFO | started process 29143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKjY4ah/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:26 INFO - PROCESS | 29143 | RSS: Main: 147136512 22:01:26 INFO - PROCESS | 29143 | 22:02:17 INFO - PROCESS | 29143 | 1453615337862 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:04:26 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56278/tests/dromaeo/cssquery-ext.html) 22:04:27 INFO - PROCESS | 29143 | RSS: Main: 264544256 22:04:27 INFO - PROCESS | 29143 | 22:07:29 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-ext.html (next: http://localhost:56278/tests/dromaeo/cssquery-jquery.html) 22:07:30 INFO - PROCESS | 29143 | RSS: Main: 228614144 22:07:30 INFO - PROCESS | 29143 | 22:10:32 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56278/tests/dromaeo/cssquery-mootools.html) 22:10:33 INFO - PROCESS | 29143 | RSS: Main: 225714176 22:10:33 INFO - PROCESS | 29143 | 22:13:34 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56278/tests/dromaeo/cssquery-prototype.html) 22:13:35 INFO - PROCESS | 29143 | RSS: Main: 209448960 22:13:35 INFO - PROCESS | 29143 | 22:16:38 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56278/tests/dromaeo/cssquery-yui.html) 22:16:38 INFO - PROCESS | 29143 | RSS: Main: 213639168 22:16:38 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:56278/tests/dromaeo/cssquery-yui.html (next: http://localhost:56278/tests/dromaeo/cssquery-dojo.html) 22:19:41 INFO - PROCESS | 29143 | RSS: Main: 227024896 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | __start_tp_report 22:19:41 INFO - PROCESS | 29143 | _x_x_mozilla_page_load 22:19:41 INFO - PROCESS | 29143 | _x_x_mozilla_page_load_details 22:19:41 INFO - PROCESS | 29143 | |i|pagename|runs| 22:19:41 INFO - PROCESS | 29143 | |0;dojo.html;3112.050824498528;3116.0807561769275;3170.461021626323;3171.3974344874487;3201.0396880935714;5011.32347133137;5082.4917508249155;5083.720395378257;5112.182050871866;5129.07676618209;5097.770600322985;5106.923396149061;5121.180611102224;5141.434442211354;5141.588672906168;4487.19230538503;4619.722816631013;4663.300504924263;4738.076075165344;4839.7096174229655;4637.234856248715;4715.033418149288;4787.593054590364;4790.041991601676;4884.145274576953;4715.386999690053;4785.234362502018;4787.6648634595595;4807.519248075199;4830.372051633265;4732.645051621143;4735.502772208937;4739.73931433771;4756;4805.807767689324;4610.331501932201;4711.175544279771;4712.458067322234;4749;4773.236282194832;4892.706437613754;4963.6277279204205;4981.72600506972;4987.700737955734;5024.547790698818;5499.670019798825;5500.22996780451;5501.229827824108;5504;5513.062779327524;5416.160495123223;5505.752241149158;5559.305086864142;5599.608027438081;5620.9437905620825;5105.668131571473;5173.430922598511;5250.238715386247;5276.947230527722;5292.52367286946;5702.714864256854;5711.143328500675;5714.314282286069;5719.142128680731;5720.456556627114;5490.094134467848;5497.065498865122;5508.807191748269;5515.531179849758;5538.252335934678;5309.097453432849;5439.211314359396;5452.018636645442;5490.176473529003;5556.888862222733;5498.422665620053;5514.172874068921;5520.806771762969;5532.889342213133;5553.250311207935;5506.174073888948;5516.393196748435;5524.66851988882;5533.391326954032;5578.497935185853;4173.227952828736;4248.660107191417;4295.226859165317;4304.913901721948;4372.562743725665;3844.8462061517225;3873.573906870242;3883;3915.256101340793;3921.431392448136;5107.33604631403;5107.540321371094;5116.513931176532;5120.206368012964;5128.333316668809;5421.891562168735;5443.34679838414;5444.8366549003595;5455.781768729206;5517.834464966058;5101.464346243665;5103.948960510422;5105.846824595268;5121.07820592297;5124.385073791169;4736.265878788793;4737.526247375304;4738.952610473852;4741.383620129361;4787.664863459524;5605.66366018032;5678.063119585305;5696.629719068247;5698.088305871123;5744.368119506851;5565.9721701392855;5596.300462442195;5604.691741954069;5617.43825617435;5651.43485651448;5670.262865827416;5698.686572238566;5706.629069110494;5709.172170035238;5721.5136713379825;5325.4940780625775;5388.892222155457;5409.459054094559;5411.242426060276;5428.45715428454;5492.697901615449;5541.085720856014;5551.944480555143;5556.333240011225;5573.944260557505;5378.811741589026;5401.3248343957;5413.621046526705;5430.456954304538;5481.588880834033;5225.712585807817;5318.069337865935;5370.677759334452;5396.190571414162;5484.890302193854;5302.469753024667;5341.092014357491;5344.545713614386;5347.839564813062;5352.116900711495;5412.648177868426;5434.510894019557;5447.182922561489;5468.261784659179;5513.145462453326;5169.198774190007;5249.2126181073145;5328.60035497347;5344.812931547377;5406.107992181246 22:19:41 INFO - PROCESS | 29143 | |1;ext.html;535.1464414259256;560.3751816724352;570.8601392658798;576.4091805898953;576.4293349583913;27601.723982760166;38299.23401531968;39256.21487570247;39269.8036509817;39352.40971385428;43369;43990;43999.78000110003;44008.3398749019;44044.77977610107;8533.786655333619;8775.210231079202;8779.385443018991;8792.47245165289;8803.823923521526;8502.06477287501;8613.61238744258;8615.741527754177;8620.137986201393;8634;8617.095205003447;8680.08859069795;8680.826383472358;8687.305015598737;8691.60887760049;8585.18440748128;8615.267702245317;8617.870731939025;8632.050474447806;8641.179087986662;8409.789755256106;8539.316854651614;8545.74362769118;8548.102449242864;8550.40147189697;39229.80385098085;39552.80223598892;39677.80161099176;39774.801125994476;39795.801020995;2865.9856700716573;2980.8807647694066;3152.858121384543;3215.7105860472434;3269.1663625775277;29735.405291894258;29942;30209.395812083854;30431.847840760875;31200.531992020136;3962.7424217425773;3982.522097348308;4014.9197016059516;4031.274728884316;4084.6323830855367;261465;262451;262728;263235;263817;52781.2082818758;58506;58859;59018.70490647519;59145.40854591485;44777.32834007493;44973.77513112414;45139;62162.68918655378;63111.684441578414;13045.282509462071;13124.868751312555;13143.408546615425;13181.406836692371;13207.207567545978;10447.791044179074;10538.367697938149;10543.31468454548;10547.947260263649;10549.103326217204;17655.73516397255;18136.183871725803;18138.546536336697;20950;21467.67798483024;7334.486585938933;7483.8503229935095;7503.5497870127965;7531.322181003736;7657.081150261893;922.686286662538;949.6960972488876;962.552413127899;1033.132168978047;1080.254624309224;28732.13803585896;29301.41397172087;29398.26504337366;29467.85266073656;29680.851595741882;979.8677178580942;1024.8565200871883;1026.609888242478;1106.645873320546;1120.38938778366;13353.399097040463;13355.933220333836;13595.45618175262;13625.182489050689;13976.790348144787;326371;329071;329729;329933;330539;43969.12061758747;44568.55431445709;52983.73508132435;53244.73377633165;53401.73299133479;1316.2168509736691;1332.3271747767315;1335.8797708206307;1340.7921772125337;1352.3576301257021;26145.477090458466;27022;27369.863150684916;28176.039022050085;28763.137105886857;44789;44795.77602111969;44945;45118.0976380464;45127.32309015302;244479;245232;247356;248624;249862;33014;33076.83461582677;33080.172995675304;33212.50181247235;33320;42637.14725705531;42837.357439639054;43423.34864976965;43799.34300985424;44101;36267;36340.45489317715;36362.63637363593;36654.63345366619;37595;36099.63900360963;36405.63594364128;36845.81577092098;36969.63030369662;37024;35025.12437189091;35154;35438.29123417569;35716;35813.28373432464;29138.417231655672;29654.555181672724;33865.83067084649;35608.10979725424;35740.82129589335;23865.64201537013;24403.877980609985;24408.6338704916;24721.62917556274;24781.380465488506 22:19:41 INFO - PROCESS | 29143 | |2;jquery.html;362.2971435415294;363.39676137611553;369.1178084378336;370.228074464741;371.1463633642623;13085.67285817855;13128.146670466413;15351;16434.50696479106;17653.20560574774;15769.684606307896;16064.27710753016;16546.50360489184;16702.749458758128;16716.66566668666;5159.1229490986525;5323.760430780605;5334.306540149775;5340.732963351837;5341.30563026806;3975.9801200993957;4116.382542618616;5235.712035838027;5318.175682769177;5586.162075688639;5688.175214593902;5692.373838877741;5749.367569567345;5751.712414379264;5751.712414379285;5006.1990081586955;5222.451642577551;5249.1076516991825;5257.5005374489365;5266.025785229725;4882.072406242803;5043.167877300241;5053.570446512051;5066.113430149709;5068.898622027539;12900.870991290061;13627.591172264847;17606.38377656776;19798.72314683801;19890.502737431536;2137.540428807814;2164.285785690718;2166.3392665237097;2270.1373478078226;2286.474110954473;8863.468191908441;9299.302552308536;9522.571484283155;9696.806063878754;9876.753081173028;1829.7072468404992;1840.9355672551396;1881.2098918454283;1882.0777818868655;1882.5670095878024;49132;52403.73798131023;52411.47588524142;52531.21203181955;53839;10079.34484258521;10148.340357876861;10200.489975501196;10207.744806379751;10280.383177009404;12855.550055748005;13212.33938303081;13222.669433264246;13244.668883277995;13258.867411325764;7086.078809754699;7128.073350464407;7134.857302853914;7168.354848063699;7187.281271872771;6680.031395447633;6695.564788288746;6753.493487988322;6781.8643627127185;6801.693923773442;4424.292113261863;4471.374007638933;4480.484744254387;4539.9773001135445;4547.658925580595;1712.315073970397;1774.299151835018;1797.81122982085;1857.1735577668078;1875.981240187608;861.2765277167209;921.6681994481982;927.6614035876856;929.3123088914155;1034.2656713733184;14707.779383309258;15277.312520936584;15532.844671553366;15618.843811561967;15651.765223521656;925.0240995749549;926.5135803702975;935.2331088507359;962.3311798300114;990.3117333453325;8035.558044307502;9411.811763764686;9423;9448.149666530046;9527.428354298765;473147;484098;485010;520714;524219;63156;63644.4088897772;67627.91348778634;68053;68139.31860681428;1050.564015933379;1086.0551320351344;1088.5700148441479;1107.7230692326918;1152.9827052594385;14172.858271417153;14213.218272995084;14841.183734894685;15017.174055427056;15183.013104148195;30156.547651784804;30893.53659695151;31781.523277150398;32549.837250813594;32724;38105.79475300958;39458.40812387874;39537.406938895365;39858;39979;7115.53749006313;7287.8542429152185;7316.926830731624;7450.552966822008;7599.734009309647;10507.474626268504;10870.239083264096;10997.12023038139;11060.668179954615;11083.778324433628;9587.743010184246;9607.56765945548;9772.80454390894;9782.119609235204;9785;9430.19843313326;9806.117449429586;9865.901340986498;9966.40201587907;10055.69832905014;9688.806223875625;9791.996168219272;9947.353422027545;10098.444585547571;10162.441065741159;7283.7450689225625;7286.380657644159;7306.561606303639;7386.446016548673;7426.220246874001;8563.82872342562;9087.636494540144;9902.455364954709;9914.950425247827;10003.749906252402 22:19:41 INFO - PROCESS | 29143 | |3;mootools.html;1239.9752004959907;1466.3474753734588;1480.7852861335102;1633.7222672145733;1785.4911350265177;6735.932640673592;7476;7692.115406728228;7701.730439434621;7701.961490192555;7601.581912994783;7760.262775036376;7780.610969451519;7787;7793.727219547317;1967;2011.0849563448596;2011.4669612552684;2318.53629274145;2348.941276468085;1997.320910890297;2282.1784157703296;2314.895829687668;2321.257197696738;2322.2452702871633;2215.7008803811523;2217.5010622609866;2220.622494175986;2222.022310183514;2316.7683231676865;2263.0382087612697;2268.0587556164173;2290.89690963907;2297.885105744706;2298.528801595677;2258.570871534403;2280.395695140789;2283.1209984156053;2291.644795056769;2297.1615360393334;7809.492382995087;7876.17300183484;7886.250806173404;7895;7898.486598371088;4771.904561908743;4848.806047758086;4852.393450818648;4888.291197776302;4896.2410826321975;2968.1095671298526;3086;3092.706192911692;3139;3141.120486263827;1000.9399436033862;1014;1020.3928662445833;1053.5259133390005;1063.3354153653966;11024.724381890517;11048.447577621168;11052.005319521202;11056.336619802758;11057;4388.341748737651;4415.911681766347;4437.600615944581;4439.711418757771;4541.704789188692;9196.034416386317;9196.908030919605;9213.539323033821;9223.216026637676;9228.907710922938;4968.677035992649;4970.155073637418;4971.130052240844;4972.030454061495;4972.701637901738;4432.689711720149;4450.109978004347;4480.193565158238;4492.348609451611;4493.393391892053;3454.9827250863586;3760.9059773505332;3826.4069069294305;3875.399313106473;3878.8836334909997;1125.831125331207;1146.5241924601364;1232.5932442294022;1245.4929535262254;1255.7488502299577;1023.1047833145997;1048.156234231451;1051.458498873081;1130.361345839598;1279.353926267229;7005.299470052954;7144.214136444987;7152.070230869954;7171.426285897116;7185.964070179615;1078.1374900079904;1080.68660088575;1100.6973082402403;1104.116706634689;1104.7127746785734;5697.971510142423;5820.3888591698105;5826.126081087786;5830.38780928005;5841.06542953134;9199.310051746012;9366.718998430058;9551.713448596553;9555.044495550528;9567.90432095684;9402.341836071546;9423.764405889908;9508.096730810563;9515.619375225051;9545.713628591153;7313.451491138186;7320.853582928312;7464.402847772165;7480.02759641254;7492.363149132276;7106.751263705745;7196.172440169447;7196.208417074223;7197.424206063607;7198.280171982759;8100.918990810253;8317.792055198426;8552.914470855212;8556.18716221958;8575.271101956154;8509.064002959545;8561.743147705578;8694.869576956224;8736.432131911406;8754.299656027375;6667.366600172976;6895.448364130958;6896.931030689629;6951.617661028692;6963.9303606963285;6293.150424692608;7494.5503269803985;7545.584992825447;7560.319571238615;7561.697532098655;6362.363763623601;6618.90071648916;6930.3762661360715;7148.678309475982;7302.123745150616;6913.792586222421;7020.333068358498;7114.324139206767;7166.713331466683;7185.712571497082;6912.723491060301;6964.880812602834;6976.6860491277;7007.789766307019;7020.297970202939;6384.265809431975;6416.679166041586;6424.646644434601;6434.131392261985;6436.16329877113;6719.361660642231;6799.830004249933;6862.142232220973;6866.553674011373;6874.828129296808 22:19:41 INFO - PROCESS | 29143 | |4;prototype.html;320.78507400041974;335.4800059907144;343.0890984436322;347.9251960828423;354.2419222863072;5829.154772557977;5836.095405212193;5856.707164641767;5900.970495147529;5958.016927207005;5573.944260557393;5683.630564013347;5701.230333904932;5799.971000145004;5878.412158784119;4519.050999290145;4537.410136682243;4585.70192937458;4602.654800889946;4602.792874320647;4346.717463364887;4597.517260687613;4605.769711514427;4609.032103258303;4617.399738034068;4378.9562104378865;4413.3159360299205;4507.918099656092;4514.841980530682;4518.277075667894;4478.261086920655;4479.7088189267915;4488.618467430272;4506.1663592235545;4507.594316511497;4015.4779878615886;4016.7991600420155;4025.778582177979;4035.556088830226;4047.898802529931;5461.098918678414;5559.166125081229;5564.721763911829;5565.276514053187;5566.443355664401;5310.70791106489;5333.040052790496;5336.813211537617;5338.359396872362;5340.198970154469;6224.253089629274;6224.350547105021;6228.470580000705;6238.251409830849;6249.156363890862;4446.577575130357;4486;4493.618042466394;4496.595306422405;4512.435945506812;6339.58792678479;6511.739530418778;6515.087887695727;6527.706253218616;6544.640044797487;4522.5025247222775;4538.977305113519;4545.409096817392;4556.3621093047;4556.544345565483;4595.4025976622825;4608.262677971508;4613;4613.2388155953895;4615.815367385267;5242.868928276824;5267.3152490176035;5275.788968441219;5276.050310944067;5277.736113194325;6126.356732543108;6289.591176573508;6318.147050148171;6327.240731112296;6332.145160403286;1597.5766421898206;1624.7887774589228;1625.8130315013689;1627.2270671430977;1628.1208147600164;1086.7283179205199;1091.5033659684825;1093.6930368209912;1099.934003959765;1118.608487029533;5934.792282270186;5937.317208520989;5942.257217847769;5944.256967879015;5948.970255148696;6466.353364663496;6469.935300646934;6469.935300647027;6472.838179045468;6478.611283323015;5737.254156959652;5806.709664516758;5831.271091113611;5841.153032810219;5990.850228744229;3479.6520347965;3485.4074807282823;3502.9124271893406;3504.5268888700207;3506.474028895686;6534.477241820738;6800.285969973082;6813.829654258584;6815.318468153244;6818;6510.707018184193;6559.7376104955265;6658.933410665832;6660.733570657217;6670.633115178614;6751.797446076625;6773.695183716744;6777.152855893013;6781.525293229525;6791.728330866808;6355.7457701693265;6489.902651460137;6496.382843629847;6499;6504.739810407531;6434.839129021625;6437.517186210959;6443.7744678936015;6451.96768517035;6453.193350831146;6787.490938179558;6798.4221341184575;6808.217055038734;6861.622610756456;6863.725450981905;4407.316865885793;4534.977325113486;4540.06928579647;4544.250198717307;4545.9090818182785;6487.286398496256;6496.577722448026;6508.576942498722;6509.446697030806;6513.967430162819;6274.811755647338;6333.8733225336155;6335.3981371769605;6347.682615869096;6348.809535713936;6231.337032255571;6275.058741188675;6318.241810982711;6320.810375688737;6331.240251169889;6195.535334849814;6234.0337247726675;6273.65494897785;6278.309385967631;6283.497320214463;6349.904751428639;6350.206224221973;6354.904676429765;6360.045993101072;6364.713587888648;6038.698065096815;6192.659403732658;6199.256089269316;6213.627182369072;6231.813045608639 22:19:41 INFO - PROCESS | 29143 | |5;yui.html;786.4848524216638;863.935204859635;868.1925808997634;870.865015922532;888.591248025908;13139.73720525589;13259.204447733142;13296.401661925212;13322.800157997637;13357.53248636298;10919;12253.816192757116;12293.26240425575;12326.691832704188;12342.136050476447;644.3846126948777;795.4352409789057;813.0446725097986;813.0527934955799;813.3574476163853;801.883726859605;810.4043528006939;810.4529442626233;813.7029984055806;815.7226542975387;693.7675878580682;707.0384277382756;844.9915500845005;848.6308455821707;849.668629234599;816.2979837339883;830.2983978538186;830.3938125168601;832.009908209229;832.6877420967137;614.8217017065045;614.9975539869984;616.3128112154915;616.654673382907;616.8951278282658;12195.329256890867;12257.019438444902;12260.203086799329;12261.203021803643;12291.938540307241;11920.165588408814;12326.32205228712;12567.937160314232;12730.363481825872;12772.936135319356;10048.196144308438;10244.48777561119;10345.224108191916;10959.890401095967;11149.832752508719;3573.4997100405703;3631.673149416565;3651.087228192952;3747.3254814133447;3754.3617585010616;40175.7991210045;40425.595744042774;40663;40741.796291018654;40749.79625101885;9016.684416045407;9473.66842160521;9524.809503810024;9878.703638890845;10059.04439078301;16713.665726685398;17026.489205323862;17186.31254749821;17187.914060429866;17369.652606948042;6710.664466776641;6805.319468053155;6852.143482064742;6926.896096558556;6973;3904.316744569746;3912.6087391260644;3935;3975.92048159041;4037.2934736421007;3005.353848922492;3014.7889647724887;3031.8332491713168;3034.4689679306034;3045.6192975878016;575.6689903305617;577.2466930655451;578.308920839601;580.3123298890828;589.1545632017982;501.8057024282258;535.7696190638063;560.736453866682;607.6809674920702;699.8705239530703;7755.379569634416;7913.366930645535;7933.206679332021;8008.959955200186;8074.838503229903;568.5366426362501;568.9971301020385;638.9041643753474;654.1283813538839;675.8546912413855;3815.6947444204397;3960.346542820402;4068.6541643960004;4078.9184216315507;4091.734037287567;52876;53233;53512.732436338345;53531.46468535265;53658;46245.7687711566;47022.529774702496;47605.28592071122;47922.76038619784;48385.5161448388;41752.791236043624;41807.58192418098;42384;42944.35583466313;43653.56346436495;8635.222829945335;8889.333300002654;8958.83417185081;8962.372633915824;9095.363324567217;31955.360892781548;32726.836365818017;33298.00105996824;33360.33279334448;33414.83292583522;37431.251374971805;37446.625533744314;38592;42306.942326442084;42336.78831605822;10700.625478108228;10723.410212438392;10747.731306717395;10867.239293249713;11034.393108379116;11819.763604727685;11845.526178952745;12086.75826483483;12568;12800.719928007125;11255.718607034889;11257.211995160587;11420.257683250895;11652.242604230698;11811.586594469152;11024.393658348547;11166.720831979266;11228;11507.712307192387;11683.299002059903;7831.384981176982;10640.148788096778;10764.730881728019;10848.783024339627;11580.36308003068;8961;9033.412828166149;9084.54577271147;9150.313726470675;9381.81236375255;7810.375169986274;9639.277054220822;9685.273604479833;9722.368046076983;9743.21671632266 22:19:41 INFO - PROCESS | 29143 | __end_tp_report 22:19:41 INFO - PROCESS | 29143 | __start_cc_report 22:19:41 INFO - PROCESS | 29143 | _x_x_mozilla_cycle_collect,900 22:19:41 INFO - PROCESS | 29143 | __end_cc_report 22:19:41 INFO - PROCESS | 29143 | __startTimestamp1453616381774__endTimestamp 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | ------- Summary: start ------- 22:19:41 INFO - PROCESS | 29143 | Number of tests: 6 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#0] dojo.html Cycles:165 Average:5133.50 Median:5328.60 stddev:550.72 (10.3%) stddev-sans-first:529.09 22:19:41 INFO - PROCESS | 29143 | Values: 3112.1 3116.1 3170.5 3171.4 3201.0 5011.3 5082.5 5083.7 5112.2 5129.1 5097.8 5106.9 5121.2 5141.4 5141.6 4487.2 4619.7 4663.3 4738.1 4839.7 4637.2 4715.0 4787.6 4790.0 4884.1 4715.4 4785.2 4787.7 4807.5 4830.4 4732.6 4735.5 4739.7 4756.0 4805.8 4610.3 4711.2 4712.5 4749.0 4773.2 4892.7 4963.6 4981.7 4987.7 5024.5 5499.7 5500.2 5501.2 5504.0 5513.1 5416.2 5505.8 5559.3 5599.6 5620.9 5105.7 5173.4 5250.2 5276.9 5292.5 5702.7 5711.1 5714.3 5719.1 5720.5 5490.1 5497.1 5508.8 5515.5 5538.3 5309.1 5439.2 5452.0 5490.2 5556.9 5498.4 5514.2 5520.8 5532.9 5553.3 5506.2 5516.4 5524.7 5533.4 5578.5 4173.2 4248.7 4295.2 4304.9 4372.6 3844.8 3873.6 3883.0 3915.3 3921.4 5107.3 5107.5 5116.5 5120.2 5128.3 5421.9 5443.3 5444.8 5455.8 5517.8 5101.5 5103.9 5105.8 5121.1 5124.4 4736.3 4737.5 4739.0 4741.4 4787.7 5605.7 5678.1 5696.6 5698.1 5744.4 5566.0 5596.3 5604.7 5617.4 5651.4 5670.3 5698.7 5706.6 5709.2 5721.5 5325.5 5388.9 5409.5 5411.2 5428.5 5492.7 5541.1 5551.9 5556.3 5573.9 5378.8 5401.3 5413.6 5430.5 5481.6 5225.7 5318.1 5370.7 5396.2 5484.9 5302.5 5341.1 5344.5 5347.8 5352.1 5412.6 5434.5 5447.2 5468.3 5513.1 5169.2 5249.2 5328.6 5344.8 5406.1 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#1] ext.html Cycles:180 Average:44758.78 Median:36384.14 stddev:73657.36 (202.4%) stddev-sans-first:73789.14 22:19:41 INFO - PROCESS | 29143 | Values: 535.1 560.4 570.9 576.4 576.4 27601.7 38299.2 39256.2 39269.8 39352.4 43369.0 43990.0 43999.8 44008.3 44044.8 8533.8 8775.2 8779.4 8792.5 8803.8 8502.1 8613.6 8615.7 8620.1 8634.0 8617.1 8680.1 8680.8 8687.3 8691.6 8585.2 8615.3 8617.9 8632.1 8641.2 8409.8 8539.3 8545.7 8548.1 8550.4 39229.8 39552.8 39677.8 39774.8 39795.8 2866.0 2980.9 3152.9 3215.7 3269.2 29735.4 29942.0 30209.4 30431.8 31200.5 3962.7 3982.5 4014.9 4031.3 4084.6 261465.0 262451.0 262728.0 263235.0 263817.0 52781.2 58506.0 58859.0 59018.7 59145.4 44777.3 44973.8 45139.0 62162.7 63111.7 13045.3 13124.9 13143.4 13181.4 13207.2 10447.8 10538.4 10543.3 10547.9 10549.1 17655.7 18136.2 18138.5 20950.0 21467.7 7334.5 7483.9 7503.5 7531.3 7657.1 922.7 949.7 962.6 1033.1 1080.3 28732.1 29301.4 29398.3 29467.9 29680.9 979.9 1024.9 1026.6 1106.6 1120.4 13353.4 13355.9 13595.5 13625.2 13976.8 326371.0 329071.0 329729.0 329933.0 330539.0 43969.1 44568.6 52983.7 53244.7 53401.7 1316.2 1332.3 1335.9 1340.8 1352.4 26145.5 27022.0 27369.9 28176.0 28763.1 44789.0 44795.8 44945.0 45118.1 45127.3 244479.0 245232.0 247356.0 248624.0 249862.0 33014.0 33076.8 33080.2 33212.5 33320.0 42637.1 42837.4 43423.3 43799.3 44101.0 36267.0 36340.5 36362.6 36654.6 37595.0 36099.6 36405.6 36845.8 36969.6 37024.0 35025.1 35154.0 35438.3 35716.0 35813.3 29138.4 29654.6 33865.8 35608.1 35740.8 23865.6 24403.9 24408.6 24721.6 24781.4 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#2] jquery.html Cycles:180 Average:25698.52 Median:27007.04 stddev:81246.68 (300.8%) stddev-sans-first:81452.32 22:19:41 INFO - PROCESS | 29143 | Values: 362.3 363.4 369.1 370.2 371.1 13085.7 13128.1 15351.0 16434.5 17653.2 15769.7 16064.3 16546.5 16702.7 16716.7 5159.1 5323.8 5334.3 5340.7 5341.3 3976.0 4116.4 5235.7 5318.2 5586.2 5688.2 5692.4 5749.4 5751.7 5751.7 5006.2 5222.5 5249.1 5257.5 5266.0 4882.1 5043.2 5053.6 5066.1 5068.9 12900.9 13627.6 17606.4 19798.7 19890.5 2137.5 2164.3 2166.3 2270.1 2286.5 8863.5 9299.3 9522.6 9696.8 9876.8 1829.7 1840.9 1881.2 1882.1 1882.6 49132.0 52403.7 52411.5 52531.2 53839.0 10079.3 10148.3 10200.5 10207.7 10280.4 12855.6 13212.3 13222.7 13244.7 13258.9 7086.1 7128.1 7134.9 7168.4 7187.3 6680.0 6695.6 6753.5 6781.9 6801.7 4424.3 4471.4 4480.5 4540.0 4547.7 1712.3 1774.3 1797.8 1857.2 1876.0 861.3 921.7 927.7 929.3 1034.3 14707.8 15277.3 15532.8 15618.8 15651.8 925.0 926.5 935.2 962.3 990.3 8035.6 9411.8 9423.0 9448.1 9527.4 473147.0 484098.0 485010.0 520714.0 524219.0 63156.0 63644.4 67627.9 68053.0 68139.3 1050.6 1086.1 1088.6 1107.7 1153.0 14172.9 14213.2 14841.2 15017.2 15183.0 30156.5 30893.5 31781.5 32549.8 32724.0 38105.8 39458.4 39537.4 39858.0 39979.0 7115.5 7287.9 7316.9 7450.6 7599.7 10507.5 10870.2 10997.1 11060.7 11083.8 9587.7 9607.6 9772.8 9782.1 9785.0 9430.2 9806.1 9865.9 9966.4 10055.7 9688.8 9792.0 9947.4 10098.4 10162.4 7283.7 7286.4 7306.6 7386.4 7426.2 8563.8 9087.6 9902.5 9915.0 10003.7 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#3] mootools.html Cycles:180 Average:5497.86 Median:6327.76 stddev:2852.04 (45.1%) stddev-sans-first:2842.07 22:19:41 INFO - PROCESS | 29143 | Values: 1240.0 1466.3 1480.8 1633.7 1785.5 6735.9 7476.0 7692.1 7701.7 7702.0 7601.6 7760.3 7780.6 7787.0 7793.7 1967.0 2011.1 2011.5 2318.5 2348.9 1997.3 2282.2 2314.9 2321.3 2322.2 2215.7 2217.5 2220.6 2222.0 2316.8 2263.0 2268.1 2290.9 2297.9 2298.5 2258.6 2280.4 2283.1 2291.6 2297.2 7809.5 7876.2 7886.3 7895.0 7898.5 4771.9 4848.8 4852.4 4888.3 4896.2 2968.1 3086.0 3092.7 3139.0 3141.1 1000.9 1014.0 1020.4 1053.5 1063.3 11024.7 11048.4 11052.0 11056.3 11057.0 4388.3 4415.9 4437.6 4439.7 4541.7 9196.0 9196.9 9213.5 9223.2 9228.9 4968.7 4970.2 4971.1 4972.0 4972.7 4432.7 4450.1 4480.2 4492.3 4493.4 3455.0 3760.9 3826.4 3875.4 3878.9 1125.8 1146.5 1232.6 1245.5 1255.7 1023.1 1048.2 1051.5 1130.4 1279.4 7005.3 7144.2 7152.1 7171.4 7186.0 1078.1 1080.7 1100.7 1104.1 1104.7 5698.0 5820.4 5826.1 5830.4 5841.1 9199.3 9366.7 9551.7 9555.0 9567.9 9402.3 9423.8 9508.1 9515.6 9545.7 7313.5 7320.9 7464.4 7480.0 7492.4 7106.8 7196.2 7196.2 7197.4 7198.3 8100.9 8317.8 8552.9 8556.2 8575.3 8509.1 8561.7 8694.9 8736.4 8754.3 6667.4 6895.4 6896.9 6951.6 6963.9 6293.2 7494.6 7545.6 7560.3 7561.7 6362.4 6618.9 6930.4 7148.7 7302.1 6913.8 7020.3 7114.3 7166.7 7185.7 6912.7 6964.9 6976.7 7007.8 7020.3 6384.3 6416.7 6424.6 6434.1 6436.2 6719.4 6799.8 6862.1 6866.6 6874.8 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#4] prototype.html Cycles:180 Average:5267.05 Median:5867.56 stddev:1573.74 (26.8%) stddev-sans-first:1533.74 22:19:41 INFO - PROCESS | 29143 | Values: 320.8 335.5 343.1 347.9 354.2 5829.2 5836.1 5856.7 5901.0 5958.0 5573.9 5683.6 5701.2 5800.0 5878.4 4519.1 4537.4 4585.7 4602.7 4602.8 4346.7 4597.5 4605.8 4609.0 4617.4 4379.0 4413.3 4507.9 4514.8 4518.3 4478.3 4479.7 4488.6 4506.2 4507.6 4015.5 4016.8 4025.8 4035.6 4047.9 5461.1 5559.2 5564.7 5565.3 5566.4 5310.7 5333.0 5336.8 5338.4 5340.2 6224.3 6224.4 6228.5 6238.3 6249.2 4446.6 4486.0 4493.6 4496.6 4512.4 6339.6 6511.7 6515.1 6527.7 6544.6 4522.5 4539.0 4545.4 4556.4 4556.5 4595.4 4608.3 4613.0 4613.2 4615.8 5242.9 5267.3 5275.8 5276.1 5277.7 6126.4 6289.6 6318.1 6327.2 6332.1 1597.6 1624.8 1625.8 1627.2 1628.1 1086.7 1091.5 1093.7 1099.9 1118.6 5934.8 5937.3 5942.3 5944.3 5949.0 6466.4 6469.9 6469.9 6472.8 6478.6 5737.3 5806.7 5831.3 5841.2 5990.9 3479.7 3485.4 3502.9 3504.5 3506.5 6534.5 6800.3 6813.8 6815.3 6818.0 6510.7 6559.7 6658.9 6660.7 6670.6 6751.8 6773.7 6777.2 6781.5 6791.7 6355.7 6489.9 6496.4 6499.0 6504.7 6434.8 6437.5 6443.8 6452.0 6453.2 6787.5 6798.4 6808.2 6861.6 6863.7 4407.3 4535.0 4540.1 4544.3 4545.9 6487.3 6496.6 6508.6 6509.4 6514.0 6274.8 6333.9 6335.4 6347.7 6348.8 6231.3 6275.1 6318.2 6320.8 6331.2 6195.5 6234.0 6273.7 6278.3 6283.5 6349.9 6350.2 6354.9 6360.0 6364.7 6038.7 6192.7 6199.3 6213.6 6231.8 22:19:41 INFO - PROCESS | 29143 | 22:19:41 INFO - PROCESS | 29143 | [#5] yui.html Cycles:180 Average:12864.28 Median:42321.87 stddev:14406.93 (34.0%) stddev-sans-first:14418.79 22:19:41 INFO - PROCESS | 29143 | Values: 786.5 863.9 868.2 870.9 888.6 13139.7 13259.2 13296.4 13322.8 13357.5 10919.0 12253.8 12293.3 12326.7 12342.1 644.4 795.4 813.0 813.1 813.4 801.9 810.4 810.5 813.7 815.7 693.8 707.0 845.0 848.6 849.7 816.3 830.3 830.4 832.0 832.7 614.8 615.0 616.3 616.7 616.9 12195.3 12257.0 12260.2 12261.2 12291.9 11920.2 12326.3 12567.9 12730.4 12772.9 10048.2 10244.5 10345.2 10959.9 11149.8 3573.5 3631.7 3651.1 3747.3 3754.4 40175.8 40425.6 40663.0 40741.8 40749.8 9016.7 9473.7 9524.8 9878.7 10059.0 16713.7 17026.5 17186.3 17187.9 17369.7 6710.7 6805.3 6852.1 6926.9 6973.0 3904.3 3912.6 3935.0 3975.9 4037.3 3005.4 3014.8 3031.8 3034.5 3045.6 575.7 577.2 578.3 580.3 589.2 501.8 535.8 560.7 607.7 699.9 7755.4 7913.4 7933.2 8009.0 8074.8 568.5 569.0 638.9 654.1 675.9 3815.7 3960.3 4068.7 4078.9 4091.7 52876.0 53233.0 53512.7 53531.5 53658.0 46245.8 47022.5 47605.3 47922.8 48385.5 41752.8 41807.6 42384.0 42944.4 43653.6 8635.2 8889.3 8958.8 8962.4 9095.4 31955.4 32726.8 33298.0 33360.3 33414.8 37431.3 37446.6 38592.0 42306.9 42336.8 10700.6 10723.4 10747.7 10867.2 11034.4 11819.8 11845.5 12086.8 12568.0 12800.7 11255.7 11257.2 11420.3 11652.2 11811.6 11024.4 11166.7 11228.0 11507.7 11683.3 7831.4 10640.1 10764.7 10848.8 11580.4 8961.0 9033.4 9084.5 9150.3 9381.8 7810.4 9639.3 9685.3 9722.4 9743.2 22:19:41 INFO - PROCESS | 29143 | -------- Summary: end -------- 22:19:41 INFO - PROCESS | 29143 | 22:19:42 INFO - TEST-INFO | 29143: exit 0 22:19:42 INFO - TEST-OK | dromaeo_css | took 1113216ms 22:19:42 INFO - TEST-START | kraken 22:19:42 INFO - operating with platform_type : linux_ 22:19:42 INFO - Initialising browser for kraken test... 22:19:42 INFO - TEST-INFO | started process 29341 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9BWkM3/profile http://localhost:56278/getInfo.html) 22:19:46 INFO - PROCESS | 29341 | __metrics Screen width/height:1600/1200 22:19:46 INFO - PROCESS | 29341 | colorDepth:24 22:19:46 INFO - PROCESS | 29341 | Browser inner width/height: 1024/697 22:19:46 INFO - PROCESS | 29341 | __metrics 22:19:46 INFO - PROCESS | 29341 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:19:46 INFO - PROCESS | 29341 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:47 INFO - TEST-INFO | 29341: exit 0 22:19:47 INFO - Browser initialized. 22:19:47 INFO - Running cycle 1/1 for kraken test... 22:19:47 INFO - TEST-INFO | started process 29426 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9BWkM3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:59 INFO - PROCESS | 29426 | RSS: Main: 147492864 22:19:59 INFO - PROCESS | 29426 | 22:20:01 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:02 INFO - PROCESS | 29426 | RSS: Main: 186855424 22:20:02 INFO - PROCESS | 29426 | 22:20:05 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-dft) 22:20:05 INFO - PROCESS | 29426 | RSS: Main: 179392512 22:20:05 INFO - PROCESS | 29426 | 22:20:08 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-fft) 22:20:09 INFO - PROCESS | 29426 | RSS: Main: 164401152 22:20:09 INFO - PROCESS | 29426 | 22:20:11 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56278/tests/kraken/driver.html?testName=audio-oscillator) 22:20:11 INFO - PROCESS | 29426 | RSS: Main: 166490112 22:20:11 INFO - PROCESS | 29426 | 22:20:14 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:14 INFO - PROCESS | 29426 | RSS: Main: 166772736 22:20:14 INFO - PROCESS | 29426 | 22:20:17 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:18 INFO - PROCESS | 29426 | RSS: Main: 167157760 22:20:18 INFO - PROCESS | 29426 | 22:20:21 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56278/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:22 INFO - PROCESS | 29426 | RSS: Main: 167518208 22:20:22 INFO - PROCESS | 29426 | 22:20:24 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56278/tests/kraken/driver.html?testName=json-parse-financial) 22:20:25 INFO - PROCESS | 29426 | RSS: Main: 168427520 22:20:25 INFO - PROCESS | 29426 | 22:20:26 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:27 INFO - PROCESS | 29426 | RSS: Main: 176898048 22:20:27 INFO - PROCESS | 29426 | 22:20:29 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:29 INFO - PROCESS | 29426 | RSS: Main: 177942528 22:20:29 INFO - PROCESS | 29426 | 22:20:32 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:32 INFO - PROCESS | 29426 | RSS: Main: 186068992 22:20:32 INFO - PROCESS | 29426 | 22:20:35 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:35 INFO - PROCESS | 29426 | RSS: Main: 195686400 22:20:35 INFO - PROCESS | 29426 | 22:20:38 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:38 INFO - PROCESS | 29426 | RSS: Main: 194244608 22:20:38 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | Cycle 1(1): loaded http://localhost:56278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56278/tests/kraken/driver.html?testName=ai-astar) 22:20:40 INFO - PROCESS | 29426 | RSS: Main: 254554112 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | __start_tp_report 22:20:40 INFO - PROCESS | 29426 | _x_x_mozilla_page_load 22:20:40 INFO - PROCESS | 29426 | _x_x_mozilla_page_load_details 22:20:40 INFO - PROCESS | 29426 | |i|pagename|runs| 22:20:40 INFO - PROCESS | 29426 | |0;ai-astar;109;110;105;111;109;113;111;111;103;110 22:20:40 INFO - PROCESS | 29426 | |1;audio-beat-detection;154;128;150;175;128;146;151;131;170;130 22:20:40 INFO - PROCESS | 29426 | |2;audio-dft;161;162;160;161;161;162;160;159;162;161 22:20:40 INFO - PROCESS | 29426 | |3;audio-fft;74;73;103;96;72;73;73;107;96;74 22:20:40 INFO - PROCESS | 29426 | |4;audio-oscillator;97;97;142;95;95;96;139;96;95;137 22:20:40 INFO - PROCESS | 29426 | |5;imaging-gaussian-blur;108;108;109;109;109;109;109;109;109;109 22:20:40 INFO - PROCESS | 29426 | |6;imaging-darkroom;146;145;146;145;145;145;145;144;145;145 22:20:40 INFO - PROCESS | 29426 | |7;imaging-desaturate;96;96;96;95;95;95;95;96;96;95 22:20:40 INFO - PROCESS | 29426 | |8;json-parse-financial;57;57;56;55;56;55;59;56;60;53 22:20:40 INFO - PROCESS | 29426 | |9;json-stringify-tinderbox;67;68;67;66;66;74;67;67;66;67 22:20:40 INFO - PROCESS | 29426 | |10;stanford-crypto-aes;83;91;83;84;85;83;84;84;86;87 22:20:40 INFO - PROCESS | 29426 | |11;stanford-crypto-ccm;134;119;122;122;123;118;126;117;116;126 22:20:40 INFO - PROCESS | 29426 | |12;stanford-crypto-pbkdf2;147;136;148;137;152;136;153;147;153;146 22:20:40 INFO - PROCESS | 29426 | |13;stanford-crypto-sha256-iterative;67;68;70;67;69;67;67;68;70;66 22:20:40 INFO - PROCESS | 29426 | __end_tp_report 22:20:40 INFO - PROCESS | 29426 | __start_cc_report 22:20:40 INFO - PROCESS | 29426 | _x_x_mozilla_cycle_collect,945 22:20:40 INFO - PROCESS | 29426 | __end_cc_report 22:20:40 INFO - PROCESS | 29426 | __startTimestamp1453616440687__endTimestamp 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | ------- Summary: start ------- 22:20:40 INFO - PROCESS | 29426 | Number of tests: 14 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:3.01 (2.7%) stddev-sans-first:3.19 22:20:40 INFO - PROCESS | 29426 | Values: 109.0 110.0 105.0 111.0 109.0 113.0 111.0 111.0 103.0 110.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:150.50 stddev:17.16 (11.4%) stddev-sans-first:17.97 22:20:40 INFO - PROCESS | 29426 | Values: 154.0 128.0 150.0 175.0 128.0 146.0 151.0 131.0 170.0 130.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 22:20:40 INFO - PROCESS | 29426 | Values: 161.0 162.0 160.0 161.0 161.0 162.0 160.0 159.0 162.0 161.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#3] audio-fft Cycles:10 Average:84.10 Median:73.50 stddev:14.47 (19.7%) stddev-sans-first:14.88 22:20:40 INFO - PROCESS | 29426 | Values: 74.0 73.0 103.0 96.0 72.0 73.0 73.0 107.0 96.0 74.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.50 stddev:21.05 (22.0%) stddev-sans-first:21.88 22:20:40 INFO - PROCESS | 29426 | Values: 97.0 97.0 142.0 95.0 95.0 96.0 139.0 96.0 95.0 137.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:20:40 INFO - PROCESS | 29426 | Values: 108.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 22:20:40 INFO - PROCESS | 29426 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 22:20:40 INFO - PROCESS | 29426 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:2.01 (3.6%) stddev-sans-first:2.12 22:20:40 INFO - PROCESS | 29426 | Values: 57.0 57.0 56.0 55.0 56.0 55.0 59.0 56.0 60.0 53.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:2.37 (3.5%) stddev-sans-first:2.51 22:20:40 INFO - PROCESS | 29426 | Values: 67.0 68.0 67.0 66.0 66.0 74.0 67.0 67.0 66.0 67.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.49 (3.0%) stddev-sans-first:2.54 22:20:40 INFO - PROCESS | 29426 | Values: 83.0 91.0 83.0 84.0 85.0 83.0 84.0 84.0 86.0 87.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:122.50 stddev:5.40 (4.4%) stddev-sans-first:3.71 22:20:40 INFO - PROCESS | 29426 | Values: 134.0 119.0 122.0 122.0 123.0 118.0 126.0 117.0 116.0 126.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:147.50 stddev:6.82 (4.6%) stddev-sans-first:7.21 22:20:40 INFO - PROCESS | 29426 | Values: 147.0 136.0 148.0 137.0 152.0 136.0 153.0 147.0 153.0 146.0 22:20:40 INFO - PROCESS | 29426 | 22:20:40 INFO - PROCESS | 29426 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 22:20:40 INFO - PROCESS | 29426 | Values: 67.0 68.0 70.0 67.0 69.0 67.0 67.0 68.0 70.0 66.0 22:20:40 INFO - PROCESS | 29426 | -------- Summary: end -------- 22:20:40 INFO - PROCESS | 29426 | 22:20:41 INFO - TEST-INFO | 29426: exit 0 22:20:41 INFO - TEST-OK | kraken | took 59045ms 22:20:41 INFO - TEST-START | v8_7 22:20:41 INFO - operating with platform_type : linux_ 22:20:41 INFO - Initialising browser for v8_7 test... 22:20:41 INFO - TEST-INFO | started process 29673 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgqvw9L/profile http://localhost:56278/getInfo.html) 22:20:45 INFO - PROCESS | 29673 | __metrics Screen width/height:1600/1200 22:20:45 INFO - PROCESS | 29673 | colorDepth:24 22:20:45 INFO - PROCESS | 29673 | Browser inner width/height: 1024/697 22:20:45 INFO - PROCESS | 29673 | __metrics 22:20:45 INFO - PROCESS | 29673 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:20:45 INFO - PROCESS | 29673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:20:46 INFO - TEST-INFO | 29673: exit 0 22:20:46 INFO - Browser initialized. 22:20:46 INFO - Running cycle 1/1 for v8_7 test... 22:20:46 INFO - TEST-INFO | started process 29753 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgqvw9L/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:58 INFO - PROCESS | 29753 | RSS: Main: 148791296 22:20:58 INFO - PROCESS | 29753 | 22:21:20 INFO - PROCESS | 29753 | Cycle 1(1): loaded http://localhost:56278/tests/v8_7/run.html (next: http://localhost:56278/tests/v8_7/run.html) 22:21:21 INFO - PROCESS | 29753 | RSS: Main: 537788416 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | __start_tp_report 22:21:21 INFO - PROCESS | 29753 | _x_x_mozilla_page_load 22:21:21 INFO - PROCESS | 29753 | _x_x_mozilla_page_load_details 22:21:21 INFO - PROCESS | 29753 | |i|pagename|runs| 22:21:21 INFO - PROCESS | 29753 | |0;Richards;167.33601070950468 22:21:21 INFO - PROCESS | 29753 | |1;DeltaBlue;191.60758766047135 22:21:21 INFO - PROCESS | 29753 | |2;Encrypt;280.2690582959641 22:21:21 INFO - PROCESS | 29753 | |3;Decrypt;5164.948453608247 22:21:21 INFO - PROCESS | 29753 | |4;RayTrace;1121.0762331838564 22:21:21 INFO - PROCESS | 29753 | |5;Earley;791.7656373713381 22:21:21 INFO - PROCESS | 29753 | |6;Boyer;12481.481481481482 22:21:21 INFO - PROCESS | 29753 | |7;RegExp;43723.40425531915 22:21:21 INFO - PROCESS | 29753 | |8;Splay;566.57223796034 22:21:21 INFO - PROCESS | 29753 | |9;NavierStokes;4822.115384615385 22:21:21 INFO - PROCESS | 29753 | __end_tp_report 22:21:21 INFO - PROCESS | 29753 | __startTimestamp1453616481117__endTimestamp 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | ------- Summary: start ------- 22:21:21 INFO - PROCESS | 29753 | Number of tests: 10 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 167.3 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 191.6 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 280.3 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 5164.9 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#4] RayTrace Cycles:1 Average:1121.08 Median:1121.08 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 1121.1 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 791.8 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 12481.5 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#7] RegExp Cycles:1 Average:43723.40 Median:43723.40 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 43723.4 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#8] Splay Cycles:1 Average:566.57 Median:566.57 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 566.6 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - PROCESS | 29753 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 22:21:21 INFO - PROCESS | 29753 | Values: 4822.1 22:21:21 INFO - PROCESS | 29753 | -------- Summary: end -------- 22:21:21 INFO - PROCESS | 29753 | 22:21:21 INFO - TEST-INFO | 29753: exit 0 22:21:21 INFO - TEST-OK | v8_7 | took 40461ms 22:21:21 INFO - SUITE-END | took 1212s 22:21:22 INFO - Completed test suite (00:20:12) 22:21:22 INFO - Working with test: dromaeo_css 22:21:22 INFO - Generating results file: dromaeo_css 22:21:22 INFO - Working with test: kraken 22:21:22 INFO - Generating results file: kraken 22:21:22 INFO - javascript benchmark 22:21:22 INFO - Working with test: v8_7 22:21:22 INFO - Generating results file: v8_7 22:21:22 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:22 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:21:22 INFO - process_Request line: dromaeo_css 6754.30 graph.html#tests=[[72,1,35]] 22:21:22 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:22 INFO - process_Request line: kraken 1503.40 graph.html#tests=[[232,1,35]] 22:21:22 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:22 INFO - process_Request line: v8_7 20014.44 graph.html#tests=[[230,1,35]] 22:21:22 INFO - RETURN: dromaeo_css: 6754.30 22:21:22 INFO - RETURN: kraken: 1503.40 22:21:22 INFO - RETURN: v8_7: 20014.44 22:21:22 INFO - javascript benchmark 22:21:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3112.050824498528, 3116.0807561769275, 3170.461021626323, 3171.3974344874487, 3201.0396880935714, 5011.32347133137, 5082.4917508249155, 5083.720395378257, 5112.182050871866, 5129.07676618209, 5097.770600322985, 5106.923396149061, 5121.180611102224, 5141.434442211354, 5141.588672906168, 4487.19230538503, 4619.722816631013, 4663.300504924263, 4738.076075165344, 4839.7096174229655, 4637.234856248715, 4715.033418149288, 4787.593054590364, 4790.041991601676, 4884.145274576953, 4715.386999690053, 4785.234362502018, 4787.6648634595595, 4807.519248075199, 4830.372051633265, 4732.645051621143, 4735.502772208937, 4739.73931433771, 4756.0, 4805.807767689324, 4610.331501932201, 4711.175544279771, 4712.458067322234, 4749.0, 4773.236282194832, 4892.706437613754, 4963.6277279204205, 4981.72600506972, 4987.700737955734, 5024.547790698818, 5499.670019798825, 5500.22996780451, 5501.229827824108, 5504.0, 5513.062779327524, 5416.160495123223, 5505.752241149158, 5559.305086864142, 5599.608027438081, 5620.9437905620825, 5105.668131571473, 5173.430922598511, 5250.238715386247, 5276.947230527722, 5292.52367286946, 5702.714864256854, 5711.143328500675, 5714.314282286069, 5719.142128680731, 5720.456556627114, 5490.094134467848, 5497.065498865122, 5508.807191748269, 5515.531179849758, 5538.252335934678, 5309.097453432849, 5439.211314359396, 5452.018636645442, 5490.176473529003, 5556.888862222733, 5498.422665620053, 5514.172874068921, 5520.806771762969, 5532.889342213133, 5553.250311207935, 5506.174073888948, 5516.393196748435, 5524.66851988882, 5533.391326954032, 5578.497935185853, 4173.227952828736, 4248.660107191417, 4295.226859165317, 4304.913901721948, 4372.562743725665, 3844.8462061517225, 3873.573906870242, 3883.0, 3915.256101340793, 3921.431392448136, 5107.33604631403, 5107.540321371094, 5116.513931176532, 5120.206368012964, 5128.333316668809, 5421.891562168735, 5443.34679838414, 5444.8366549003595, 5455.781768729206, 5517.834464966058, 5101.464346243665, 5103.948960510422, 5105.846824595268, 5121.07820592297, 5124.385073791169, 4736.265878788793, 4737.526247375304, 4738.952610473852, 4741.383620129361, 4787.664863459524, 5605.66366018032, 5678.063119585305, 5696.629719068247, 5698.088305871123, 5744.368119506851, 5565.9721701392855, 5596.300462442195, 5604.691741954069, 5617.43825617435, 5651.43485651448, 5670.262865827416, 5698.686572238566, 5706.629069110494, 5709.172170035238, 5721.5136713379825, 5325.4940780625775, 5388.892222155457, 5409.459054094559, 5411.242426060276, 5428.45715428454, 5492.697901615449, 5541.085720856014, 5551.944480555143, 5556.333240011225, 5573.944260557505, 5378.811741589026, 5401.3248343957, 5413.621046526705, 5430.456954304538, 5481.588880834033, 5225.712585807817, 5318.069337865935, 5370.677759334452, 5396.190571414162, 5484.890302193854, 5302.469753024667, 5341.092014357491, 5344.545713614386, 5347.839564813062, 5352.116900711495, 5412.648177868426, 5434.510894019557, 5447.182922561489, 5468.261784659179, 5513.145462453326, 5169.198774190007, 5249.2126181073145, 5328.60035497347, 5344.812931547377, 5406.107992181246], "unit": "score", "name": "dojo.html", "value": 5099.3522441400955}, {"lowerIsBetter": false, "replicates": [535.1464414259256, 560.3751816724352, 570.8601392658798, 576.4091805898953, 576.4293349583913, 27601.723982760166, 38299.23401531968, 39256.21487570247, 39269.8036509817, 39352.40971385428, 43369.0, 43990.0, 43999.78000110003, 44008.3398749019, 44044.77977610107, 8533.786655333619, 8775.210231079202, 8779.385443018991, 8792.47245165289, 8803.823923521526, 8502.06477287501, 8613.61238744258, 8615.741527754177, 8620.137986201393, 8634.0, 8617.095205003447, 8680.08859069795, 8680.826383472358, 8687.305015598737, 8691.60887760049, 8585.18440748128, 8615.267702245317, 8617.870731939025, 8632.050474447806, 8641.179087986662, 8409.789755256106, 8539.316854651614, 8545.74362769118, 8548.102449242864, 8550.40147189697, 39229.80385098085, 39552.80223598892, 39677.80161099176, 39774.801125994476, 39795.801020995, 2865.9856700716573, 2980.8807647694066, 3152.858121384543, 3215.7105860472434, 3269.1663625775277, 29735.405291894258, 29942.0, 30209.395812083854, 30431.847840760875, 31200.531992020136, 3962.7424217425773, 3982.522097348308, 4014.9197016059516, 4031.274728884316, 4084.6323830855367, 261465.0, 262451.0, 262728.0, 263235.0, 263817.0, 52781.2082818758, 58506.0, 58859.0, 59018.70490647519, 59145.40854591485, 44777.32834007493, 44973.77513112414, 45139.0, 62162.68918655378, 63111.684441578414, 13045.282509462071, 13124.868751312555, 13143.408546615425, 13181.406836692371, 13207.207567545978, 10447.791044179074, 10538.367697938149, 10543.31468454548, 10547.947260263649, 10549.103326217204, 17655.73516397255, 18136.183871725803, 18138.546536336697, 20950.0, 21467.67798483024, 7334.486585938933, 7483.8503229935095, 7503.5497870127965, 7531.322181003736, 7657.081150261893, 922.686286662538, 949.6960972488876, 962.552413127899, 1033.132168978047, 1080.254624309224, 28732.13803585896, 29301.41397172087, 29398.26504337366, 29467.85266073656, 29680.851595741882, 979.8677178580942, 1024.8565200871883, 1026.609888242478, 1106.645873320546, 1120.38938778366, 13353.399097040463, 13355.933220333836, 13595.45618175262, 13625.182489050689, 13976.790348144787, 326371.0, 329071.0, 329729.0, 329933.0, 330539.0, 43969.12061758747, 44568.55431445709, 52983.73508132435, 53244.73377633165, 53401.73299133479, 1316.2168509736691, 1332.3271747767315, 1335.8797708206307, 1340.7921772125337, 1352.3576301257021, 26145.477090458466, 27022.0, 27369.863150684916, 28176.039022050085, 28763.137105886857, 44789.0, 44795.77602111969, 44945.0, 45118.0976380464, 45127.32309015302, 244479.0, 245232.0, 247356.0, 248624.0, 249862.0, 33014.0, 33076.83461582677, 33080.172995675304, 33212.50181247235, 33320.0, 42637.14725705531, 42837.357439639054, 43423.34864976965, 43799.34300985424, 44101.0, 36267.0, 36340.45489317715, 36362.63637363593, 36654.63345366619, 37595.0, 36099.63900360963, 36405.63594364128, 36845.81577092098, 36969.63030369662, 37024.0, 35025.12437189091, 35154.0, 35438.29123417569, 35716.0, 35813.28373432464, 29138.417231655672, 29654.555181672724, 33865.83067084649, 35608.10979725424, 35740.82129589335, 23865.64201537013, 24403.877980609985, 24408.6338704916, 24721.62917556274, 24781.380465488506], "unit": "score", "name": "ext.html", "value": 18002.53092742139}, {"lowerIsBetter": false, "replicates": [362.2971435415294, 363.39676137611553, 369.1178084378336, 370.228074464741, 371.1463633642623, 13085.67285817855, 13128.146670466413, 15351.0, 16434.50696479106, 17653.20560574774, 15769.684606307896, 16064.27710753016, 16546.50360489184, 16702.749458758128, 16716.66566668666, 5159.1229490986525, 5323.760430780605, 5334.306540149775, 5340.732963351837, 5341.30563026806, 3975.9801200993957, 4116.382542618616, 5235.712035838027, 5318.175682769177, 5586.162075688639, 5688.175214593902, 5692.373838877741, 5749.367569567345, 5751.712414379264, 5751.712414379285, 5006.1990081586955, 5222.451642577551, 5249.1076516991825, 5257.5005374489365, 5266.025785229725, 4882.072406242803, 5043.167877300241, 5053.570446512051, 5066.113430149709, 5068.898622027539, 12900.870991290061, 13627.591172264847, 17606.38377656776, 19798.72314683801, 19890.502737431536, 2137.540428807814, 2164.285785690718, 2166.3392665237097, 2270.1373478078226, 2286.474110954473, 8863.468191908441, 9299.302552308536, 9522.571484283155, 9696.806063878754, 9876.753081173028, 1829.7072468404992, 1840.9355672551396, 1881.2098918454283, 1882.0777818868655, 1882.5670095878024, 49132.0, 52403.73798131023, 52411.47588524142, 52531.21203181955, 53839.0, 10079.34484258521, 10148.340357876861, 10200.489975501196, 10207.744806379751, 10280.383177009404, 12855.550055748005, 13212.33938303081, 13222.669433264246, 13244.668883277995, 13258.867411325764, 7086.078809754699, 7128.073350464407, 7134.857302853914, 7168.354848063699, 7187.281271872771, 6680.031395447633, 6695.564788288746, 6753.493487988322, 6781.8643627127185, 6801.693923773442, 4424.292113261863, 4471.374007638933, 4480.484744254387, 4539.9773001135445, 4547.658925580595, 1712.315073970397, 1774.299151835018, 1797.81122982085, 1857.1735577668078, 1875.981240187608, 861.2765277167209, 921.6681994481982, 927.6614035876856, 929.3123088914155, 1034.2656713733184, 14707.779383309258, 15277.312520936584, 15532.844671553366, 15618.843811561967, 15651.765223521656, 925.0240995749549, 926.5135803702975, 935.2331088507359, 962.3311798300114, 990.3117333453325, 8035.558044307502, 9411.811763764686, 9423.0, 9448.149666530046, 9527.428354298765, 473147.0, 484098.0, 485010.0, 520714.0, 524219.0, 63156.0, 63644.4088897772, 67627.91348778634, 68053.0, 68139.31860681428, 1050.564015933379, 1086.0551320351344, 1088.5700148441479, 1107.7230692326918, 1152.9827052594385, 14172.858271417153, 14213.218272995084, 14841.183734894685, 15017.174055427056, 15183.013104148195, 30156.547651784804, 30893.53659695151, 31781.523277150398, 32549.837250813594, 32724.0, 38105.79475300958, 39458.40812387874, 39537.406938895365, 39858.0, 39979.0, 7115.53749006313, 7287.8542429152185, 7316.926830731624, 7450.552966822008, 7599.734009309647, 10507.474626268504, 10870.239083264096, 10997.12023038139, 11060.668179954615, 11083.778324433628, 9587.743010184246, 9607.56765945548, 9772.80454390894, 9782.119609235204, 9785.0, 9430.19843313326, 9806.117449429586, 9865.901340986498, 9966.40201587907, 10055.69832905014, 9688.806223875625, 9791.996168219272, 9947.353422027545, 10098.444585547571, 10162.441065741159, 7283.7450689225625, 7286.380657644159, 7306.561606303639, 7386.446016548673, 7426.220246874001, 8563.82872342562, 9087.636494540144, 9902.455364954709, 9914.950425247827, 10003.749906252402], "unit": "score", "name": "jquery.html", "value": 7960.434053742623}, {"lowerIsBetter": false, "replicates": [1239.9752004959907, 1466.3474753734588, 1480.7852861335102, 1633.7222672145733, 1785.4911350265177, 6735.932640673592, 7476.0, 7692.115406728228, 7701.730439434621, 7701.961490192555, 7601.581912994783, 7760.262775036376, 7780.610969451519, 7787.0, 7793.727219547317, 1967.0, 2011.0849563448596, 2011.4669612552684, 2318.53629274145, 2348.941276468085, 1997.320910890297, 2282.1784157703296, 2314.895829687668, 2321.257197696738, 2322.2452702871633, 2215.7008803811523, 2217.5010622609866, 2220.622494175986, 2222.022310183514, 2316.7683231676865, 2263.0382087612697, 2268.0587556164173, 2290.89690963907, 2297.885105744706, 2298.528801595677, 2258.570871534403, 2280.395695140789, 2283.1209984156053, 2291.644795056769, 2297.1615360393334, 7809.492382995087, 7876.17300183484, 7886.250806173404, 7895.0, 7898.486598371088, 4771.904561908743, 4848.806047758086, 4852.393450818648, 4888.291197776302, 4896.2410826321975, 2968.1095671298526, 3086.0, 3092.706192911692, 3139.0, 3141.120486263827, 1000.9399436033862, 1014.0, 1020.3928662445833, 1053.5259133390005, 1063.3354153653966, 11024.724381890517, 11048.447577621168, 11052.005319521202, 11056.336619802758, 11057.0, 4388.341748737651, 4415.911681766347, 4437.600615944581, 4439.711418757771, 4541.704789188692, 9196.034416386317, 9196.908030919605, 9213.539323033821, 9223.216026637676, 9228.907710922938, 4968.677035992649, 4970.155073637418, 4971.130052240844, 4972.030454061495, 4972.701637901738, 4432.689711720149, 4450.109978004347, 4480.193565158238, 4492.348609451611, 4493.393391892053, 3454.9827250863586, 3760.9059773505332, 3826.4069069294305, 3875.399313106473, 3878.8836334909997, 1125.831125331207, 1146.5241924601364, 1232.5932442294022, 1245.4929535262254, 1255.7488502299577, 1023.1047833145997, 1048.156234231451, 1051.458498873081, 1130.361345839598, 1279.353926267229, 7005.299470052954, 7144.214136444987, 7152.070230869954, 7171.426285897116, 7185.964070179615, 1078.1374900079904, 1080.68660088575, 1100.6973082402403, 1104.116706634689, 1104.7127746785734, 5697.971510142423, 5820.3888591698105, 5826.126081087786, 5830.38780928005, 5841.06542953134, 9199.310051746012, 9366.718998430058, 9551.713448596553, 9555.044495550528, 9567.90432095684, 9402.341836071546, 9423.764405889908, 9508.096730810563, 9515.619375225051, 9545.713628591153, 7313.451491138186, 7320.853582928312, 7464.402847772165, 7480.02759641254, 7492.363149132276, 7106.751263705745, 7196.172440169447, 7196.208417074223, 7197.424206063607, 7198.280171982759, 8100.918990810253, 8317.792055198426, 8552.914470855212, 8556.18716221958, 8575.271101956154, 8509.064002959545, 8561.743147705578, 8694.869576956224, 8736.432131911406, 8754.299656027375, 6667.366600172976, 6895.448364130958, 6896.931030689629, 6951.617661028692, 6963.9303606963285, 6293.150424692608, 7494.5503269803985, 7545.584992825447, 7560.319571238615, 7561.697532098655, 6362.363763623601, 6618.90071648916, 6930.3762661360715, 7148.678309475982, 7302.123745150616, 6913.792586222421, 7020.333068358498, 7114.324139206767, 7166.713331466683, 7185.712571497082, 6912.723491060301, 6964.880812602834, 6976.6860491277, 7007.789766307019, 7020.297970202939, 6384.265809431975, 6416.679166041586, 6424.646644434601, 6434.131392261985, 6436.16329877113, 6719.361660642231, 6799.830004249933, 6862.142232220973, 6866.553674011373, 6874.828129296808], "unit": "score", "name": "mootools.html", "value": 4508.899460499654}, {"lowerIsBetter": false, "replicates": [320.78507400041974, 335.4800059907144, 343.0890984436322, 347.9251960828423, 354.2419222863072, 5829.154772557977, 5836.095405212193, 5856.707164641767, 5900.970495147529, 5958.016927207005, 5573.944260557393, 5683.630564013347, 5701.230333904932, 5799.971000145004, 5878.412158784119, 4519.050999290145, 4537.410136682243, 4585.70192937458, 4602.654800889946, 4602.792874320647, 4346.717463364887, 4597.517260687613, 4605.769711514427, 4609.032103258303, 4617.399738034068, 4378.9562104378865, 4413.3159360299205, 4507.918099656092, 4514.841980530682, 4518.277075667894, 4478.261086920655, 4479.7088189267915, 4488.618467430272, 4506.1663592235545, 4507.594316511497, 4015.4779878615886, 4016.7991600420155, 4025.778582177979, 4035.556088830226, 4047.898802529931, 5461.098918678414, 5559.166125081229, 5564.721763911829, 5565.276514053187, 5566.443355664401, 5310.70791106489, 5333.040052790496, 5336.813211537617, 5338.359396872362, 5340.198970154469, 6224.253089629274, 6224.350547105021, 6228.470580000705, 6238.251409830849, 6249.156363890862, 4446.577575130357, 4486.0, 4493.618042466394, 4496.595306422405, 4512.435945506812, 6339.58792678479, 6511.739530418778, 6515.087887695727, 6527.706253218616, 6544.640044797487, 4522.5025247222775, 4538.977305113519, 4545.409096817392, 4556.3621093047, 4556.544345565483, 4595.4025976622825, 4608.262677971508, 4613.0, 4613.2388155953895, 4615.815367385267, 5242.868928276824, 5267.3152490176035, 5275.788968441219, 5276.050310944067, 5277.736113194325, 6126.356732543108, 6289.591176573508, 6318.147050148171, 6327.240731112296, 6332.145160403286, 1597.5766421898206, 1624.7887774589228, 1625.8130315013689, 1627.2270671430977, 1628.1208147600164, 1086.7283179205199, 1091.5033659684825, 1093.6930368209912, 1099.934003959765, 1118.608487029533, 5934.792282270186, 5937.317208520989, 5942.257217847769, 5944.256967879015, 5948.970255148696, 6466.353364663496, 6469.935300646934, 6469.935300647027, 6472.838179045468, 6478.611283323015, 5737.254156959652, 5806.709664516758, 5831.271091113611, 5841.153032810219, 5990.850228744229, 3479.6520347965, 3485.4074807282823, 3502.9124271893406, 3504.5268888700207, 3506.474028895686, 6534.477241820738, 6800.285969973082, 6813.829654258584, 6815.318468153244, 6818.0, 6510.707018184193, 6559.7376104955265, 6658.933410665832, 6660.733570657217, 6670.633115178614, 6751.797446076625, 6773.695183716744, 6777.152855893013, 6781.525293229525, 6791.728330866808, 6355.7457701693265, 6489.902651460137, 6496.382843629847, 6499.0, 6504.739810407531, 6434.839129021625, 6437.517186210959, 6443.7744678936015, 6451.96768517035, 6453.193350831146, 6787.490938179558, 6798.4221341184575, 6808.217055038734, 6861.622610756456, 6863.725450981905, 4407.316865885793, 4534.977325113486, 4540.06928579647, 4544.250198717307, 4545.9090818182785, 6487.286398496256, 6496.577722448026, 6508.576942498722, 6509.446697030806, 6513.967430162819, 6274.811755647338, 6333.8733225336155, 6335.3981371769605, 6347.682615869096, 6348.809535713936, 6231.337032255571, 6275.058741188675, 6318.241810982711, 6320.810375688737, 6331.240251169889, 6195.535334849814, 6234.0337247726675, 6273.65494897785, 6278.309385967631, 6283.497320214463, 6349.904751428639, 6350.206224221973, 6354.904676429765, 6360.045993101072, 6364.713587888648, 6038.698065096815, 6192.659403732658, 6199.256089269316, 6213.627182369072, 6231.813045608639], "unit": "score", "name": "prototype.html", "value": 4760.162522959856}, {"lowerIsBetter": false, "replicates": [786.4848524216638, 863.935204859635, 868.1925808997634, 870.865015922532, 888.591248025908, 13139.73720525589, 13259.204447733142, 13296.401661925212, 13322.800157997637, 13357.53248636298, 10919.0, 12253.816192757116, 12293.26240425575, 12326.691832704188, 12342.136050476447, 644.3846126948777, 795.4352409789057, 813.0446725097986, 813.0527934955799, 813.3574476163853, 801.883726859605, 810.4043528006939, 810.4529442626233, 813.7029984055806, 815.7226542975387, 693.7675878580682, 707.0384277382756, 844.9915500845005, 848.6308455821707, 849.668629234599, 816.2979837339883, 830.2983978538186, 830.3938125168601, 832.009908209229, 832.6877420967137, 614.8217017065045, 614.9975539869984, 616.3128112154915, 616.654673382907, 616.8951278282658, 12195.329256890867, 12257.019438444902, 12260.203086799329, 12261.203021803643, 12291.938540307241, 11920.165588408814, 12326.32205228712, 12567.937160314232, 12730.363481825872, 12772.936135319356, 10048.196144308438, 10244.48777561119, 10345.224108191916, 10959.890401095967, 11149.832752508719, 3573.4997100405703, 3631.673149416565, 3651.087228192952, 3747.3254814133447, 3754.3617585010616, 40175.7991210045, 40425.595744042774, 40663.0, 40741.796291018654, 40749.79625101885, 9016.684416045407, 9473.66842160521, 9524.809503810024, 9878.703638890845, 10059.04439078301, 16713.665726685398, 17026.489205323862, 17186.31254749821, 17187.914060429866, 17369.652606948042, 6710.664466776641, 6805.319468053155, 6852.143482064742, 6926.896096558556, 6973.0, 3904.316744569746, 3912.6087391260644, 3935.0, 3975.92048159041, 4037.2934736421007, 3005.353848922492, 3014.7889647724887, 3031.8332491713168, 3034.4689679306034, 3045.6192975878016, 575.6689903305617, 577.2466930655451, 578.308920839601, 580.3123298890828, 589.1545632017982, 501.8057024282258, 535.7696190638063, 560.736453866682, 607.6809674920702, 699.8705239530703, 7755.379569634416, 7913.366930645535, 7933.206679332021, 8008.959955200186, 8074.838503229903, 568.5366426362501, 568.9971301020385, 638.9041643753474, 654.1283813538839, 675.8546912413855, 3815.6947444204397, 3960.346542820402, 4068.6541643960004, 4078.9184216315507, 4091.734037287567, 52876.0, 53233.0, 53512.732436338345, 53531.46468535265, 53658.0, 46245.7687711566, 47022.529774702496, 47605.28592071122, 47922.76038619784, 48385.5161448388, 41752.791236043624, 41807.58192418098, 42384.0, 42944.35583466313, 43653.56346436495, 8635.222829945335, 8889.333300002654, 8958.83417185081, 8962.372633915824, 9095.363324567217, 31955.360892781548, 32726.836365818017, 33298.00105996824, 33360.33279334448, 33414.83292583522, 37431.251374971805, 37446.625533744314, 38592.0, 42306.942326442084, 42336.78831605822, 10700.625478108228, 10723.410212438392, 10747.731306717395, 10867.239293249713, 11034.393108379116, 11819.763604727685, 11845.526178952745, 12086.75826483483, 12568.0, 12800.719928007125, 11255.718607034889, 11257.211995160587, 11420.257683250895, 11652.242604230698, 11811.586594469152, 11024.393658348547, 11166.720831979266, 11228.0, 11507.712307192387, 11683.299002059903, 7831.384981176982, 10640.148788096778, 10764.730881728019, 10848.783024339627, 11580.36308003068, 8961.0, 9033.412828166149, 9084.54577271147, 9150.313726470675, 9381.81236375255, 7810.375169986274, 9639.277054220822, 9685.273604479833, 9722.368046076983, 9743.21671632266], "unit": "score", "name": "yui.html", "value": 6052.977393225656}], "name": "dromaeo_css", "value": 6754.30513228475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 111.0, 109.0, 113.0, 111.0, 111.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 150.0, 175.0, 128.0, 146.0, 151.0, 131.0, 170.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 160.0, 159.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 103.0, 96.0, 72.0, 73.0, 73.0, 107.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 95.0, 95.0, 96.0, 139.0, 96.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [108.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 55.0, 56.0, 55.0, 59.0, 56.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 66.0, 74.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 83.0, 84.0, 85.0, 83.0, 84.0, 84.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [134.0, 119.0, 122.0, 122.0, 123.0, 118.0, 126.0, 117.0, 116.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 148.0, 137.0, 152.0, 136.0, 153.0, 147.0, 153.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 70.0, 67.0, 69.0, 67.0, 67.0, 68.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1503.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [191.60758766047135], "unit": "score", "name": "DeltaBlue", "value": 345.06984200000005}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1121.0762331838564], "unit": "score", "name": "RayTrace", "value": 660.070188}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [43723.40425531915], "unit": "score", "name": "RegExp", "value": 20.835180048661794}, {"lowerIsBetter": false, "replicates": [566.57223796034], "unit": "score", "name": "Splay", "value": 143.83161500000003}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20014.441512599355}]} 22:21:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "20014.44"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1503.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6754.30"}}} 22:21:22 INFO - Return code: 0 22:21:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:21:22 INFO - # TBPL SUCCESS # 22:21:22 INFO - Running post-action listener: _resource_record_post_action 22:21:22 INFO - Running post-run listener: _resource_record_post_run 22:21:23 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 538169344; Read time: 0; Write time: 387772 22:21:23 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236220416; Read time: 0; Write time: 195816 22:21:23 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 301948928; Read time: 0; Write time: 191956 22:21:23 INFO - Running post-run listener: _upload_blobber_files 22:21:23 INFO - Blob upload gear active. 22:21:23 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:21:23 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:21:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:21:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:21:24 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:21:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:21:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:25 INFO - (blobuploader) - INFO - Done attempting. 22:21:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:21:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:21:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:26 INFO - (blobuploader) - INFO - Done attempting. 22:21:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:26 INFO - Return code: 0 22:21:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:21:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b9e6cc436eb139ade73259729285f2c3689282c49c7505bd4003199ff6348122f9ba1269144e281c43907e68cb1cb16122632a9a91381d5f8af2a54c4587bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36c52faa37496eabc18af3e6baf656b658a4f80ad728c0701d86f88efd7fc01adb07ee8a6fba730686d8f7f49e3613545fe6bc98bde7b574788e539bde9d3ce9"} 22:21:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:21:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:21:26 INFO - Contents: 22:21:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b9e6cc436eb139ade73259729285f2c3689282c49c7505bd4003199ff6348122f9ba1269144e281c43907e68cb1cb16122632a9a91381d5f8af2a54c4587bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36c52faa37496eabc18af3e6baf656b658a4f80ad728c0701d86f88efd7fc01adb07ee8a6fba730686d8f7f49e3613545fe6bc98bde7b574788e539bde9d3ce9"} 22:21:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:26 INFO - Copying logs to upload dir... 22:21:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:21:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.405777 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-23 22:21:25.996239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:25.999759) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b9e6cc436eb139ade73259729285f2c3689282c49c7505bd4003199ff6348122f9ba1269144e281c43907e68cb1cb16122632a9a91381d5f8af2a54c4587bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36c52faa37496eabc18af3e6baf656b658a4f80ad728c0701d86f88efd7fc01adb07ee8a6fba730686d8f7f49e3613545fe6bc98bde7b574788e539bde9d3ce9"} build_url:https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011475 build_url: 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c4b9e6cc436eb139ade73259729285f2c3689282c49c7505bd4003199ff6348122f9ba1269144e281c43907e68cb1cb16122632a9a91381d5f8af2a54c4587bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36c52faa37496eabc18af3e6baf656b658a4f80ad728c0701d86f88efd7fc01adb07ee8a6fba730686d8f7f49e3613545fe6bc98bde7b574788e539bde9d3ce9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:26.028895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:26.029692) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453615147.531972-1040815307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:26.115703) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 22:21:26.116507) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 22:21:26.117047) ========= ========= Total master_lag: 0.31 =========