builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1456161397.51 results: success (0) buildid: 20160222063456 builduid: e640b582242a4daa93246b32bddc22f2 revision: 19f7989b29da7a6f37e21b02ac6b3da7aefda10c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:37.512782) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:37.513283) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-02-22 09:16:37.513566) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003455 basedir: '/builds/slave/test-pgo' ========= master_lag: 8.46 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-02-22 09:16:45.979110) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:45.979465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.066321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.066626) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004224 ========= master_lag: 0.34 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.405874) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.406145) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.406457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.406720) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 09:16:46-- 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% 222M=0s 2016-02-22 09:16:46 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100246 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.550331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.550597) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019802 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:46.621785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-02-22 09:16:46.622154) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 19f7989b29da7a6f37e21b02ac6b3da7aefda10c --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 19f7989b29da7a6f37e21b02ac6b3da7aefda10c --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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 09:16:46,923 truncating revision to first 12 chars 2016-02-22 09:16:46,923 Setting DEBUG logging. 2016-02-22 09:16:46,923 attempt 1/10 2016-02-22 09:16:46,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/19f7989b29da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 09:16:47,496 unpacking tar archive at: mozilla-aurora-19f7989b29da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910418 ========= master_lag: 9.97 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2016-02-22 09:16:57.503138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:57.503479) ========= echo 19f7989b29da7a6f37e21b02ac6b3da7aefda10c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'19f7989b29da7a6f37e21b02ac6b3da7aefda10c'] 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19f7989b29da7a6f37e21b02ac6b3da7aefda10c program finished with exit code 0 elapsedTime=0.004770 script_repo_revision: '19f7989b29da7a6f37e21b02ac6b3da7aefda10c' ========= master_lag: 0.16 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:57.672045) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:57.672405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 09:16:57.688042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-22 09:16:57.688311) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:58 INFO - MultiFileLogger online at 20160222 09:16:58 in /builds/slave/test-pgo 09:16:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:16:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:16:58 INFO - {'append_to_log': False, 09:16:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:16:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:16:58 INFO - 'branch': 'Mozilla-Aurora', 09:16:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:58 INFO - 'config_files': ('talos/linux_config.py',), 09:16:58 INFO - 'default_actions': ('clobber', 09:16:58 INFO - 'read-buildbot-config', 09:16:58 INFO - 'download-and-extract', 09:16:58 INFO - 'populate-webroot', 09:16:58 INFO - 'create-virtualenv', 09:16:58 INFO - 'install', 09:16:58 INFO - 'run-tests'), 09:16:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:58 INFO - 'download_minidump_stackwalk': True, 09:16:58 INFO - 'download_symbols': 'ondemand', 09:16:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:58 INFO - 'installer_path': 'installer.exe', 09:16:58 INFO - 'log_level': 'info', 09:16:58 INFO - 'log_name': 'talos', 09:16:58 INFO - 'log_to_console': True, 09:16:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:58 INFO - 'opt_config_files': (), 09:16:58 INFO - 'pip_index': False, 09:16:58 INFO - 'sps_profile': False, 09:16:58 INFO - 'sps_profile_interval': 0, 09:16:58 INFO - 'suite': 'dromaeojs-e10s', 09:16:58 INFO - 'system_bits': '32', 09:16:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:58 INFO - 'title': 'talos-linux64-ix-055', 09:16:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:58 INFO - 'use_talos_json': True, 09:16:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:16:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:58 INFO - 'work_dir': 'build'} 09:16:58 INFO - ##### 09:16:58 INFO - ##### Running clobber step. 09:16:58 INFO - ##### 09:16:58 INFO - Running pre-action listener: _resource_record_pre_action 09:16:58 INFO - Running main action method: clobber 09:16:58 INFO - rmtree: /builds/slave/test-pgo/build 09:16:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:16:59 INFO - Running post-action listener: _resource_record_post_action 09:16:59 INFO - ##### 09:16:59 INFO - ##### Running read-buildbot-config step. 09:16:59 INFO - ##### 09:16:59 INFO - Running pre-action listener: _resource_record_pre_action 09:16:59 INFO - Running main action method: read_buildbot_config 09:16:59 INFO - Using buildbot properties: 09:16:59 INFO - { 09:16:59 INFO - "project": "", 09:16:59 INFO - "product": "firefox", 09:16:59 INFO - "script_repo_revision": "production", 09:16:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:16:59 INFO - "repository": "", 09:16:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:16:59 INFO - "buildid": "20160222063456", 09:16:59 INFO - "pgo_build": "True", 09:16:59 INFO - "basedir": "/builds/slave/test-pgo", 09:16:59 INFO - "buildnumber": 157, 09:16:59 INFO - "slavename": "talos-linux64-ix-055", 09:16:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:59 INFO - "platform": "ubuntu64_hw", 09:16:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:16:59 INFO - "branch": "mozilla-aurora", 09:16:59 INFO - "repo_path": "releases/mozilla-aurora", 09:16:59 INFO - "revision": "19f7989b29da7a6f37e21b02ac6b3da7aefda10c", 09:16:59 INFO - "stage_platform": "linux64-pgo", 09:16:59 INFO - "builduid": "e640b582242a4daa93246b32bddc22f2", 09:16:59 INFO - "slavebuilddir": "test" 09:16:59 INFO - } 09:16:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 09:16:59 INFO - Running post-action listener: _resource_record_post_action 09:16:59 INFO - ##### 09:16:59 INFO - ##### Running download-and-extract step. 09:16:59 INFO - ##### 09:16:59 INFO - Running pre-action listener: _resource_record_pre_action 09:16:59 INFO - Running main action method: download_and_extract 09:16:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:16:59 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')]} 09:16:59 INFO - https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/test_packages.json 09:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/test_packages.json 09:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:17:00 INFO - Downloaded 1448 bytes. 09:17:00 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:17:00 INFO - Using the following test package requirements: 09:17:00 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:00 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:17:00 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:17:00 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'jsshell-linux-x86_64.zip'], 09:17:00 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:17:00 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:00 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:17:00 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:17:00 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:17:00 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 09:17:00 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 09:17:00 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:17:00 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:17:00 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')]} 09:17:00 INFO - https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:01 INFO - Downloaded 23079152 bytes. 09:17:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:17:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:17:02 INFO - Return code: 0 09:17:02 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:17:02 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')]} 09:17:02 INFO - https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 09:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:17:03 INFO - Downloaded 23079152 bytes. 09:17:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 09:17:04 INFO - Return code: 0 09:17:04 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')]} 09:17:04 INFO - https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 09:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:17:05 INFO - Downloaded 10706572 bytes. 09:17:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 09:17:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 09:17:06 INFO - Return code: 0 09:17:06 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')]} 09:17:06 INFO - https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:17:07 INFO - Downloaded 59965518 bytes. 09:17:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:07 INFO - mkdir: /builds/slave/test-pgo/properties 09:17:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:17:07 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:17:07 INFO - Contents: 09:17:07 INFO - build_url:https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 09:17:08 INFO - Running post-action listener: _resource_record_post_action 09:17:08 INFO - Running post-action listener: set_extra_try_arguments 09:17:08 INFO - ##### 09:17:08 INFO - ##### Running populate-webroot step. 09:17:08 INFO - ##### 09:17:08 INFO - Running pre-action listener: _resource_record_pre_action 09:17:08 INFO - Running main action method: populate_webroot 09:17:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:08 INFO - '--tppagecycles', 09:17:08 INFO - '7'], 09:17:08 INFO - 'tests': ['tsvgm']}}, 09:17:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:17:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:17:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'tests': ['damp', 'tps']}, 09:17:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['damp', 'tps']}, 09:17:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:17:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:08 INFO - 'other': {'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'other_l64': {'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'other_nol64': {'tests': ['a11yr', 09:17:08 INFO - 'ts_paint', 09:17:08 INFO - 'tpaint', 09:17:08 INFO - 'sessionrestore', 09:17:08 INFO - 'sessionrestore_no_auto_restore']}, 09:17:08 INFO - 'svgr': {'tests': ['tsvgx', 09:17:08 INFO - 'tsvgr_opacity', 09:17:08 INFO - 'tart', 09:17:08 INFO - 'tscrollx', 09:17:08 INFO - 'cart']}, 09:17:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['tsvgx', 09:17:08 INFO - 'tsvgr_opacity', 09:17:08 INFO - 'tart', 09:17:08 INFO - 'tscrollx', 09:17:08 INFO - 'cart']}, 09:17:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'tests': ['tp5o']}, 09:17:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'talos_options': ['--e10s'], 09:17:08 INFO - 'tests': ['tp5o']}, 09:17:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'talos_options': ['--xperf_path', 09:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:08 INFO - 'tests': ['tp5n']}, 09:17:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:08 INFO - 'talos_options': ['--e10s', 09:17:08 INFO - '--xperf_path', 09:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:08 INFO - 'tests': ['tp5n']}}, 09:17:08 INFO - 'talos.zip': {'path': '', 09:17:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:08 INFO - Running post-action listener: _resource_record_post_action 09:17:08 INFO - ##### 09:17:08 INFO - ##### Running create-virtualenv step. 09:17:08 INFO - ##### 09:17:08 INFO - Running pre-action listener: _resource_record_pre_action 09:17:08 INFO - Running main action method: create_virtualenv 09:17:08 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:17:08 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 09:17:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:17:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:08 INFO - Using real prefix '/usr' 09:17:08 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:10 INFO - Installing pip.................done. 09:17:10 INFO - Return code: 0 09:17:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:17:10 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')]} 09:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:10 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')]} 09:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:10 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:10 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 09:17:10 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 09:17:10 INFO - Using env: {'DISPLAY': ':0', 09:17:10 INFO - 'HOME': '/home/cltbld', 09:17:10 INFO - 'LANG': 'en_US.UTF-8', 09:17:10 INFO - 'LANGUAGE': 'en_US:en', 09:17:10 INFO - 'LOGNAME': 'cltbld', 09:17:10 INFO - 'MAIL': '/var/mail/cltbld', 09:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:10 INFO - 'MOZ_NO_REMOTE': '1', 09:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:10 INFO - 'NO_EM_RESTART': '1', 09:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:10 INFO - 'SHELL': '/bin/bash', 09:17:10 INFO - 'SHLVL': '1', 09:17:10 INFO - 'TERM': 'linux', 09:17:10 INFO - 'TMOUT': '86400', 09:17:10 INFO - 'USER': 'cltbld', 09:17:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:10 INFO - '_': '/tools/buildbot/bin/python'} 09:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:10 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 09:17:10 INFO - Cleaning up... 09:17:10 INFO - Return code: 0 09:17:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:17:10 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')]} 09:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:10 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')]} 09:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:10 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:10 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 09:17:10 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 09:17:10 INFO - Using env: {'DISPLAY': ':0', 09:17:10 INFO - 'HOME': '/home/cltbld', 09:17:10 INFO - 'LANG': 'en_US.UTF-8', 09:17:10 INFO - 'LANGUAGE': 'en_US:en', 09:17:10 INFO - 'LOGNAME': 'cltbld', 09:17:10 INFO - 'MAIL': '/var/mail/cltbld', 09:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:10 INFO - 'MOZ_NO_REMOTE': '1', 09:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:10 INFO - 'NO_EM_RESTART': '1', 09:17:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:10 INFO - 'SHELL': '/bin/bash', 09:17:10 INFO - 'SHLVL': '1', 09:17:10 INFO - 'TERM': 'linux', 09:17:10 INFO - 'TMOUT': '86400', 09:17:10 INFO - 'USER': 'cltbld', 09:17:10 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:10 INFO - '_': '/tools/buildbot/bin/python'} 09:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:11 INFO - Downloading/unpacking psutil>=0.7.1 09:17:11 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 09:17:11 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 09:17:11 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 09:17:11 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 09:17:11 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 09:17:11 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 09:17:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:12 INFO - Installing collected packages: psutil 09:17:12 INFO - Running setup.py install for psutil 09:17:13 INFO - building 'psutil._psutil_linux' extension 09:17:13 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 09:17:13 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 09:17:13 INFO - building 'psutil._psutil_posix' extension 09:17:13 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 09:17:13 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 09:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:13 INFO - Successfully installed psutil 09:17:13 INFO - Cleaning up... 09:17:13 INFO - Return code: 0 09:17:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:17:13 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')]} 09:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:13 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')]} 09:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:13 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:13 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 09:17:13 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 09:17:13 INFO - Using env: {'DISPLAY': ':0', 09:17:13 INFO - 'HOME': '/home/cltbld', 09:17:13 INFO - 'LANG': 'en_US.UTF-8', 09:17:13 INFO - 'LANGUAGE': 'en_US:en', 09:17:13 INFO - 'LOGNAME': 'cltbld', 09:17:13 INFO - 'MAIL': '/var/mail/cltbld', 09:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:13 INFO - 'MOZ_NO_REMOTE': '1', 09:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:13 INFO - 'NO_EM_RESTART': '1', 09:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:13 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:13 INFO - 'SHELL': '/bin/bash', 09:17:13 INFO - 'SHLVL': '1', 09:17:13 INFO - 'TERM': 'linux', 09:17:13 INFO - 'TMOUT': '86400', 09:17:13 INFO - 'USER': 'cltbld', 09:17:13 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:13 INFO - '_': '/tools/buildbot/bin/python'} 09:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:17:15 INFO - Installing collected packages: mozsystemmonitor 09:17:15 INFO - Running setup.py install for mozsystemmonitor 09:17:15 INFO - Successfully installed mozsystemmonitor 09:17:15 INFO - Cleaning up... 09:17:15 INFO - Return code: 0 09:17:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:17:15 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')]} 09:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 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')]} 09:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:15 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:15 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 09:17:15 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 09:17:15 INFO - Using env: {'DISPLAY': ':0', 09:17:15 INFO - 'HOME': '/home/cltbld', 09:17:15 INFO - 'LANG': 'en_US.UTF-8', 09:17:15 INFO - 'LANGUAGE': 'en_US:en', 09:17:15 INFO - 'LOGNAME': 'cltbld', 09:17:15 INFO - 'MAIL': '/var/mail/cltbld', 09:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:15 INFO - 'MOZ_NO_REMOTE': '1', 09:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:15 INFO - 'NO_EM_RESTART': '1', 09:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:15 INFO - 'SHELL': '/bin/bash', 09:17:15 INFO - 'SHLVL': '1', 09:17:15 INFO - 'TERM': 'linux', 09:17:15 INFO - 'TMOUT': '86400', 09:17:15 INFO - 'USER': 'cltbld', 09:17:15 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:15 INFO - '_': '/tools/buildbot/bin/python'} 09:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:15 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 09:17:15 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 09:17:15 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 09:17:15 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 09:17:15 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 09:17:15 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 09:17:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:17 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 09:17:17 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 09:17:17 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 09:17:17 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 09:17:17 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 09:17:17 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 09:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:17:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 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 09:17:18 INFO - Downloading docopt-0.6.1.tar.gz 09:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:18 INFO - Running setup.py install for blobuploader 09:17:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:18 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:17:18 INFO - Running setup.py install for requests 09:17:18 INFO - Running setup.py install for docopt 09:17:19 INFO - Successfully installed blobuploader requests docopt 09:17:19 INFO - Cleaning up... 09:17:19 INFO - Return code: 0 09:17:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17:19 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')]} 09:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:19 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')]} 09:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:19 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:19 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 09:17:19 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 09:17:19 INFO - Using env: {'DISPLAY': ':0', 09:17:19 INFO - 'HOME': '/home/cltbld', 09:17:19 INFO - 'LANG': 'en_US.UTF-8', 09:17:19 INFO - 'LANGUAGE': 'en_US:en', 09:17:19 INFO - 'LOGNAME': 'cltbld', 09:17:19 INFO - 'MAIL': '/var/mail/cltbld', 09:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:19 INFO - 'MOZ_NO_REMOTE': '1', 09:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:19 INFO - 'NO_EM_RESTART': '1', 09:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:19 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:19 INFO - 'SHELL': '/bin/bash', 09:17:19 INFO - 'SHLVL': '1', 09:17:19 INFO - 'TERM': 'linux', 09:17:19 INFO - 'TMOUT': '86400', 09:17:19 INFO - 'USER': 'cltbld', 09:17:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:19 INFO - '_': '/tools/buildbot/bin/python'} 09:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:19 INFO - Running setup.py (path:/tmp/pip-XZ34HN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:19 INFO - Running setup.py (path:/tmp/pip-WE81XW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:19 INFO - Running setup.py (path:/tmp/pip-O6wFqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:19 INFO - Running setup.py (path:/tmp/pip-sD8a34-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:19 INFO - Running setup.py (path:/tmp/pip-CKHHgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:19 INFO - Running setup.py (path:/tmp/pip-OK324s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:19 INFO - Running setup.py (path:/tmp/pip-I8Ylk9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:19 INFO - Running setup.py (path:/tmp/pip-gfOZtS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:19 INFO - Running setup.py (path:/tmp/pip-TZB1a_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:19 INFO - Running setup.py (path:/tmp/pip-wl36SY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:20 INFO - Running setup.py (path:/tmp/pip-RWOSwc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:20 INFO - Running setup.py (path:/tmp/pip-XygXoP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:20 INFO - Running setup.py (path:/tmp/pip-6NmafN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:20 INFO - Running setup.py (path:/tmp/pip-L49vtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:20 INFO - Running setup.py (path:/tmp/pip-rll_FY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:20 INFO - Running setup.py (path:/tmp/pip-wzVrJD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:20 INFO - Running setup.py (path:/tmp/pip-M5PQrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:20 INFO - Running setup.py install for manifestparser 09:17:20 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:17:20 INFO - Running setup.py install for mozcrash 09:17:20 INFO - Running setup.py install for mozdebug 09:17:20 INFO - Running setup.py install for mozdevice 09:17:20 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:17:20 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:17:20 INFO - Running setup.py install for mozfile 09:17:21 INFO - Running setup.py install for mozhttpd 09:17:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozinfo 09:17:21 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozInstall 09:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozleak 09:17:21 INFO - Running setup.py install for mozlog 09:17:21 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for moznetwork 09:17:21 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozprocess 09:17:21 INFO - Running setup.py install for mozprofile 09:17:21 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozrunner 09:17:21 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:17:21 INFO - Running setup.py install for mozscreenshot 09:17:22 INFO - Running setup.py install for moztest 09:17:22 INFO - Running setup.py install for mozversion 09:17:22 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:22 INFO - Cleaning up... 09:17:22 INFO - Return code: 0 09:17:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17: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')]} 09:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:22 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:22 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 09:17:22 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 09:17:22 INFO - Using env: {'DISPLAY': ':0', 09:17:22 INFO - 'HOME': '/home/cltbld', 09:17:22 INFO - 'LANG': 'en_US.UTF-8', 09:17:22 INFO - 'LANGUAGE': 'en_US:en', 09:17:22 INFO - 'LOGNAME': 'cltbld', 09:17:22 INFO - 'MAIL': '/var/mail/cltbld', 09:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:22 INFO - 'MOZ_NO_REMOTE': '1', 09:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:22 INFO - 'NO_EM_RESTART': '1', 09:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:22 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:22 INFO - 'SHELL': '/bin/bash', 09:17:22 INFO - 'SHLVL': '1', 09:17:22 INFO - 'TERM': 'linux', 09:17:22 INFO - 'TMOUT': '86400', 09:17:22 INFO - 'USER': 'cltbld', 09:17:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:22 INFO - '_': '/tools/buildbot/bin/python'} 09:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:22 INFO - Running setup.py (path:/tmp/pip-9W1tBb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:22 INFO - Running setup.py (path:/tmp/pip-44A9I1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:22 INFO - Running setup.py (path:/tmp/pip-bzQaYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:22 INFO - Running setup.py (path:/tmp/pip-GOXVWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:22 INFO - Running setup.py (path:/tmp/pip-kGVxmz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:22 INFO - Running setup.py (path:/tmp/pip-c9Aesu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:22 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)) 09:17:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:22 INFO - Running setup.py (path:/tmp/pip-TZxFzC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:23 INFO - Running setup.py (path:/tmp/pip-02D9jP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:23 INFO - Running setup.py (path:/tmp/pip-kayq8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:23 INFO - Running setup.py (path:/tmp/pip-ST_d7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:23 INFO - Running setup.py (path:/tmp/pip-_webmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:23 INFO - Running setup.py (path:/tmp/pip-txHkSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:23 INFO - Running setup.py (path:/tmp/pip-lwCtPn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:23 INFO - Running setup.py (path:/tmp/pip-72Kytm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:23 INFO - Running setup.py (path:/tmp/pip-84W9lq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:23 INFO - Running setup.py (path:/tmp/pip-EHKAjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:23 INFO - Running setup.py (path:/tmp/pip-R9qhsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:23 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)) 09:17:23 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)) 09:17:23 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)) 09:17:23 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)) 09:17:23 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)) 09:17:23 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)) 09:17:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:25 INFO - Downloading blessings-1.6.tar.gz 09:17:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:25 INFO - Installing collected packages: blessings 09:17:25 INFO - Running setup.py install for blessings 09:17:25 INFO - Successfully installed blessings 09:17:25 INFO - Cleaning up... 09:17:25 INFO - Return code: 0 09:17:25 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:17:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:26 INFO - Reading from file tmpfile_stdout 09:17:26 INFO - Current package versions: 09:17:26 INFO - argparse == 1.2.1 09:17:26 INFO - blessings == 1.6 09:17:26 INFO - blobuploader == 1.2.4 09:17:26 INFO - docopt == 0.6.1 09:17:26 INFO - manifestparser == 1.1 09:17:26 INFO - mozInstall == 1.12 09:17:26 INFO - mozcrash == 0.16 09:17:26 INFO - mozdebug == 0.1 09:17:26 INFO - mozdevice == 0.48 09:17:26 INFO - mozfile == 1.2 09:17:26 INFO - mozhttpd == 0.7 09:17:26 INFO - mozinfo == 0.9 09:17:26 INFO - mozleak == 0.1 09:17:26 INFO - mozlog == 3.1 09:17:26 INFO - moznetwork == 0.27 09:17:26 INFO - mozprocess == 0.22 09:17:26 INFO - mozprofile == 0.28 09:17:26 INFO - mozrunner == 6.11 09:17:26 INFO - mozscreenshot == 0.1 09:17:26 INFO - mozsystemmonitor == 0.0 09:17:26 INFO - moztest == 0.7 09:17:26 INFO - mozversion == 1.4 09:17:26 INFO - psutil == 3.1.1 09:17:26 INFO - requests == 1.2.3 09:17:26 INFO - wsgiref == 0.1.2 09:17:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17: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')]} 09:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:26 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:26 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 09:17:26 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 09:17:26 INFO - Using env: {'DISPLAY': ':0', 09:17:26 INFO - 'HOME': '/home/cltbld', 09:17:26 INFO - 'LANG': 'en_US.UTF-8', 09:17:26 INFO - 'LANGUAGE': 'en_US:en', 09:17:26 INFO - 'LOGNAME': 'cltbld', 09:17:26 INFO - 'MAIL': '/var/mail/cltbld', 09:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:26 INFO - 'MOZ_NO_REMOTE': '1', 09:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:26 INFO - 'NO_EM_RESTART': '1', 09:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:26 INFO - 'SHELL': '/bin/bash', 09:17:26 INFO - 'SHLVL': '1', 09:17:26 INFO - 'TERM': 'linux', 09:17:26 INFO - 'TMOUT': '86400', 09:17:26 INFO - 'USER': 'cltbld', 09:17:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:26 INFO - '_': '/tools/buildbot/bin/python'} 09:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 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)) 09:17:26 INFO - Cleaning up... 09:17:26 INFO - Return code: 0 09:17:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:17: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')]} 09:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17: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')]} 09:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:26 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:26 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 09:17:26 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 09:17:26 INFO - Using env: {'DISPLAY': ':0', 09:17:26 INFO - 'HOME': '/home/cltbld', 09:17:26 INFO - 'LANG': 'en_US.UTF-8', 09:17:26 INFO - 'LANGUAGE': 'en_US:en', 09:17:26 INFO - 'LOGNAME': 'cltbld', 09:17:26 INFO - 'MAIL': '/var/mail/cltbld', 09:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:26 INFO - 'MOZ_NO_REMOTE': '1', 09:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:26 INFO - 'NO_EM_RESTART': '1', 09:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:26 INFO - 'SHELL': '/bin/bash', 09:17:26 INFO - 'SHLVL': '1', 09:17:26 INFO - 'TERM': 'linux', 09:17:26 INFO - 'TMOUT': '86400', 09:17:26 INFO - 'USER': 'cltbld', 09:17:26 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:26 INFO - '_': '/tools/buildbot/bin/python'} 09:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:26 INFO - Downloading/unpacking jsonschema 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:28 INFO - Downloading/unpacking functools32 (from jsonschema) 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:28 INFO - warning: no files found matching '*.txt' 09:17:28 INFO - no previously-included directories found matching 'build' 09:17:28 INFO - no previously-included directories found matching 'dist' 09:17:28 INFO - no previously-included directories found matching '.git*' 09:17:28 INFO - Installing collected packages: jsonschema, functools32 09:17:28 INFO - Running setup.py install for functools32 09:17:28 INFO - warning: no files found matching '*.txt' 09:17:28 INFO - no previously-included directories found matching 'build' 09:17:28 INFO - no previously-included directories found matching 'dist' 09:17:28 INFO - no previously-included directories found matching '.git*' 09:17:28 INFO - Successfully installed jsonschema functools32 09:17:28 INFO - Cleaning up... 09:17:28 INFO - Return code: 0 09:17:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:17:28 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')]} 09:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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')]} 09:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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 0x7f3f9c5e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c9480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, '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': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', '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 09:17:28 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 09:17:28 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 09:17:28 INFO - Using env: {'DISPLAY': ':0', 09:17:28 INFO - 'HOME': '/home/cltbld', 09:17:28 INFO - 'LANG': 'en_US.UTF-8', 09:17:28 INFO - 'LANGUAGE': 'en_US:en', 09:17:28 INFO - 'LOGNAME': 'cltbld', 09:17:28 INFO - 'MAIL': '/var/mail/cltbld', 09:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:28 INFO - 'MOZ_NO_REMOTE': '1', 09:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:28 INFO - 'NO_EM_RESTART': '1', 09:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:28 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:28 INFO - 'SHELL': '/bin/bash', 09:17:28 INFO - 'SHLVL': '1', 09:17:28 INFO - 'TERM': 'linux', 09:17:28 INFO - 'TMOUT': '86400', 09:17:28 INFO - 'USER': 'cltbld', 09:17:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:28 INFO - '_': '/tools/buildbot/bin/python'} 09:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:28 INFO - Downloading/unpacking flake8 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:28 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 09:17:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:17:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:17:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 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 09:17:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:17:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:31 INFO - no previously-included directories found matching 'docs/_build' 09:17:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:17:31 INFO - Running setup.py install for pep8 09:17:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:31 INFO - no previously-included directories found matching 'docs/_build' 09:17:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:17:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:17:31 INFO - Cleaning up... 09:17:31 INFO - Return code: 0 09:17:31 INFO - Running post-action listener: _resource_record_post_action 09:17:31 INFO - Running post-action listener: _start_resource_monitoring 09:17:31 INFO - Starting resource monitoring. 09:17:31 INFO - ##### 09:17:31 INFO - ##### Running install step. 09:17:31 INFO - ##### 09:17:31 INFO - Running pre-action listener: _resource_record_pre_action 09:17:31 INFO - Running main action method: install 09:17:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:31 INFO - Reading from file tmpfile_stdout 09:17:31 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:17:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:17:31 INFO - Reading from file tmpfile_stdout 09:17:31 INFO - Output received: 09:17:31 INFO - Usage: mozinstall [options] installer 09:17:31 INFO - Options: 09:17:31 INFO - -h, --help show this help message and exit 09:17:31 INFO - -d DEST, --destination=DEST 09:17:31 INFO - Directory to install application into. [default: 09:17:31 INFO - "/builds/slave/test-pgo"] 09:17:31 INFO - --app=APP Application being installed. [default: firefox] 09:17:31 INFO - mkdir: /builds/slave/test-pgo/build/application 09:17:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:17:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:17:46 INFO - Reading from file tmpfile_stdout 09:17:46 INFO - Output received: 09:17:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:17:46 INFO - Running post-action listener: _resource_record_post_action 09:17:46 INFO - ##### 09:17:46 INFO - ##### Running run-tests step. 09:17:46 INFO - ##### 09:17:46 INFO - Running pre-action listener: _resource_record_pre_action 09:17:46 INFO - Running main action method: run_tests 09:17:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:17:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:17:46 INFO - Python 2.7.3 09:17:46 INFO - Return code: 0 09:17:46 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:46 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 0x2958660>, '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 0x2959560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2959a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:17:46 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 09:17:46 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 09:17:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:47 INFO - Return code: 0 09:17:47 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:17:47 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:17:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:17:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:17:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:17:48 INFO - Return code: 0 09:17:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 09:17:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:17:48 INFO - Using env: {'DISPLAY': ':0', 09:17:48 INFO - 'HOME': '/home/cltbld', 09:17:48 INFO - 'LANG': 'en_US.UTF-8', 09:17:48 INFO - 'LANGUAGE': 'en_US:en', 09:17:48 INFO - 'LOGNAME': 'cltbld', 09:17:48 INFO - 'MAIL': '/var/mail/cltbld', 09:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:48 INFO - 'MOZ_NO_REMOTE': '1', 09:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:48 INFO - 'NO_EM_RESTART': '1', 09:17:48 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:48 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:48 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:17:48 INFO - 'SHELL': '/bin/bash', 09:17:48 INFO - 'SHLVL': '1', 09:17:48 INFO - 'TERM': 'linux', 09:17:48 INFO - 'TMOUT': '86400', 09:17:48 INFO - 'USER': 'cltbld', 09:17:48 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226', 09:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:48 INFO - '_': '/tools/buildbot/bin/python'} 09:17:48 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:17:48 INFO - mozversion application_buildid: 20160222063456 09:17:48 INFO - mozversion application_changeset: 19f7989b29da7a6f37e21b02ac6b3da7aefda10c 09:17:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:48 INFO - mozversion application_name: Firefox 09:17:48 INFO - mozversion application_remotingname: firefox-dev 09:17:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:48 INFO - mozversion application_vendor: Mozilla 09:17:48 INFO - mozversion application_version: 46.0a2 09:17:48 INFO - mozversion platform_buildid: 20160222063456 09:17:48 INFO - mozversion platform_changeset: 19f7989b29da7a6f37e21b02ac6b3da7aefda10c 09:17:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:48 INFO - mozversion platform_version: 46.0a2 09:17:48 INFO - using testdate: 1456161468 09:17:48 INFO - actual date: 1456161468 09:17:48 INFO - starting webserver on 'localhost:59219' 09:17:48 INFO - SUITE-START | Running 3 tests 09:17:48 INFO - TEST-START | dromaeo_css 09:17:48 INFO - operating with platform_type : linux_ 09:17:48 INFO - Initialising browser for dromaeo_css test... 09:17:48 INFO - TEST-INFO | started process 13979 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9OTSo/profile http://localhost:59219/getInfo.html) 09:17:52 INFO - PROCESS | 13979 | 09:17:52 INFO - PROCESS | 13979 | (process:14059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:53 INFO - PROCESS | 13979 | __metrics Screen width/height:1600/1200 09:17:53 INFO - PROCESS | 13979 | colorDepth:24 09:17:53 INFO - PROCESS | 13979 | Browser inner width/height: 1024/697 09:17:53 INFO - PROCESS | 13979 | __metrics 09:17:54 INFO - TEST-INFO | 13979: exit 0 09:17:54 INFO - Browser initialized. 09:17:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:54 INFO - TEST-INFO | started process 14108 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt9OTSo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:55 INFO - PROCESS | 14108 | 09:17:55 INFO - PROCESS | 14108 | (process:14169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:05 INFO - PROCESS | 14108 | RSS: Main: 141172736 09:18:05 INFO - PROCESS | 14108 | 09:18:55 INFO - PROCESS | 14108 | 1456161535557 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] 09:21:02 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59219/tests/dromaeo/cssquery-ext.html) 09:21:04 INFO - PROCESS | 14108 | RSS: Main: 146219008 09:21:04 INFO - PROCESS | 14108 | 09:24:06 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-ext.html (next: http://localhost:59219/tests/dromaeo/cssquery-jquery.html) 09:24:06 INFO - PROCESS | 14108 | RSS: Main: 144642048 09:24:06 INFO - PROCESS | 14108 | 09:27:08 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59219/tests/dromaeo/cssquery-mootools.html) 09:27:09 INFO - PROCESS | 14108 | RSS: Main: 143376384 09:27:09 INFO - PROCESS | 14108 | 09:30:10 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59219/tests/dromaeo/cssquery-prototype.html) 09:30:11 INFO - PROCESS | 14108 | RSS: Main: 142544896 09:30:11 INFO - PROCESS | 14108 | 09:33:13 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59219/tests/dromaeo/cssquery-yui.html) 09:33:14 INFO - PROCESS | 14108 | RSS: Main: 143695872 09:33:14 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:59219/tests/dromaeo/cssquery-yui.html (next: http://localhost:59219/tests/dromaeo/cssquery-dojo.html) 09:36:16 INFO - PROCESS | 14108 | RSS: Main: 146628608 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | __start_tp_report 09:36:16 INFO - PROCESS | 14108 | _x_x_mozilla_page_load 09:36:16 INFO - PROCESS | 14108 | _x_x_mozilla_page_load_details 09:36:16 INFO - PROCESS | 14108 | |i|pagename|runs| 09:36:16 INFO - PROCESS | 14108 | |0;dojo.html;3322.5846769153854;3324.850381732822;3362.546056282401;3367.1918739502526;3369.679880411361;5369.7583608737605;5371.919421208685;5378.408375078739;5391.191321301807;5404.162354834997;5344.732763361836;5400.054990376688;5403.972980135104;5408.323959505062;5411.621186516945;4907.3865766779245;4947.579455746248;4977.228529577921;4986.276989836471;5069.087564238435;4780.737059461728;4902.7058376497525;4986.152354099811;4989.800407983676;4991.051700176973;4957.380327459067;4962.677425967318;5030.421501527335;5048.444671086178;5053.039922414748;4998.57512111471;5013.172826483626;5020.3724534433195;5031.597472202215;5032.094223039851;4797.688150270256;4855.5387238212315;4880.731559764212;4939.975300123477;4953.281774142765;5273.077211487975;5287.312649355559;5288.418273989858;5290.470952904717;5298.549623282026;5803.738831752581;5805.36141024487;5814.651120932757;5819.88360232793;5837.708114594296;5647.915281270784;5675.34733505648;5758.3090029196765;5777.220075289824;5880.323762767293;5416.674999500004;5416.83749487516;5418.024755544;5421.864453388657;5445.727713614343;5859.033259512218;5876.970615146983;5885.352611212763;5887.793927212527;5897.67562784051;5565.526930210977;5631.662100273997;5649.4350564944;5659.801906933238;5661.037623603997;5794.8551286217335;5834.5624078194305;5836.445537673914;5843.328017277982;5857.531397488191;5781.942180578225;5784.161296611967;5787.074068149076;5792;5804.651720896675;5651.321841378978;5680.346760122638;5761.107028410603;5793.073108302651;5846.678432686158;4443.6667249955735;4467.6202522785925;4477.977610111929;4482.484514280899;4496.955030449653;4039.7980100994832;4045.3527435610163;4046.2716710991717;4067.8576249831112;4077.959220407817;5402.324709411324;5422.783088676409;5446.291982042309;5470.9452905471235;5564.276644036249;5698.17376480408;5703.372629010805;5707.34365547959;5711.857203569944;5716.771329146871;5424.647397919122;5431.402545719968;5446.809361672323;5457.045017121988;5463.071277882769;4972.353594032753;4980.9252861207115;5019.974900125549;5046.1926091825135;5048.192289233779;5946;5967.940320596738;5972.820815375546;6006.789762358297;6013.54898382623;5678.574106941914;5695.487406133468;5842.766289348463;5847.619904706181;5853.64878107315;6000.819975400745;6001.579889407874;6065.272167339947;6068.332483426731;6105.9084113737445;5677.545796336366;5732.7706891723865;5762.222100016612;5775.971120144372;5789.652620842763;5711.971440142939;5821.126830975388;5826.883462330815;5858.091995740667;5866.472017518444;5689.34572524165;5732.742026608896;5739.426057394227;5744.942550574608;5745.511631511368;5682.573806964577;5690.260266165372;5705.572082093942;5716.742746576498;5716.857078573069;5433.5381492572;5455.290812194389;5503.091989821794;5513.448655134454;5646.983542962142;5594.0769772987005;5625.831225063254;5641.435856414326;5643.971780141073;5696.088625819849;5560;5586.469285417878;5595.804146854841;5602.047651899105;5603.80386686464 09:36:16 INFO - PROCESS | 14108 | |1;ext.html;559.8264537993223;566.6005466146364;577.3389469057928;586.988260234795;592.9229200203973;41908.161836763284;42228.788856055675;42829.143417131636;42839.78580107099;42878.57121428785;46215.30677039847;46681.29978050332;46885;46898;46969.5909122726;9056.230220431255;9194.35639505235;9241.676541321056;9251.25989920808;9255.53722313885;8914.465132092062;9038.276937844958;9044.23124034458;9055.909440905572;9099.590518426654;8997.05530919254;9065.22945549629;9088.454692718426;9102.180803727662;9112.8633070504;8943.731688049402;8959.193672569467;8971.147740964598;8979.14698103679;9091.63633454661;8740.956295218546;8901.510416927067;8911;8944.284457243404;8967.820643587156;40248;40623.1875362494;40653.18693626111;40711.79644101761;40738.38892416616;3923.391874259494;4243.215005224043;4243.469566304212;4430.667699922518;4449.2213862574245;31285.687143128733;31547.369052619048;31564;31919.202019949455;32514.349713005842;4166.8749937501925;4274.957250427487;4338.891527711801;4353.978230108829;4364.2798938175165;298025;300459;301142;302338;303022.9999999978;44850.55149448529;45371.54628453739;45536.3169552457;45739;45752;42821;43229.78385108117;43257.56742432535;43265;43321;16314.592135196715;16340.591485212964;16517.091559964076;16568.83431165697;16602.916985414995;11949.701257468632;11954.880451195551;11959.701007474883;11985.460654270579;12271.93864030692;14928.40286388554;14941.626459338604;14999.475018374524;15094.54716358511;15140.772888406682;5923.229980102559;6085.786997455068;6095;6100.847478812976;6164.969175154185;1074.9677509674566;1095.4358505369742;1104.7514309280348;1154.8970732950013;1191.6603767926272;29915.551266731018;29992.700072998992;30612.234694132378;30637.38725225483;31183.376332473224;1163.2497039409534;1269.504893091695;1274.9609068609054;1279.7824369857146;1344.8655134486473;15862.52412427629;15933.681326373408;15934.56588907004;16243.269052892649;16369.754453683205;338653;535170;541320;542024;554904;54602;55528;55529.722351388795;55622;55767.44232557704;1460.8539146085518;1475.1960181701;1480.962975925589;1486.457443033285;1499.4601943300404;32175;32673.509897351083;32909.50635740514;32974.34051319008;33810.49284260787;49370.753146235475;49836.75081624569;49994.500054998985;50239.24641130459;50381.74809125931;325132;326081;328034;328767;330562;34390.48414273838;34678.65321346754;34694;35114.47328290027;35293.647063530065;45921.54078459173;46228.53771462242;46794;47459.05081898412;47632.52367476281;40853.59146408498;42529.57470425256;46241.76879115583;46813.76593117149;46992.7650361746;39340.803295983336;39719.205615886945;39823.2035359297;40263.79868100758;40434.59565404426;40887.795561022;42039.7898010508;42262.57737422586;42320.941976450835;42506;29452.705472944996;31963.680363196072;32126.19684507906;32332.676673232967;32475.837620811744;25969.74030259749;28231.396050917778;28730;28977;29460.55809162907 09:36:16 INFO - PROCESS | 14108 | |2;jquery.html;384.5404741334106;385.98649047283334;387.93405121129405;393.1782574419463;400.0798164222288;15638;16321.183940802943;17422.82577174228;19779.60440791185;19819.900900495497;10998.615048473304;11623.941880290608;11666.416679166028;17413.73879391807;17542.649147017084;4889.26661000851;5113.207452844806;5275.577953763709;5281.70950597717;5779.913301300484;5248.448912864152;5468.26178465906;5489.752961116739;5490.313710786152;5673.8581535461535;5243.947560524384;5449.863753406176;5465.863353416176;5494.478024587658;5505.944940550603;5289.259503669489;5422.403535611099;5432.483914028161;5453.618246722731;5497.505224529811;5031.295618613397;5279.498447647467;5305.495977882095;5311.256424100629;5322;13914.373853176632;14021.158730476203;14042.789358159636;16339.754903676454;21412.571748565097;2211.347652442533;2212.5021870079104;2273.874936878471;2302.9078836846506;2391.0077317913046;11153.330800152016;13482.19106853592;13788.241646709426;13897.235652039133;14030.1581905085;1919.932802351911;1927.421773467968;1942.2134035715558;1964.6070785842746;1981.9504512387305;59739.701301493646;59796.40203597952;61988.07017894735;62247.377526225064;62292.37707622911;9776.608935642636;9931.404115753077;9981.999999999854;10011.549480273405;10193.541290641939;12752.043596730282;12812.42344094518;12817.679558011125;12877.098603097693;12908.483660653657;7885.487443316166;7947.046354437389;8091.109977902426;8106.9594652027545;8180;7900.841983160304;7928.4450088494405;7939.325157361689;7974.561399123104;7994.2805147537;4457.1308594823695;4653.23221668421;4696.084263568571;4718.127146477913;4771.785269662804;1772.5036989642663;1797.667431525146;1857.4799056264267;1876.1088482970479;1912.3306842604977;471.3966123362102;489.2538878210757;506.6099103690138;960.851068084448;1077.385890042668;11073.390963496924;11221.775564488664;11337.206395552397;11417.48621312043;11501.36742479155;496.99254511182363;1005.8139244239838;1009.8687170667913;1032.4631191780231;1034.255336157965;9240.8613870792;9765.853512197322;10089.848652270222;10572.788544229226;10631.308964917256;574835;575518;585811;593773;599255;74418;75644;75754;77423;79521.60239198768;1221.9389030548436;1232.303748382179;1235.7960936445386;1242.5588915934893;1251.3492983648453;14872.33074511628;16006.839931600534;16181.59546011359;16225.918870405572;16284.674306513567;30755;32377.838110809294;32491.512627310138;34373.31253374968;34679.306413871076;39027.21945561016;41462.378064328455;44787.55212447834;45903.3114503276;48220;7338.082739657543;7552.358049565629;7596.202398748273;7601.885971710318;7912.525248485109;11021;11022.724431889266;11133.332000080021;11264.887351126712;11851.466683999068;9557.23542116643;9861.753456163653;10041.748956276151;10232.437215953194;10360.119389851947;9835.508224588599;10092.949535252277;10154.644587439405;10302.175825934057;10495.265331426726;8245.546494942595;9665.806683866424;10152.796944061225;10506.369617822955;10605.946970265099;7692.884606731015;7997.920020799717;8010.559419231999;8017.198280171936;8064.435489515678;10226.28416010872;10430.634927777492;10506.737331566466;10672.733181670521;10756.139508839431 09:36:16 INFO - PROCESS | 14108 | |3;mootools.html;1482.384810303724;1502.1587910769967;1739.521631551324;1857.414914301994;1926.2198809482165;7401.740939067134;7515.887261691066;7928.3260922821555;8044.557549334784;8123.471974321672;7805.687772489107;7959.243871832181;8014.078380986189;8019.198080191978;8102.756917292476;2420.9636855447184;2454.5090981803623;2457.741937096606;2461.7415171406924;2462.741412151725;2418.5592282932616;2491.402063504764;2496.500699860035;2506.285708573057;2519.5590771614984;2414.3722632115687;2422.903083876643;2427.7329493755674;2428.7935525480357;2443.6823212982285;2448.020791683332;2450.3629056445366;2470.28361775085;2478.0707234786955;2479.851208927461;2505.912293069752;2510.811689123323;2530.671012768328;2532.430203204283;2546.261584140597;8136.02367715872;8158.347332213409;8163.0612479564425;8188;8194.344452443791;5029.773660185264;5078.13671675816;5161.864389834231;5188.092083885305;5189.558887494568;3094.5667606535103;3271.7219036381935;3281.2125089978235;3283.097148284241;3293.7859039162377;1086.3427626286061;1088.9945550272278;1163.7905177068124;1164.7554013657143;1198.922070065443;11616.128790340757;11772.823407648892;11794.233374830608;11838.112141589329;11858.881411185865;4676.392069031004;4701.2478003519955;4752.786124624331;4812.663113582015;4822.927656085161;10204.183665306758;10214.591416343412;10221.795564088676;10226.53980570876;10248.38509689421;5261.684298941999;5292.92060619091;5314.574834013347;5346;5357;4780.49804770501;4809.134355815987;4832.420109586802;4859.489753575824;4878.414590249193;3968.444417781513;3982.2433737590345;3992.540857801332;4040.8383664653084;4045.5145382554283;1268.4101892619792;1278.1244847279643;1286.0933042205222;1292.7414517096618;1303;1425.8930580206527;1444.4077928049448;1464.699736554004;1469.1772607339924;1498.2059508460534;7785.805354866174;7870.645820938072;7890.132085470594;7922.168172341936;7956.085050219183;531.7394476706386;531.9388270348959;533.1549494051972;542.9647072940326;554.4400155842548;5893.499052580579;5895.64626122434;5945.316288626776;5948.910766338508;6004.579679422486;9541.761455963657;9642.035796420441;9675.935647078815;9779.608815647436;9800.166985806287;9488.715338539854;9591.760205994906;9603.567839447102;9664;9723.222142228746;7698.730544430918;7754.9224507755325;7778.611069446505;7787.766367008999;7791.883121753178;7756.418268629763;7782.571958542108;7816.335611473089;7838.372930165687;7896.802579935547;8870.955645221991;9093.954530227307;9099;9208.49353285549;9295.628174872929;8685.305175585812;8874.733757987271;9421.104995025462;9474.668386606436;9528.475933823705;7278.563286202845;7279.526830755984;7358.632068396666;7383.963080184565;7394.260573942563;7578.052743407075;7653.808654783675;7780.961095194488;7794.415418843496;7810.101838288442;7189.1013623297085;7346;7457.142428620561;7503.09962804467;7611.314981651456;7264.34620884123;7295.161056478573;7406.259374062766;7441.590712510864;7455.291747283999;7325.974363589208;7466.514676546007;7471.738489152854;7488.101427828696;7496.362809161283;6879.415249703631;6909.378155965987;6910.343517365842;6917.619530925847;6940.375366217065;6497.675116244263;6525.3800888915475;6558.147440832661;6594.670266486753;6763.830904227434 09:36:16 INFO - PROCESS | 14108 | |4;prototype.html;365.37885594489364;373.7682636765204;374.5262243262275;377.40181811828245;378.40968089779943;6305.779297724581;6337.524685648572;6342.714577843996;6404.871902561946;6480;6324.3991820776955;6325.746970121189;6363.109164716943;6366.172397588319;6373;4884.267359896008;4889.071076495472;4891.461939186686;4893.388326459192;4903.9754801225945;4889.413270407538;4899.534544218312;4900.019996000797;4900.7794649240695;4916.680415772981;4675.041616468616;4713.670043096985;4768.546988036131;4774.9761251193695;4843.39457567804;4788.856334309976;4804.063207674522;4814.10938976287;4816.349792777965;4823.107725070873;4207.600277973618;4222.493300803892;4222.683298752606;4224.112936283384;4252.043290259698;5974.37269086744;5975.25309336333;5983.521318294526;5993.190919225893;5998.340182579913;5598.1322894950945;5620.072688006474;5698;5715.428457154293;5725.112607545795;6625.469962402996;6668.733250670016;6725.125733654642;6732.2257940336995;6744.156980377453;4717.693349932243;4718.292256161569;4719.95280047202;4722.126406614753;4737.170995075882;6894.896576551356;6966.442684585221;7014.859702805967;7039.366457018893;7054.823629409255;4822.9758851205515;4827.131116399082;4842.685225460334;4847.660663753503;4852.56326930578;4903.387076615423;4905.901881962341;4910.042541704333;4922.187839006524;4929.433115191799;5626.071698169838;5644.491995720323;5653.462921022497;5657.189699296268;5673.149027645886;6719.697613607399;6800.625965571842;6823.965880170666;6824.317568243136;6827.249002609709;1716.1076240354946;1734.167599552222;1735.0977491704496;1738.721804511272;1739.199968014702;1143.3711458697849;1162.1574358589955;1163.5404015413865;1164.5050853387277;1171.8710941796396;6501.1548498694865;6503.674816259168;6507.3167317431935;6555.311692272338;6563.146790917151;6958.756443524554;6973.4072603829245;6997.4052205562075;7017.193022802443;7024.578525288499;6372.203474565679;6513.348665133449;6516.57642253252;6562.639054851934;6639.070530125786;3799.848006079781;3818.4845045919;3836.07934095815;3837.76973381598;3845.7115716321387;7280.41756659466;7284.235155308616;7349.522281051714;7350.823868181065;7359.6688149033425;7130.643467826588;7291.598962057032;7293.489455738048;7300.926990730131;7318.63406829667;7294.489385743053;7311.305425984523;7317.707291708272;7327.560346379234;7330.5968171751065;6932.272111428228;7028.297170282931;7060.43516518667;7073;7073.504854660125;6886.345797149263;6944.166699996033;6944.756933507303;6993.160820701549;6995.510314277952;7309.232530584212;7309.963450182928;7312.1591017033725;7318.524295920748;7342.9632851835395;4821.831235906727;4839.564439200489;4853.854384368475;4868.294097355934;4884.804607815648;6857.828554286183;7088.255733147946;7106.502544821813;7110.288971102848;7135.822589272711;6892.586444813327;6901.413379862768;6908.585484870924;6910.896336554855;6917.342852429011;6742.595444273163;6837.794866154023;6850.520463567702;6865.725370985105;6874.4844136690945;6753.662316884234;6791.558548694319;6806.285340039224;6838.316168383122;6858.691358888762;6871.072405225231;6929.618870962146;6936.0636314096955;6969;6990.825229369307;6598.505112116514;6637.70130344126;6698.263191049078;6702.966485167738;6718.697658605277 09:36:16 INFO - PROCESS | 14108 | |5;yui.html;808.316972158526;906.8960012770374;946.5740416812436;952.6237136331149;953.5613617735842;13902.443902243911;13963.301834908265;14046.016778825498;14083.225422601752;14141.292935353242;13810.861891381082;13837.446502139928;13862.861371386283;13871.583852484442;13873.306334683275;757.303280981497;771.3713323641242;873.057098333798;890.8930928288614;897.5512243878061;898.0525545549443;899.7615631857562;900.2348004196446;902.6975963052386;903.832790933676;944.0795224655974;949.4398305000049;951.4243882451121;954.0793134625086;954.5942974235957;937.6765016069445;937.8640097185904;938.5494962418044;943.7216021273741;943.9622415103388;698.0889938630086;699.1784653032666;701.9017337572744;704.7322017633318;705.2559549675091;13890;13933.512327068605;13982.510612128628;14011.29943502831;14011.64970875726;13659.590212293648;13864.930675346659;13961.162330260115;13979;14225.715485690229;11310.886891131147;11386.71533211668;11444.599439019677;11536.711582210428;11838.822417663741;3868.6518213360932;3909.7263191576603;3943.743656662308;3946.1515774108416;3976.264391087658;49461;49791.75104124493;49979.500204998214;50029.24956125661;50077.49922500765;11171.83242251367;11360.147988900866;11439.428028598537;11566.94216528912;11595.652130436101;19239.615207695766;19536.21855125779;19696;19740.309089182098;20154.59690806205;7902.24928631779;8386.161383861687;8442.957785211034;8543.487390756574;8620.784480387914;4629;4692;4697.882552936136;4830.106430310404;4848.248521479177;3169.8098114113227;3182.331710340808;3213.212762873064;3236.7896086754286;3261.5270785735934;604.5103466192398;609.2080295615682;609.8322961185621;610.764855530615;613.6563524426335;568.7554351628839;629.1412222316596;643.5784561112479;695.2838576266454;728.613834667627;8593.957030214933;8891.19979201875;8931.285497160212;8997.820043599091;9062.229710474552;646.4763541531374;692.5463821197123;711.839836036898;761.7181642792092;806.3911746631256;4807.95192048075;4934.802607895644;5021.874453138701;5045.117104506697;5130.204818253177;61043.6947815267;61251.38748612457;61765.691171543855;61800.69099654563;61922.0711689325;55784.16323755147;55908.16137757937;56804;57037.42962570404;57179.42820571824;50503;51630.67661955221;52167.478325217024;52187.73906130445;52349;9928.313802960201;10029.398236105857;10051.145652619609;10208.540615672164;10219.058378907983;36087.819560902026;36110.638893610725;36172.63827361798;37104.25791484209;37755.43366849554;46069.76965115153;49820.50179498159;50172.996540069726;50412.49587504078;50637;11800.291982481078;12107.75784484323;12169.391530423267;12259.754804903674;12351.505939762668;13227.470901163846;13440.327983600586;13564.86435135636;13617.659558511117;13889;12409.317487538272;12614.180078294881;12839.101262911507;12896.161749486253;12976.8053479196;12801.167924084904;12949.482020719066;13006.934965325112;13040.217586944813;13080.672983175116;12464.68838279014;12523.248605083723;12838.42227099764;12982.545610903573;13026.54407095785;10281.485925703535;10380.584776608852;10500.212484063879;10646.787064258826;10755.129457137828;10581.523831427758;10979.17656175774;11005.394703291076;11016.741567978705;11187.944060279646 09:36:16 INFO - PROCESS | 14108 | __end_tp_report 09:36:16 INFO - PROCESS | 14108 | __start_cc_report 09:36:16 INFO - PROCESS | 14108 | _x_x_mozilla_cycle_collect,294 09:36:16 INFO - PROCESS | 14108 | __end_cc_report 09:36:16 INFO - PROCESS | 14108 | __startTimestamp1456162576714__endTimestamp 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | ------- Summary: start ------- 09:36:16 INFO - PROCESS | 14108 | Number of tests: 6 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#0] dojo.html Cycles:165 Average:5388.37 Median:5594.08 stddev:570.98 (10.2%) stddev-sans-first:549.26 09:36:16 INFO - PROCESS | 14108 | Values: 3322.6 3324.9 3362.5 3367.2 3369.7 5369.8 5371.9 5378.4 5391.2 5404.2 5344.7 5400.1 5404.0 5408.3 5411.6 4907.4 4947.6 4977.2 4986.3 5069.1 4780.7 4902.7 4986.2 4989.8 4991.1 4957.4 4962.7 5030.4 5048.4 5053.0 4998.6 5013.2 5020.4 5031.6 5032.1 4797.7 4855.5 4880.7 4940.0 4953.3 5273.1 5287.3 5288.4 5290.5 5298.5 5803.7 5805.4 5814.7 5819.9 5837.7 5647.9 5675.3 5758.3 5777.2 5880.3 5416.7 5416.8 5418.0 5421.9 5445.7 5859.0 5877.0 5885.4 5887.8 5897.7 5565.5 5631.7 5649.4 5659.8 5661.0 5794.9 5834.6 5836.4 5843.3 5857.5 5781.9 5784.2 5787.1 5792.0 5804.7 5651.3 5680.3 5761.1 5793.1 5846.7 4443.7 4467.6 4478.0 4482.5 4497.0 4039.8 4045.4 4046.3 4067.9 4078.0 5402.3 5422.8 5446.3 5470.9 5564.3 5698.2 5703.4 5707.3 5711.9 5716.8 5424.6 5431.4 5446.8 5457.0 5463.1 4972.4 4980.9 5020.0 5046.2 5048.2 5946.0 5967.9 5972.8 6006.8 6013.5 5678.6 5695.5 5842.8 5847.6 5853.6 6000.8 6001.6 6065.3 6068.3 6105.9 5677.5 5732.8 5762.2 5776.0 5789.7 5712.0 5821.1 5826.9 5858.1 5866.5 5689.3 5732.7 5739.4 5744.9 5745.5 5682.6 5690.3 5705.6 5716.7 5716.9 5433.5 5455.3 5503.1 5513.4 5647.0 5594.1 5625.8 5641.4 5644.0 5696.1 5560.0 5586.5 5595.8 5602.0 5603.8 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#1] ext.html Cycles:180 Average:53949.28 Median:41973.98 stddev:103366.28 (246.3%) stddev-sans-first:103578.52 09:36:16 INFO - PROCESS | 14108 | Values: 559.8 566.6 577.3 587.0 592.9 41908.2 42228.8 42829.1 42839.8 42878.6 46215.3 46681.3 46885.0 46898.0 46969.6 9056.2 9194.4 9241.7 9251.3 9255.5 8914.5 9038.3 9044.2 9055.9 9099.6 8997.1 9065.2 9088.5 9102.2 9112.9 8943.7 8959.2 8971.1 8979.1 9091.6 8741.0 8901.5 8911.0 8944.3 8967.8 40248.0 40623.2 40653.2 40711.8 40738.4 3923.4 4243.2 4243.5 4430.7 4449.2 31285.7 31547.4 31564.0 31919.2 32514.3 4166.9 4275.0 4338.9 4354.0 4364.3 298025.0 300459.0 301142.0 302338.0 303023.0 44850.6 45371.5 45536.3 45739.0 45752.0 42821.0 43229.8 43257.6 43265.0 43321.0 16314.6 16340.6 16517.1 16568.8 16602.9 11949.7 11954.9 11959.7 11985.5 12271.9 14928.4 14941.6 14999.5 15094.5 15140.8 5923.2 6085.8 6095.0 6100.8 6165.0 1075.0 1095.4 1104.8 1154.9 1191.7 29915.6 29992.7 30612.2 30637.4 31183.4 1163.2 1269.5 1275.0 1279.8 1344.9 15862.5 15933.7 15934.6 16243.3 16369.8 338653.0 535170.0 541320.0 542024.0 554904.0 54602.0 55528.0 55529.7 55622.0 55767.4 1460.9 1475.2 1481.0 1486.5 1499.5 32175.0 32673.5 32909.5 32974.3 33810.5 49370.8 49836.8 49994.5 50239.2 50381.7 325132.0 326081.0 328034.0 328767.0 330562.0 34390.5 34678.7 34694.0 35114.5 35293.6 45921.5 46228.5 46794.0 47459.1 47632.5 40853.6 42529.6 46241.8 46813.8 46992.8 39340.8 39719.2 39823.2 40263.8 40434.6 40887.8 42039.8 42262.6 42320.9 42506.0 29452.7 31963.7 32126.2 32332.7 32475.8 25969.7 28231.4 28730.0 28977.0 29460.6 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#2] jquery.html Cycles:180 Average:29042.74 Median:385.26 stddev:95754.42 (24854.3%) stddev-sans-first:95998.85 09:36:16 INFO - PROCESS | 14108 | Values: 384.5 386.0 387.9 393.2 400.1 15638.0 16321.2 17422.8 19779.6 19819.9 10998.6 11623.9 11666.4 17413.7 17542.6 4889.3 5113.2 5275.6 5281.7 5779.9 5248.4 5468.3 5489.8 5490.3 5673.9 5243.9 5449.9 5465.9 5494.5 5505.9 5289.3 5422.4 5432.5 5453.6 5497.5 5031.3 5279.5 5305.5 5311.3 5322.0 13914.4 14021.2 14042.8 16339.8 21412.6 2211.3 2212.5 2273.9 2302.9 2391.0 11153.3 13482.2 13788.2 13897.2 14030.2 1919.9 1927.4 1942.2 1964.6 1982.0 59739.7 59796.4 61988.1 62247.4 62292.4 9776.6 9931.4 9982.0 10011.5 10193.5 12752.0 12812.4 12817.7 12877.1 12908.5 7885.5 7947.0 8091.1 8107.0 8180.0 7900.8 7928.4 7939.3 7974.6 7994.3 4457.1 4653.2 4696.1 4718.1 4771.8 1772.5 1797.7 1857.5 1876.1 1912.3 471.4 489.3 506.6 960.9 1077.4 11073.4 11221.8 11337.2 11417.5 11501.4 497.0 1005.8 1009.9 1032.5 1034.3 9240.9 9765.9 10089.8 10572.8 10631.3 574835.0 575518.0 585811.0 593773.0 599255.0 74418.0 75644.0 75754.0 77423.0 79521.6 1221.9 1232.3 1235.8 1242.6 1251.3 14872.3 16006.8 16181.6 16225.9 16284.7 30755.0 32377.8 32491.5 34373.3 34679.3 39027.2 41462.4 44787.6 45903.3 48220.0 7338.1 7552.4 7596.2 7601.9 7912.5 11021.0 11022.7 11133.3 11264.9 11851.5 9557.2 9861.8 10041.7 10232.4 10360.1 9835.5 10092.9 10154.6 10302.2 10495.3 8245.5 9665.8 10152.8 10506.4 10605.9 7692.9 7997.9 8010.6 8017.2 8064.4 10226.3 10430.6 10506.7 10672.7 10756.1 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#3] mootools.html Cycles:180 Average:5820.39 Median:5894.57 stddev:3006.04 (51.0%) stddev-sans-first:2996.79 09:36:16 INFO - PROCESS | 14108 | Values: 1482.4 1502.2 1739.5 1857.4 1926.2 7401.7 7515.9 7928.3 8044.6 8123.5 7805.7 7959.2 8014.1 8019.2 8102.8 2421.0 2454.5 2457.7 2461.7 2462.7 2418.6 2491.4 2496.5 2506.3 2519.6 2414.4 2422.9 2427.7 2428.8 2443.7 2448.0 2450.4 2470.3 2478.1 2479.9 2505.9 2510.8 2530.7 2532.4 2546.3 8136.0 8158.3 8163.1 8188.0 8194.3 5029.8 5078.1 5161.9 5188.1 5189.6 3094.6 3271.7 3281.2 3283.1 3293.8 1086.3 1089.0 1163.8 1164.8 1198.9 11616.1 11772.8 11794.2 11838.1 11858.9 4676.4 4701.2 4752.8 4812.7 4822.9 10204.2 10214.6 10221.8 10226.5 10248.4 5261.7 5292.9 5314.6 5346.0 5357.0 4780.5 4809.1 4832.4 4859.5 4878.4 3968.4 3982.2 3992.5 4040.8 4045.5 1268.4 1278.1 1286.1 1292.7 1303.0 1425.9 1444.4 1464.7 1469.2 1498.2 7785.8 7870.6 7890.1 7922.2 7956.1 531.7 531.9 533.2 543.0 554.4 5893.5 5895.6 5945.3 5948.9 6004.6 9541.8 9642.0 9675.9 9779.6 9800.2 9488.7 9591.8 9603.6 9664.0 9723.2 7698.7 7754.9 7778.6 7787.8 7791.9 7756.4 7782.6 7816.3 7838.4 7896.8 8871.0 9094.0 9099.0 9208.5 9295.6 8685.3 8874.7 9421.1 9474.7 9528.5 7278.6 7279.5 7358.6 7384.0 7394.3 7578.1 7653.8 7781.0 7794.4 7810.1 7189.1 7346.0 7457.1 7503.1 7611.3 7264.3 7295.2 7406.3 7441.6 7455.3 7326.0 7466.5 7471.7 7488.1 7496.4 6879.4 6909.4 6910.3 6917.6 6940.4 6497.7 6525.4 6558.1 6594.7 6763.8 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#4] prototype.html Cycles:180 Average:5694.66 Median:6490.58 stddev:1723.17 (26.5%) stddev-sans-first:1680.94 09:36:16 INFO - PROCESS | 14108 | Values: 365.4 373.8 374.5 377.4 378.4 6305.8 6337.5 6342.7 6404.9 6480.0 6324.4 6325.7 6363.1 6366.2 6373.0 4884.3 4889.1 4891.5 4893.4 4904.0 4889.4 4899.5 4900.0 4900.8 4916.7 4675.0 4713.7 4768.5 4775.0 4843.4 4788.9 4804.1 4814.1 4816.3 4823.1 4207.6 4222.5 4222.7 4224.1 4252.0 5974.4 5975.3 5983.5 5993.2 5998.3 5598.1 5620.1 5698.0 5715.4 5725.1 6625.5 6668.7 6725.1 6732.2 6744.2 4717.7 4718.3 4720.0 4722.1 4737.2 6894.9 6966.4 7014.9 7039.4 7054.8 4823.0 4827.1 4842.7 4847.7 4852.6 4903.4 4905.9 4910.0 4922.2 4929.4 5626.1 5644.5 5653.5 5657.2 5673.1 6719.7 6800.6 6824.0 6824.3 6827.2 1716.1 1734.2 1735.1 1738.7 1739.2 1143.4 1162.2 1163.5 1164.5 1171.9 6501.2 6503.7 6507.3 6555.3 6563.1 6958.8 6973.4 6997.4 7017.2 7024.6 6372.2 6513.3 6516.6 6562.6 6639.1 3799.8 3818.5 3836.1 3837.8 3845.7 7280.4 7284.2 7349.5 7350.8 7359.7 7130.6 7291.6 7293.5 7300.9 7318.6 7294.5 7311.3 7317.7 7327.6 7330.6 6932.3 7028.3 7060.4 7073.0 7073.5 6886.3 6944.2 6944.8 6993.2 6995.5 7309.2 7310.0 7312.2 7318.5 7343.0 4821.8 4839.6 4853.9 4868.3 4884.8 6857.8 7088.3 7106.5 7110.3 7135.8 6892.6 6901.4 6908.6 6910.9 6917.3 6742.6 6837.8 6850.5 6865.7 6874.5 6753.7 6791.6 6806.3 6838.3 6858.7 6871.1 6929.6 6936.1 6969.0 6990.8 6598.5 6637.7 6698.3 6703.0 6718.7 09:36:16 INFO - PROCESS | 14108 | 09:36:16 INFO - PROCESS | 14108 | [#5] yui.html Cycles:180 Average:15035.96 Median:4660.50 stddev:17221.66 (369.5%) stddev-sans-first:17236.83 09:36:16 INFO - PROCESS | 14108 | Values: 808.3 906.9 946.6 952.6 953.6 13902.4 13963.3 14046.0 14083.2 14141.3 13810.9 13837.4 13862.9 13871.6 13873.3 757.3 771.4 873.1 890.9 897.6 898.1 899.8 900.2 902.7 903.8 944.1 949.4 951.4 954.1 954.6 937.7 937.9 938.5 943.7 944.0 698.1 699.2 701.9 704.7 705.3 13890.0 13933.5 13982.5 14011.3 14011.6 13659.6 13864.9 13961.2 13979.0 14225.7 11310.9 11386.7 11444.6 11536.7 11838.8 3868.7 3909.7 3943.7 3946.2 3976.3 49461.0 49791.8 49979.5 50029.2 50077.5 11171.8 11360.1 11439.4 11566.9 11595.7 19239.6 19536.2 19696.0 19740.3 20154.6 7902.2 8386.2 8443.0 8543.5 8620.8 4629.0 4692.0 4697.9 4830.1 4848.2 3169.8 3182.3 3213.2 3236.8 3261.5 604.5 609.2 609.8 610.8 613.7 568.8 629.1 643.6 695.3 728.6 8594.0 8891.2 8931.3 8997.8 9062.2 646.5 692.5 711.8 761.7 806.4 4808.0 4934.8 5021.9 5045.1 5130.2 61043.7 61251.4 61765.7 61800.7 61922.1 55784.2 55908.2 56804.0 57037.4 57179.4 50503.0 51630.7 52167.5 52187.7 52349.0 9928.3 10029.4 10051.1 10208.5 10219.1 36087.8 36110.6 36172.6 37104.3 37755.4 46069.8 49820.5 50173.0 50412.5 50637.0 11800.3 12107.8 12169.4 12259.8 12351.5 13227.5 13440.3 13564.9 13617.7 13889.0 12409.3 12614.2 12839.1 12896.2 12976.8 12801.2 12949.5 13006.9 13040.2 13080.7 12464.7 12523.2 12838.4 12982.5 13026.5 10281.5 10380.6 10500.2 10646.8 10755.1 10581.5 10979.2 11005.4 11016.7 11187.9 09:36:16 INFO - PROCESS | 14108 | -------- Summary: end -------- 09:36:16 INFO - PROCESS | 14108 | 09:36:17 INFO - TEST-INFO | 14108: exit 0 09:36:17 INFO - TEST-OK | dromaeo_css | took 1109016ms 09:36:17 INFO - TEST-START | kraken 09:36:17 INFO - operating with platform_type : linux_ 09:36:17 INFO - Initialising browser for kraken test... 09:36:17 INFO - TEST-INFO | started process 14353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPc1Iq5/profile http://localhost:59219/getInfo.html) 09:36:20 INFO - PROCESS | 14353 | 09:36:20 INFO - PROCESS | 14353 | (process:14430): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:21 INFO - PROCESS | 14353 | __metrics Screen width/height:1600/1200 09:36:21 INFO - PROCESS | 14353 | colorDepth:24 09:36:21 INFO - PROCESS | 14353 | Browser inner width/height: 1024/697 09:36:21 INFO - PROCESS | 14353 | __metrics 09:36:22 INFO - TEST-INFO | 14353: exit 0 09:36:22 INFO - Browser initialized. 09:36:22 INFO - Running cycle 1/1 for kraken test... 09:36:22 INFO - TEST-INFO | started process 14479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPc1Iq5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:23 INFO - PROCESS | 14479 | 09:36:23 INFO - PROCESS | 14479 | (process:14543): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:34 INFO - PROCESS | 14479 | RSS: Main: 140906496 09:36:34 INFO - PROCESS | 14479 | 09:36:36 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59219/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:37 INFO - PROCESS | 14479 | RSS: Main: 145731584 09:36:37 INFO - PROCESS | 14479 | 09:36:40 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59219/tests/kraken/driver.html?testName=audio-dft) 09:36:40 INFO - PROCESS | 14479 | RSS: Main: 146497536 09:36:40 INFO - PROCESS | 14479 | 09:36:43 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59219/tests/kraken/driver.html?testName=audio-fft) 09:36:44 INFO - PROCESS | 14479 | RSS: Main: 146481152 09:36:44 INFO - PROCESS | 14479 | 09:36:46 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59219/tests/kraken/driver.html?testName=audio-oscillator) 09:36:46 INFO - PROCESS | 14479 | RSS: Main: 146640896 09:36:46 INFO - PROCESS | 14479 | 09:36:48 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59219/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:49 INFO - PROCESS | 14479 | RSS: Main: 147009536 09:36:49 INFO - PROCESS | 14479 | 09:36:52 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59219/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:52 INFO - PROCESS | 14479 | RSS: Main: 146972672 09:36:52 INFO - PROCESS | 14479 | 09:36:56 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59219/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:56 INFO - PROCESS | 14479 | RSS: Main: 145453056 09:36:56 INFO - PROCESS | 14479 | 09:36:59 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59219/tests/kraken/driver.html?testName=json-parse-financial) 09:37:00 INFO - PROCESS | 14479 | RSS: Main: 146833408 09:37:00 INFO - PROCESS | 14479 | 09:37:01 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59219/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:02 INFO - PROCESS | 14479 | RSS: Main: 145199104 09:37:02 INFO - PROCESS | 14479 | 09:37:04 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:04 INFO - PROCESS | 14479 | RSS: Main: 147140608 09:37:04 INFO - PROCESS | 14479 | 09:37:06 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:07 INFO - PROCESS | 14479 | RSS: Main: 146984960 09:37:07 INFO - PROCESS | 14479 | 09:37:09 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:10 INFO - PROCESS | 14479 | RSS: Main: 146935808 09:37:10 INFO - PROCESS | 14479 | 09:37:12 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:13 INFO - PROCESS | 14479 | RSS: Main: 145903616 09:37:13 INFO - PROCESS | 14479 | 09:37:14 INFO - PROCESS | 14479 | Cycle 1(1): loaded http://localhost:59219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59219/tests/kraken/driver.html?testName=ai-astar) 09:37:15 INFO - PROCESS | 14479 | RSS: Main: 147660800 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | __start_tp_report 09:37:15 INFO - PROCESS | 14479 | _x_x_mozilla_page_load 09:37:15 INFO - PROCESS | 14479 | _x_x_mozilla_page_load_details 09:37:15 INFO - PROCESS | 14479 | |i|pagename|runs| 09:37:15 INFO - PROCESS | 14479 | |0;ai-astar;112;105;112;110;111;121;110;110;110;111 09:37:15 INFO - PROCESS | 14479 | |1;audio-beat-detection;145;125;152;159;128;155;153;127;167;124 09:37:15 INFO - PROCESS | 14479 | |2;audio-dft;163;164;162;168;163;161;161;162;164;163 09:37:15 INFO - PROCESS | 14479 | |3;audio-fft;72;76;74;155;73;74;75;74;154;74 09:37:15 INFO - PROCESS | 14479 | |4;audio-oscillator;95;95;138;93;95;94;144;95;95;144 09:37:15 INFO - PROCESS | 14479 | |5;imaging-gaussian-blur;110;109;109;110;109;110;110;109;110;110 09:37:15 INFO - PROCESS | 14479 | |6;imaging-darkroom;147;147;147;147;146;147;147;148;148;146 09:37:15 INFO - PROCESS | 14479 | |7;imaging-desaturate;96;96;96;96;96;97;97;96;97;96 09:37:15 INFO - PROCESS | 14479 | |8;json-parse-financial;54;54;56;54;55;56;57;65;54;55 09:37:15 INFO - PROCESS | 14479 | |9;json-stringify-tinderbox;65;71;65;65;65;64;65;65;64;65 09:37:15 INFO - PROCESS | 14479 | |10;stanford-crypto-aes;80;82;83;82;83;82;81;89;81;80 09:37:15 INFO - PROCESS | 14479 | |11;stanford-crypto-ccm;110;113;121;115;114;114;118;112;110;120 09:37:15 INFO - PROCESS | 14479 | |12;stanford-crypto-pbkdf2;130;139;140;147;130;127;128;140;151;128 09:37:15 INFO - PROCESS | 14479 | |13;stanford-crypto-sha256-iterative;66;65;65;65;66;65;65;64;64;64 09:37:15 INFO - PROCESS | 14479 | __end_tp_report 09:37:15 INFO - PROCESS | 14479 | __start_cc_report 09:37:15 INFO - PROCESS | 14479 | _x_x_mozilla_cycle_collect,742 09:37:15 INFO - PROCESS | 14479 | __end_cc_report 09:37:15 INFO - PROCESS | 14479 | __startTimestamp1456162635164__endTimestamp 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | ------- Summary: start ------- 09:37:15 INFO - PROCESS | 14479 | Number of tests: 14 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:4.20 09:37:15 INFO - PROCESS | 14479 | Values: 112.0 105.0 112.0 110.0 111.0 121.0 110.0 110.0 110.0 111.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:152.50 stddev:16.07 (10.5%) stddev-sans-first:17.04 09:37:15 INFO - PROCESS | 14479 | Values: 145.0 125.0 152.0 159.0 128.0 155.0 153.0 127.0 167.0 124.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.02 (1.2%) stddev-sans-first:2.15 09:37:15 INFO - PROCESS | 14479 | Values: 163.0 164.0 162.0 168.0 163.0 161.0 161.0 162.0 164.0 163.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#3] audio-fft Cycles:10 Average:90.10 Median:74.00 stddev:33.96 (45.9%) stddev-sans-first:35.38 09:37:15 INFO - PROCESS | 14479 | Values: 72.0 76.0 74.0 155.0 73.0 74.0 75.0 74.0 154.0 74.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:22.98 (24.2%) stddev-sans-first:23.82 09:37:15 INFO - PROCESS | 14479 | Values: 95.0 95.0 138.0 93.0 95.0 94.0 144.0 95.0 95.0 144.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:37:15 INFO - PROCESS | 14479 | Values: 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 09:37:15 INFO - PROCESS | 14479 | Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 148.0 146.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:37:15 INFO - PROCESS | 14479 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:3.33 (6.0%) stddev-sans-first:3.46 09:37:15 INFO - PROCESS | 14479 | Values: 54.0 54.0 56.0 54.0 55.0 56.0 57.0 65.0 54.0 55.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.01 (3.1%) stddev-sans-first:2.13 09:37:15 INFO - PROCESS | 14479 | Values: 65.0 71.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.58 (3.2%) stddev-sans-first:2.60 09:37:15 INFO - PROCESS | 14479 | Values: 80.0 82.0 83.0 82.0 83.0 82.0 81.0 89.0 81.0 80.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:114.50 stddev:3.86 (3.4%) stddev-sans-first:3.70 09:37:15 INFO - PROCESS | 14479 | Values: 110.0 113.0 121.0 115.0 114.0 114.0 118.0 112.0 110.0 120.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.00 Median:139.50 stddev:8.62 (6.2%) stddev-sans-first:8.86 09:37:15 INFO - PROCESS | 14479 | Values: 130.0 139.0 140.0 147.0 130.0 127.0 128.0 140.0 151.0 128.0 09:37:15 INFO - PROCESS | 14479 | 09:37:15 INFO - PROCESS | 14479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 09:37:15 INFO - PROCESS | 14479 | Values: 66.0 65.0 65.0 65.0 66.0 65.0 65.0 64.0 64.0 64.0 09:37:15 INFO - PROCESS | 14479 | -------- Summary: end -------- 09:37:15 INFO - PROCESS | 14479 | 09:37:16 INFO - TEST-INFO | 14479: exit 0 09:37:16 INFO - TEST-OK | kraken | took 58749ms 09:37:16 INFO - TEST-START | v8_7 09:37:16 INFO - operating with platform_type : linux_ 09:37:16 INFO - Initialising browser for v8_7 test... 09:37:16 INFO - TEST-INFO | started process 14771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJJKYNI/profile http://localhost:59219/getInfo.html) 09:37:19 INFO - PROCESS | 14771 | 09:37:19 INFO - PROCESS | 14771 | (process:14848): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:37:20 INFO - PROCESS | 14771 | __metrics Screen width/height:1600/1200 09:37:20 INFO - PROCESS | 14771 | colorDepth:24 09:37:20 INFO - PROCESS | 14771 | Browser inner width/height: 1024/697 09:37:20 INFO - PROCESS | 14771 | __metrics 09:37:21 INFO - TEST-INFO | 14771: exit 0 09:37:21 INFO - Browser initialized. 09:37:21 INFO - Running cycle 1/1 for v8_7 test... 09:37:21 INFO - TEST-INFO | started process 14897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJJKYNI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:22 INFO - PROCESS | 14897 | 09:37:22 INFO - PROCESS | 14897 | (process:14957): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:37:33 INFO - PROCESS | 14897 | RSS: Main: 141004800 09:37:33 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | Cycle 1(1): loaded http://localhost:59219/tests/v8_7/run.html (next: http://localhost:59219/tests/v8_7/run.html) 09:37:55 INFO - PROCESS | 14897 | RSS: Main: 144752640 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | __start_tp_report 09:37:55 INFO - PROCESS | 14897 | _x_x_mozilla_page_load 09:37:55 INFO - PROCESS | 14897 | _x_x_mozilla_page_load_details 09:37:55 INFO - PROCESS | 14897 | |i|pagename|runs| 09:37:55 INFO - PROCESS | 14897 | |0;Richards;166.9727834362999 09:37:55 INFO - PROCESS | 14897 | |1;DeltaBlue;170.01020061203673 09:37:55 INFO - PROCESS | 14897 | |2;Encrypt;280.1120448179272 09:37:55 INFO - PROCESS | 14897 | |3;Decrypt;5213.541666666667 09:37:55 INFO - PROCESS | 14897 | |4;RayTrace;902.5270758122743 09:37:55 INFO - PROCESS | 14897 | |5;Earley;563.3802816901408 09:37:55 INFO - PROCESS | 14897 | |6;Boyer;11122.222222222223 09:37:55 INFO - PROCESS | 14897 | |7;RegExp;38830.188679245286 09:37:55 INFO - PROCESS | 14897 | |8;Splay;516.2622612287042 09:37:55 INFO - PROCESS | 14897 | |9;NavierStokes;4840.579710144928 09:37:55 INFO - PROCESS | 14897 | __end_tp_report 09:37:55 INFO - PROCESS | 14897 | __startTimestamp1456162675735__endTimestamp 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | ------- Summary: start ------- 09:37:55 INFO - PROCESS | 14897 | Number of tests: 10 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 167.0 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#1] DeltaBlue Cycles:1 Average:170.01 Median:170.01 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 170.0 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 280.1 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 5213.5 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#4] RayTrace Cycles:1 Average:902.53 Median:902.53 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 902.5 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#5] Earley Cycles:1 Average:563.38 Median:563.38 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 563.4 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#6] Boyer Cycles:1 Average:11122.22 Median:11122.22 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 11122.2 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#7] RegExp Cycles:1 Average:38830.19 Median:38830.19 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 38830.2 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#8] Splay Cycles:1 Average:516.26 Median:516.26 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 516.3 09:37:55 INFO - PROCESS | 14897 | 09:37:55 INFO - PROCESS | 14897 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:37:55 INFO - PROCESS | 14897 | Values: 4840.6 09:37:55 INFO - PROCESS | 14897 | -------- Summary: end -------- 09:37:55 INFO - PROCESS | 14897 | 09:37:56 INFO - TEST-INFO | 14897: exit 0 09:37:56 INFO - TEST-OK | v8_7 | took 40537ms 09:37:56 INFO - SUITE-END | took 1208s 09:37:56 INFO - Completed test suite (00:20:08) 09:37:56 INFO - Working with test: dromaeo_css 09:37:56 INFO - Generating results file: dromaeo_css 09:37:56 INFO - Working with test: kraken 09:37:56 INFO - Generating results file: kraken 09:37:56 INFO - javascript benchmark 09:37:56 INFO - Working with test: v8_7 09:37:56 INFO - Generating results file: v8_7 09:37:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:37:56 INFO - process_Request line: dromaeo_css 7258.48 graph.html#tests=[[72,52,43]] 09:37:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:56 INFO - process_Request line: kraken 1488.90 graph.html#tests=[[232,52,43]] 09:37:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:57 INFO - process_Request line: v8_7 22095.98 graph.html#tests=[[230,52,43]] 09:37:57 INFO - RETURN: dromaeo_css: 7258.48 09:37:57 INFO - RETURN: kraken: 1488.90 09:37:57 INFO - RETURN: v8_7: 22095.98 09:37:57 INFO - javascript benchmark 09:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3322.5846769153854, 3324.850381732822, 3362.546056282401, 3367.1918739502526, 3369.679880411361, 5369.7583608737605, 5371.919421208685, 5378.408375078739, 5391.191321301807, 5404.162354834997, 5344.732763361836, 5400.054990376688, 5403.972980135104, 5408.323959505062, 5411.621186516945, 4907.3865766779245, 4947.579455746248, 4977.228529577921, 4986.276989836471, 5069.087564238435, 4780.737059461728, 4902.7058376497525, 4986.152354099811, 4989.800407983676, 4991.051700176973, 4957.380327459067, 4962.677425967318, 5030.421501527335, 5048.444671086178, 5053.039922414748, 4998.57512111471, 5013.172826483626, 5020.3724534433195, 5031.597472202215, 5032.094223039851, 4797.688150270256, 4855.5387238212315, 4880.731559764212, 4939.975300123477, 4953.281774142765, 5273.077211487975, 5287.312649355559, 5288.418273989858, 5290.470952904717, 5298.549623282026, 5803.738831752581, 5805.36141024487, 5814.651120932757, 5819.88360232793, 5837.708114594296, 5647.915281270784, 5675.34733505648, 5758.3090029196765, 5777.220075289824, 5880.323762767293, 5416.674999500004, 5416.83749487516, 5418.024755544, 5421.864453388657, 5445.727713614343, 5859.033259512218, 5876.970615146983, 5885.352611212763, 5887.793927212527, 5897.67562784051, 5565.526930210977, 5631.662100273997, 5649.4350564944, 5659.801906933238, 5661.037623603997, 5794.8551286217335, 5834.5624078194305, 5836.445537673914, 5843.328017277982, 5857.531397488191, 5781.942180578225, 5784.161296611967, 5787.074068149076, 5792.0, 5804.651720896675, 5651.321841378978, 5680.346760122638, 5761.107028410603, 5793.073108302651, 5846.678432686158, 4443.6667249955735, 4467.6202522785925, 4477.977610111929, 4482.484514280899, 4496.955030449653, 4039.7980100994832, 4045.3527435610163, 4046.2716710991717, 4067.8576249831112, 4077.959220407817, 5402.324709411324, 5422.783088676409, 5446.291982042309, 5470.9452905471235, 5564.276644036249, 5698.17376480408, 5703.372629010805, 5707.34365547959, 5711.857203569944, 5716.771329146871, 5424.647397919122, 5431.402545719968, 5446.809361672323, 5457.045017121988, 5463.071277882769, 4972.353594032753, 4980.9252861207115, 5019.974900125549, 5046.1926091825135, 5048.192289233779, 5946.0, 5967.940320596738, 5972.820815375546, 6006.789762358297, 6013.54898382623, 5678.574106941914, 5695.487406133468, 5842.766289348463, 5847.619904706181, 5853.64878107315, 6000.819975400745, 6001.579889407874, 6065.272167339947, 6068.332483426731, 6105.9084113737445, 5677.545796336366, 5732.7706891723865, 5762.222100016612, 5775.971120144372, 5789.652620842763, 5711.971440142939, 5821.126830975388, 5826.883462330815, 5858.091995740667, 5866.472017518444, 5689.34572524165, 5732.742026608896, 5739.426057394227, 5744.942550574608, 5745.511631511368, 5682.573806964577, 5690.260266165372, 5705.572082093942, 5716.742746576498, 5716.857078573069, 5433.5381492572, 5455.290812194389, 5503.091989821794, 5513.448655134454, 5646.983542962142, 5594.0769772987005, 5625.831225063254, 5641.435856414326, 5643.971780141073, 5696.088625819849, 5560.0, 5586.469285417878, 5595.804146854841, 5602.047651899105, 5603.80386686464], "unit": "score", "name": "dojo.html", "value": 5353.349275420467}, {"lowerIsBetter": false, "replicates": [559.8264537993223, 566.6005466146364, 577.3389469057928, 586.988260234795, 592.9229200203973, 41908.161836763284, 42228.788856055675, 42829.143417131636, 42839.78580107099, 42878.57121428785, 46215.30677039847, 46681.29978050332, 46885.0, 46898.0, 46969.5909122726, 9056.230220431255, 9194.35639505235, 9241.676541321056, 9251.25989920808, 9255.53722313885, 8914.465132092062, 9038.276937844958, 9044.23124034458, 9055.909440905572, 9099.590518426654, 8997.05530919254, 9065.22945549629, 9088.454692718426, 9102.180803727662, 9112.8633070504, 8943.731688049402, 8959.193672569467, 8971.147740964598, 8979.14698103679, 9091.63633454661, 8740.956295218546, 8901.510416927067, 8911.0, 8944.284457243404, 8967.820643587156, 40248.0, 40623.1875362494, 40653.18693626111, 40711.79644101761, 40738.38892416616, 3923.391874259494, 4243.215005224043, 4243.469566304212, 4430.667699922518, 4449.2213862574245, 31285.687143128733, 31547.369052619048, 31564.0, 31919.202019949455, 32514.349713005842, 4166.8749937501925, 4274.957250427487, 4338.891527711801, 4353.978230108829, 4364.2798938175165, 298025.0, 300459.0, 301142.0, 302338.0, 303022.9999999978, 44850.55149448529, 45371.54628453739, 45536.3169552457, 45739.0, 45752.0, 42821.0, 43229.78385108117, 43257.56742432535, 43265.0, 43321.0, 16314.592135196715, 16340.591485212964, 16517.091559964076, 16568.83431165697, 16602.916985414995, 11949.701257468632, 11954.880451195551, 11959.701007474883, 11985.460654270579, 12271.93864030692, 14928.40286388554, 14941.626459338604, 14999.475018374524, 15094.54716358511, 15140.772888406682, 5923.229980102559, 6085.786997455068, 6095.0, 6100.847478812976, 6164.969175154185, 1074.9677509674566, 1095.4358505369742, 1104.7514309280348, 1154.8970732950013, 1191.6603767926272, 29915.551266731018, 29992.700072998992, 30612.234694132378, 30637.38725225483, 31183.376332473224, 1163.2497039409534, 1269.504893091695, 1274.9609068609054, 1279.7824369857146, 1344.8655134486473, 15862.52412427629, 15933.681326373408, 15934.56588907004, 16243.269052892649, 16369.754453683205, 338653.0, 535170.0, 541320.0, 542024.0, 554904.0, 54602.0, 55528.0, 55529.722351388795, 55622.0, 55767.44232557704, 1460.8539146085518, 1475.1960181701, 1480.962975925589, 1486.457443033285, 1499.4601943300404, 32175.0, 32673.509897351083, 32909.50635740514, 32974.34051319008, 33810.49284260787, 49370.753146235475, 49836.75081624569, 49994.500054998985, 50239.24641130459, 50381.74809125931, 325132.0, 326081.0, 328034.0, 328767.0, 330562.0, 34390.48414273838, 34678.65321346754, 34694.0, 35114.47328290027, 35293.647063530065, 45921.54078459173, 46228.53771462242, 46794.0, 47459.05081898412, 47632.52367476281, 40853.59146408498, 42529.57470425256, 46241.76879115583, 46813.76593117149, 46992.7650361746, 39340.803295983336, 39719.205615886945, 39823.2035359297, 40263.79868100758, 40434.59565404426, 40887.795561022, 42039.7898010508, 42262.57737422586, 42320.941976450835, 42506.0, 29452.705472944996, 31963.680363196072, 32126.19684507906, 32332.676673232967, 32475.837620811744, 25969.74030259749, 28231.396050917778, 28730.0, 28977.0, 29460.55809162907], "unit": "score", "name": "ext.html", "value": 19537.564971659987}, {"lowerIsBetter": false, "replicates": [384.5404741334106, 385.98649047283334, 387.93405121129405, 393.1782574419463, 400.0798164222288, 15638.0, 16321.183940802943, 17422.82577174228, 19779.60440791185, 19819.900900495497, 10998.615048473304, 11623.941880290608, 11666.416679166028, 17413.73879391807, 17542.649147017084, 4889.26661000851, 5113.207452844806, 5275.577953763709, 5281.70950597717, 5779.913301300484, 5248.448912864152, 5468.26178465906, 5489.752961116739, 5490.313710786152, 5673.8581535461535, 5243.947560524384, 5449.863753406176, 5465.863353416176, 5494.478024587658, 5505.944940550603, 5289.259503669489, 5422.403535611099, 5432.483914028161, 5453.618246722731, 5497.505224529811, 5031.295618613397, 5279.498447647467, 5305.495977882095, 5311.256424100629, 5322.0, 13914.373853176632, 14021.158730476203, 14042.789358159636, 16339.754903676454, 21412.571748565097, 2211.347652442533, 2212.5021870079104, 2273.874936878471, 2302.9078836846506, 2391.0077317913046, 11153.330800152016, 13482.19106853592, 13788.241646709426, 13897.235652039133, 14030.1581905085, 1919.932802351911, 1927.421773467968, 1942.2134035715558, 1964.6070785842746, 1981.9504512387305, 59739.701301493646, 59796.40203597952, 61988.07017894735, 62247.377526225064, 62292.37707622911, 9776.608935642636, 9931.404115753077, 9981.999999999854, 10011.549480273405, 10193.541290641939, 12752.043596730282, 12812.42344094518, 12817.679558011125, 12877.098603097693, 12908.483660653657, 7885.487443316166, 7947.046354437389, 8091.109977902426, 8106.9594652027545, 8180.0, 7900.841983160304, 7928.4450088494405, 7939.325157361689, 7974.561399123104, 7994.2805147537, 4457.1308594823695, 4653.23221668421, 4696.084263568571, 4718.127146477913, 4771.785269662804, 1772.5036989642663, 1797.667431525146, 1857.4799056264267, 1876.1088482970479, 1912.3306842604977, 471.3966123362102, 489.2538878210757, 506.6099103690138, 960.851068084448, 1077.385890042668, 11073.390963496924, 11221.775564488664, 11337.206395552397, 11417.48621312043, 11501.36742479155, 496.99254511182363, 1005.8139244239838, 1009.8687170667913, 1032.4631191780231, 1034.255336157965, 9240.8613870792, 9765.853512197322, 10089.848652270222, 10572.788544229226, 10631.308964917256, 574835.0, 575518.0, 585811.0, 593773.0, 599255.0, 74418.0, 75644.0, 75754.0, 77423.0, 79521.60239198768, 1221.9389030548436, 1232.303748382179, 1235.7960936445386, 1242.5588915934893, 1251.3492983648453, 14872.33074511628, 16006.839931600534, 16181.59546011359, 16225.918870405572, 16284.674306513567, 30755.0, 32377.838110809294, 32491.512627310138, 34373.31253374968, 34679.306413871076, 39027.21945561016, 41462.378064328455, 44787.55212447834, 45903.3114503276, 48220.0, 7338.082739657543, 7552.358049565629, 7596.202398748273, 7601.885971710318, 7912.525248485109, 11021.0, 11022.724431889266, 11133.332000080021, 11264.887351126712, 11851.466683999068, 9557.23542116643, 9861.753456163653, 10041.748956276151, 10232.437215953194, 10360.119389851947, 9835.508224588599, 10092.949535252277, 10154.644587439405, 10302.175825934057, 10495.265331426726, 8245.546494942595, 9665.806683866424, 10152.796944061225, 10506.369617822955, 10605.946970265099, 7692.884606731015, 7997.920020799717, 8010.559419231999, 8017.198280171936, 8064.435489515678, 10226.28416010872, 10430.634927777492, 10506.737331566466, 10672.733181670521, 10756.139508839431], "unit": "score", "name": "jquery.html", "value": 8289.16099366947}, {"lowerIsBetter": false, "replicates": [1482.384810303724, 1502.1587910769967, 1739.521631551324, 1857.414914301994, 1926.2198809482165, 7401.740939067134, 7515.887261691066, 7928.3260922821555, 8044.557549334784, 8123.471974321672, 7805.687772489107, 7959.243871832181, 8014.078380986189, 8019.198080191978, 8102.756917292476, 2420.9636855447184, 2454.5090981803623, 2457.741937096606, 2461.7415171406924, 2462.741412151725, 2418.5592282932616, 2491.402063504764, 2496.500699860035, 2506.285708573057, 2519.5590771614984, 2414.3722632115687, 2422.903083876643, 2427.7329493755674, 2428.7935525480357, 2443.6823212982285, 2448.020791683332, 2450.3629056445366, 2470.28361775085, 2478.0707234786955, 2479.851208927461, 2505.912293069752, 2510.811689123323, 2530.671012768328, 2532.430203204283, 2546.261584140597, 8136.02367715872, 8158.347332213409, 8163.0612479564425, 8188.0, 8194.344452443791, 5029.773660185264, 5078.13671675816, 5161.864389834231, 5188.092083885305, 5189.558887494568, 3094.5667606535103, 3271.7219036381935, 3281.2125089978235, 3283.097148284241, 3293.7859039162377, 1086.3427626286061, 1088.9945550272278, 1163.7905177068124, 1164.7554013657143, 1198.922070065443, 11616.128790340757, 11772.823407648892, 11794.233374830608, 11838.112141589329, 11858.881411185865, 4676.392069031004, 4701.2478003519955, 4752.786124624331, 4812.663113582015, 4822.927656085161, 10204.183665306758, 10214.591416343412, 10221.795564088676, 10226.53980570876, 10248.38509689421, 5261.684298941999, 5292.92060619091, 5314.574834013347, 5346.0, 5357.0, 4780.49804770501, 4809.134355815987, 4832.420109586802, 4859.489753575824, 4878.414590249193, 3968.444417781513, 3982.2433737590345, 3992.540857801332, 4040.8383664653084, 4045.5145382554283, 1268.4101892619792, 1278.1244847279643, 1286.0933042205222, 1292.7414517096618, 1303.0, 1425.8930580206527, 1444.4077928049448, 1464.699736554004, 1469.1772607339924, 1498.2059508460534, 7785.805354866174, 7870.645820938072, 7890.132085470594, 7922.168172341936, 7956.085050219183, 531.7394476706386, 531.9388270348959, 533.1549494051972, 542.9647072940326, 554.4400155842548, 5893.499052580579, 5895.64626122434, 5945.316288626776, 5948.910766338508, 6004.579679422486, 9541.761455963657, 9642.035796420441, 9675.935647078815, 9779.608815647436, 9800.166985806287, 9488.715338539854, 9591.760205994906, 9603.567839447102, 9664.0, 9723.222142228746, 7698.730544430918, 7754.9224507755325, 7778.611069446505, 7787.766367008999, 7791.883121753178, 7756.418268629763, 7782.571958542108, 7816.335611473089, 7838.372930165687, 7896.802579935547, 8870.955645221991, 9093.954530227307, 9099.0, 9208.49353285549, 9295.628174872929, 8685.305175585812, 8874.733757987271, 9421.104995025462, 9474.668386606436, 9528.475933823705, 7278.563286202845, 7279.526830755984, 7358.632068396666, 7383.963080184565, 7394.260573942563, 7578.052743407075, 7653.808654783675, 7780.961095194488, 7794.415418843496, 7810.101838288442, 7189.1013623297085, 7346.0, 7457.142428620561, 7503.09962804467, 7611.314981651456, 7264.34620884123, 7295.161056478573, 7406.259374062766, 7441.590712510864, 7455.291747283999, 7325.974363589208, 7466.514676546007, 7471.738489152854, 7488.101427828696, 7496.362809161283, 6879.415249703631, 6909.378155965987, 6910.343517365842, 6917.619530925847, 6940.375366217065, 6497.675116244263, 6525.3800888915475, 6558.147440832661, 6594.670266486753, 6763.830904227434], "unit": "score", "name": "mootools.html", "value": 4738.849435117726}, {"lowerIsBetter": false, "replicates": [365.37885594489364, 373.7682636765204, 374.5262243262275, 377.40181811828245, 378.40968089779943, 6305.779297724581, 6337.524685648572, 6342.714577843996, 6404.871902561946, 6480.0, 6324.3991820776955, 6325.746970121189, 6363.109164716943, 6366.172397588319, 6373.0, 4884.267359896008, 4889.071076495472, 4891.461939186686, 4893.388326459192, 4903.9754801225945, 4889.413270407538, 4899.534544218312, 4900.019996000797, 4900.7794649240695, 4916.680415772981, 4675.041616468616, 4713.670043096985, 4768.546988036131, 4774.9761251193695, 4843.39457567804, 4788.856334309976, 4804.063207674522, 4814.10938976287, 4816.349792777965, 4823.107725070873, 4207.600277973618, 4222.493300803892, 4222.683298752606, 4224.112936283384, 4252.043290259698, 5974.37269086744, 5975.25309336333, 5983.521318294526, 5993.190919225893, 5998.340182579913, 5598.1322894950945, 5620.072688006474, 5698.0, 5715.428457154293, 5725.112607545795, 6625.469962402996, 6668.733250670016, 6725.125733654642, 6732.2257940336995, 6744.156980377453, 4717.693349932243, 4718.292256161569, 4719.95280047202, 4722.126406614753, 4737.170995075882, 6894.896576551356, 6966.442684585221, 7014.859702805967, 7039.366457018893, 7054.823629409255, 4822.9758851205515, 4827.131116399082, 4842.685225460334, 4847.660663753503, 4852.56326930578, 4903.387076615423, 4905.901881962341, 4910.042541704333, 4922.187839006524, 4929.433115191799, 5626.071698169838, 5644.491995720323, 5653.462921022497, 5657.189699296268, 5673.149027645886, 6719.697613607399, 6800.625965571842, 6823.965880170666, 6824.317568243136, 6827.249002609709, 1716.1076240354946, 1734.167599552222, 1735.0977491704496, 1738.721804511272, 1739.199968014702, 1143.3711458697849, 1162.1574358589955, 1163.5404015413865, 1164.5050853387277, 1171.8710941796396, 6501.1548498694865, 6503.674816259168, 6507.3167317431935, 6555.311692272338, 6563.146790917151, 6958.756443524554, 6973.4072603829245, 6997.4052205562075, 7017.193022802443, 7024.578525288499, 6372.203474565679, 6513.348665133449, 6516.57642253252, 6562.639054851934, 6639.070530125786, 3799.848006079781, 3818.4845045919, 3836.07934095815, 3837.76973381598, 3845.7115716321387, 7280.41756659466, 7284.235155308616, 7349.522281051714, 7350.823868181065, 7359.6688149033425, 7130.643467826588, 7291.598962057032, 7293.489455738048, 7300.926990730131, 7318.63406829667, 7294.489385743053, 7311.305425984523, 7317.707291708272, 7327.560346379234, 7330.5968171751065, 6932.272111428228, 7028.297170282931, 7060.43516518667, 7073.0, 7073.504854660125, 6886.345797149263, 6944.166699996033, 6944.756933507303, 6993.160820701549, 6995.510314277952, 7309.232530584212, 7309.963450182928, 7312.1591017033725, 7318.524295920748, 7342.9632851835395, 4821.831235906727, 4839.564439200489, 4853.854384368475, 4868.294097355934, 4884.804607815648, 6857.828554286183, 7088.255733147946, 7106.502544821813, 7110.288971102848, 7135.822589272711, 6892.586444813327, 6901.413379862768, 6908.585484870924, 6910.896336554855, 6917.342852429011, 6742.595444273163, 6837.794866154023, 6850.520463567702, 6865.725370985105, 6874.4844136690945, 6753.662316884234, 6791.558548694319, 6806.285340039224, 6838.316168383122, 6858.691358888762, 6871.072405225231, 6929.618870962146, 6936.0636314096955, 6969.0, 6990.825229369307, 6598.505112116514, 6637.70130344126, 6698.263191049078, 6702.966485167738, 6718.697658605277], "unit": "score", "name": "prototype.html", "value": 5139.925247974498}, {"lowerIsBetter": false, "replicates": [808.316972158526, 906.8960012770374, 946.5740416812436, 952.6237136331149, 953.5613617735842, 13902.443902243911, 13963.301834908265, 14046.016778825498, 14083.225422601752, 14141.292935353242, 13810.861891381082, 13837.446502139928, 13862.861371386283, 13871.583852484442, 13873.306334683275, 757.303280981497, 771.3713323641242, 873.057098333798, 890.8930928288614, 897.5512243878061, 898.0525545549443, 899.7615631857562, 900.2348004196446, 902.6975963052386, 903.832790933676, 944.0795224655974, 949.4398305000049, 951.4243882451121, 954.0793134625086, 954.5942974235957, 937.6765016069445, 937.8640097185904, 938.5494962418044, 943.7216021273741, 943.9622415103388, 698.0889938630086, 699.1784653032666, 701.9017337572744, 704.7322017633318, 705.2559549675091, 13890.0, 13933.512327068605, 13982.510612128628, 14011.29943502831, 14011.64970875726, 13659.590212293648, 13864.930675346659, 13961.162330260115, 13979.0, 14225.715485690229, 11310.886891131147, 11386.71533211668, 11444.599439019677, 11536.711582210428, 11838.822417663741, 3868.6518213360932, 3909.7263191576603, 3943.743656662308, 3946.1515774108416, 3976.264391087658, 49461.0, 49791.75104124493, 49979.500204998214, 50029.24956125661, 50077.49922500765, 11171.83242251367, 11360.147988900866, 11439.428028598537, 11566.94216528912, 11595.652130436101, 19239.615207695766, 19536.21855125779, 19696.0, 19740.309089182098, 20154.59690806205, 7902.24928631779, 8386.161383861687, 8442.957785211034, 8543.487390756574, 8620.784480387914, 4629.0, 4692.0, 4697.882552936136, 4830.106430310404, 4848.248521479177, 3169.8098114113227, 3182.331710340808, 3213.212762873064, 3236.7896086754286, 3261.5270785735934, 604.5103466192398, 609.2080295615682, 609.8322961185621, 610.764855530615, 613.6563524426335, 568.7554351628839, 629.1412222316596, 643.5784561112479, 695.2838576266454, 728.613834667627, 8593.957030214933, 8891.19979201875, 8931.285497160212, 8997.820043599091, 9062.229710474552, 646.4763541531374, 692.5463821197123, 711.839836036898, 761.7181642792092, 806.3911746631256, 4807.95192048075, 4934.802607895644, 5021.874453138701, 5045.117104506697, 5130.204818253177, 61043.6947815267, 61251.38748612457, 61765.691171543855, 61800.69099654563, 61922.0711689325, 55784.16323755147, 55908.16137757937, 56804.0, 57037.42962570404, 57179.42820571824, 50503.0, 51630.67661955221, 52167.478325217024, 52187.73906130445, 52349.0, 9928.313802960201, 10029.398236105857, 10051.145652619609, 10208.540615672164, 10219.058378907983, 36087.819560902026, 36110.638893610725, 36172.63827361798, 37104.25791484209, 37755.43366849554, 46069.76965115153, 49820.50179498159, 50172.996540069726, 50412.49587504078, 50637.0, 11800.291982481078, 12107.75784484323, 12169.391530423267, 12259.754804903674, 12351.505939762668, 13227.470901163846, 13440.327983600586, 13564.86435135636, 13617.659558511117, 13889.0, 12409.317487538272, 12614.180078294881, 12839.101262911507, 12896.161749486253, 12976.8053479196, 12801.167924084904, 12949.482020719066, 13006.934965325112, 13040.217586944813, 13080.672983175116, 12464.68838279014, 12523.248605083723, 12838.42227099764, 12982.545610903573, 13026.54407095785, 10281.485925703535, 10380.584776608852, 10500.212484063879, 10646.787064258826, 10755.129457137828, 10581.523831427758, 10979.17656175774, 11005.394703291076, 11016.741567978705, 11187.944060279646], "unit": "score", "name": "yui.html", "value": 6924.703851163419}], "name": "dromaeo_css", "value": 7258.477211678096}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 110.0, 111.0, 121.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [145.0, 125.0, 152.0, 159.0, 128.0, 155.0, 153.0, 127.0, 167.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 162.0, 168.0, 163.0, 161.0, 161.0, 162.0, 164.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 74.0, 155.0, 73.0, 74.0, 75.0, 74.0, 154.0, 74.0], "unit": "score", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 93.0, 95.0, 94.0, 144.0, 95.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 56.0, 54.0, 55.0, 56.0, 57.0, 65.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 71.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 83.0, 82.0, 83.0, 82.0, 81.0, 89.0, 81.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [110.0, 113.0, 121.0, 115.0, 114.0, 114.0, 118.0, 112.0, 110.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.7}, {"lowerIsBetter": true, "replicates": [130.0, 139.0, 140.0, 147.0, 130.0, 127.0, 128.0, 140.0, 151.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.0}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1488.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [170.01020061203673], "unit": "score", "name": "DeltaBlue", "value": 388.9060759999999}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [902.5270758122743], "unit": "score", "name": "RayTrace", "value": 819.9078120000003}, {"lowerIsBetter": false, "replicates": [563.3802816901408], "unit": "score", "name": "Earley", "value": 1182.9718249999999}, {"lowerIsBetter": false, "replicates": [11122.222222222223], "unit": "score", "name": "Boyer", "value": 59.92174825174829}, {"lowerIsBetter": false, "replicates": [38830.188679245286], "unit": "score", "name": "RegExp", "value": 23.460741010689976}, {"lowerIsBetter": false, "replicates": [516.2622612287042], "unit": "score", "name": "Splay", "value": 157.84806699999996}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 22095.98240170402}]} 09:37:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22095.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1488.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7258.48"}}} 09:37:57 INFO - Return code: 0 09:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:37:57 INFO - # TBPL SUCCESS # 09:37:57 INFO - Running post-action listener: _resource_record_post_action 09:37:57 INFO - Running post-run listener: _resource_record_post_run 09:37:58 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 278528; Write bytes: 502198272; Read time: 260; Write time: 446600 09:37:58 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 12288; Write bytes: 242659328; Read time: 228; Write time: 281392 09:37:58 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 259538944; Read time: 32; Write time: 165208 09:37:58 INFO - Running post-run listener: _upload_blobber_files 09:37:58 INFO - Blob upload gear active. 09:37:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:37:58 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 09:37:58 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 09:37:58 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 09:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:59 INFO - (blobuploader) - INFO - Done attempting. 09:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:38:00 INFO - (blobuploader) - INFO - Done attempting. 09:38:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:38:00 INFO - Return code: 0 09:38:00 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:38:00 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:38:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b16a83db6349fbdc6fd118189dd815e14771abb9a9ad7c8aa0b0691e9ce3ce6ff08cb2eb7fc851435f15cb91e95af4e6ff3bf0a604f68d699cf5a1d113707d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3c82c769a455829201c4892c1892daba4a6a78b513beba6248f143fd825a58fdb6a327d406a7bebec73fa28652900045f5d486baf11065ce3a9520d780ad1"} 09:38:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:38:00 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:38:00 INFO - Contents: 09:38:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b16a83db6349fbdc6fd118189dd815e14771abb9a9ad7c8aa0b0691e9ce3ce6ff08cb2eb7fc851435f15cb91e95af4e6ff3bf0a604f68d699cf5a1d113707d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3c82c769a455829201c4892c1892daba4a6a78b513beba6248f143fd825a58fdb6a327d406a7bebec73fa28652900045f5d486baf11065ce3a9520d780ad1"} 09:38:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:38:00 INFO - Copying logs to upload dir... 09:38:00 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:38:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.453296 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-22 09:38:00.153559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 09:38:00.157659) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b16a83db6349fbdc6fd118189dd815e14771abb9a9ad7c8aa0b0691e9ce3ce6ff08cb2eb7fc851435f15cb91e95af4e6ff3bf0a604f68d699cf5a1d113707d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3c82c769a455829201c4892c1892daba4a6a78b513beba6248f143fd825a58fdb6a327d406a7bebec73fa28652900045f5d486baf11065ce3a9520d780ad1"} build_url:https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/XB7nNqN-TAyLxLe1Mu65RQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2b16a83db6349fbdc6fd118189dd815e14771abb9a9ad7c8aa0b0691e9ce3ce6ff08cb2eb7fc851435f15cb91e95af4e6ff3bf0a604f68d699cf5a1d113707d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffb3c82c769a455829201c4892c1892daba4a6a78b513beba6248f143fd825a58fdb6a327d406a7bebec73fa28652900045f5d486baf11065ce3a9520d780ad1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 09:38:00.182733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:38:00.183058) ========= 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=82e07478c745e68b1fe4678a000001bc-1456160918.548491-375420226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 09:38:00.266126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 09:38:00.266445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 09:38:00.266778) ========= ========= Total master_lag: 19.13 =========