builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1451260464.79 results: success (0) buildid: 20151227133005 builduid: 3b567f5e51b144c2b21dd0cf8dfdc24d revision: f96142e950e08c82b0d6f0f87b95ec58fcd06ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.795556) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.796312) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.796773) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006325 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.864917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.865246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.949597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.949929) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026354 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:24.999962) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.000319) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.000740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.001111) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-27 15:54:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2015-12-27 15:54:25 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.155405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.155737) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035176 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.206659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.207037) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f96142e950e08c82b0d6f0f87b95ec58fcd06ea7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f96142e950e08c82b0d6f0f87b95ec58fcd06ea7 --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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-27 15:54:25,390 truncating revision to first 12 chars 2015-12-27 15:54:25,390 Setting DEBUG logging. 2015-12-27 15:54:25,390 attempt 1/10 2015-12-27 15:54:25,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f96142e950e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-27 15:54:25,741 unpacking tar archive at: mozilla-inbound-f96142e950e0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.868276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.868575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.883897) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.884201) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-27 15:54:25.884597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-27 15:54:25.884915) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:26 INFO - MultiFileLogger online at 20151227 15:54:26 in /builds/slave/test-pgo 15:54:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:54:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:54:26 INFO - {'append_to_log': False, 15:54:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:54:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:54:26 INFO - 'branch': 'Mozilla-Inbound', 15:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:26 INFO - 'config_files': ('talos/linux_config.py',), 15:54:26 INFO - 'default_actions': ('clobber', 15:54:26 INFO - 'read-buildbot-config', 15:54:26 INFO - 'download-and-extract', 15:54:26 INFO - 'populate-webroot', 15:54:26 INFO - 'create-virtualenv', 15:54:26 INFO - 'install', 15:54:26 INFO - 'run-tests'), 15:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:26 INFO - 'download_minidump_stackwalk': True, 15:54:26 INFO - 'download_symbols': 'ondemand', 15:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:26 INFO - 'installer_path': 'installer.exe', 15:54:26 INFO - 'log_level': 'info', 15:54:26 INFO - 'log_name': 'talos', 15:54:26 INFO - 'log_to_console': True, 15:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:26 INFO - 'opt_config_files': (), 15:54:26 INFO - 'pip_index': False, 15:54:26 INFO - 'sps_profile': False, 15:54:26 INFO - 'sps_profile_interval': 0, 15:54:26 INFO - 'suite': 'dromaeojs-e10s', 15:54:26 INFO - 'system_bits': '64', 15:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:26 INFO - 'title': 'talos-linux64-ix-062', 15:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:26 INFO - 'use_talos_json': True, 15:54:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:26 INFO - 'work_dir': 'build'} 15:54:26 INFO - ##### 15:54:26 INFO - ##### Running clobber step. 15:54:26 INFO - ##### 15:54:26 INFO - Running pre-action listener: _resource_record_pre_action 15:54:26 INFO - Running main action method: clobber 15:54:26 INFO - rmtree: /builds/slave/test-pgo/build 15:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:54:27 INFO - Running post-action listener: _resource_record_post_action 15:54:27 INFO - ##### 15:54:27 INFO - ##### Running read-buildbot-config step. 15:54:27 INFO - ##### 15:54:27 INFO - Running pre-action listener: _resource_record_pre_action 15:54:27 INFO - Running main action method: read_buildbot_config 15:54:27 INFO - Using buildbot properties: 15:54:27 INFO - { 15:54:27 INFO - "project": "", 15:54:27 INFO - "product": "firefox", 15:54:27 INFO - "script_repo_revision": "production", 15:54:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:54:27 INFO - "repository": "", 15:54:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:54:27 INFO - "buildid": "20151227133005", 15:54:27 INFO - "pgo_build": "True", 15:54:27 INFO - "basedir": "/builds/slave/test-pgo", 15:54:27 INFO - "buildnumber": 558, 15:54:27 INFO - "slavename": "talos-linux64-ix-062", 15:54:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:54:27 INFO - "platform": "ubuntu64_hw", 15:54:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:54:27 INFO - "branch": "mozilla-inbound", 15:54:27 INFO - "repo_path": "integration/mozilla-inbound", 15:54:27 INFO - "revision": "f96142e950e08c82b0d6f0f87b95ec58fcd06ea7", 15:54:27 INFO - "stage_platform": "linux64-pgo", 15:54:27 INFO - "builduid": "3b567f5e51b144c2b21dd0cf8dfdc24d", 15:54:27 INFO - "slavebuilddir": "test" 15:54:27 INFO - } 15:54:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:54:27 INFO - Running post-action listener: _resource_record_post_action 15:54:27 INFO - ##### 15:54:27 INFO - ##### Running download-and-extract step. 15:54:27 INFO - ##### 15:54:27 INFO - Running pre-action listener: _resource_record_pre_action 15:54:27 INFO - Running main action method: download_and_extract 15:54:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:54:27 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')]} 15:54:27 INFO - https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/test_packages.json 15:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/test_packages.json 15:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:54:29 INFO - Downloaded 1302 bytes. 15:54:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:54:29 INFO - Using the following test package requirements: 15:54:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'jsshell-linux-x86_64.zip'], 15:54:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:54:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:54:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54:29 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')]} 15:54:29 INFO - https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:30 INFO - Downloaded 23192738 bytes. 15:54:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:54:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:54:31 INFO - Return code: 0 15:54:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:54:31 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')]} 15:54:31 INFO - https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:32 INFO - Downloaded 23192738 bytes. 15:54:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:54:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:54:33 INFO - Return code: 0 15:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:33 INFO - https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:35 INFO - Downloaded 11132270 bytes. 15:54:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:54:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:54:36 INFO - Return code: 0 15:54:36 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')]} 15:54:36 INFO - https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:54:39 INFO - Downloaded 54923263 bytes. 15:54:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:54:39 INFO - mkdir: /builds/slave/test-pgo/properties 15:54:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:54:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:54:39 INFO - Contents: 15:54:39 INFO - build_url:https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:54:39 INFO - Running post-action listener: _resource_record_post_action 15:54:39 INFO - Running post-action listener: set_extra_try_arguments 15:54:39 INFO - ##### 15:54:39 INFO - ##### Running populate-webroot step. 15:54:39 INFO - ##### 15:54:39 INFO - Running pre-action listener: _resource_record_pre_action 15:54:39 INFO - Running main action method: populate_webroot 15:54:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:39 INFO - '--tppagecycles', 15:54:39 INFO - '7'], 15:54:39 INFO - 'tests': ['tsvgm']}}, 15:54:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:54:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:54:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:54:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['damp', 'tps']}, 15:54:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['damp', 'tps']}, 15:54:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:54:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:39 INFO - 'other': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'other_l64': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore']}, 15:54:39 INFO - 'svgr': {'tests': ['tsvgx', 15:54:39 INFO - 'tsvgr_opacity', 15:54:39 INFO - 'tart', 15:54:39 INFO - 'tscrollx', 15:54:39 INFO - 'cart']}, 15:54:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tsvgx', 15:54:39 INFO - 'tsvgr_opacity', 15:54:39 INFO - 'tart', 15:54:39 INFO - 'tscrollx', 15:54:39 INFO - 'cart']}, 15:54:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['tp5o']}, 15:54:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tp5o']}, 15:54:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--xperf_path', 15:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:39 INFO - 'tests': ['tp5n']}, 15:54:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s', 15:54:39 INFO - '--xperf_path', 15:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:39 INFO - 'tests': ['tp5n']}}, 15:54:39 INFO - 'talos.zip': {'path': '', 15:54:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:39 INFO - Running post-action listener: _resource_record_post_action 15:54:39 INFO - ##### 15:54:39 INFO - ##### Running create-virtualenv step. 15:54:39 INFO - ##### 15:54:39 INFO - Running pre-action listener: _resource_record_pre_action 15:54:39 INFO - Running main action method: create_virtualenv 15:54:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:54:39 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 15:54:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:54:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:39 INFO - Using real prefix '/usr' 15:54:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:54:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:41 INFO - Installing pip.................done. 15:54:41 INFO - Return code: 0 15:54:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:54:41 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')]} 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 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')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:41 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 15:54:41 INFO - Cleaning up... 15:54:41 INFO - Return code: 0 15:54:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:54:41 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')]} 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 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')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:42 INFO - Downloading/unpacking psutil>=0.7.1 15:54:42 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 15:54:42 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 15:54:42 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 15:54:42 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 15:54:42 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 15:54:42 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 15:54:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:54:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:54:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:43 INFO - Installing collected packages: psutil 15:54:43 INFO - Running setup.py install for psutil 15:54:44 INFO - building 'psutil._psutil_linux' extension 15:54:44 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 15:54:44 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 15:54:44 INFO - building 'psutil._psutil_posix' extension 15:54:44 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 15:54:44 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 15:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:44 INFO - Successfully installed psutil 15:54:44 INFO - Cleaning up... 15:54:44 INFO - Return code: 0 15:54:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:54:44 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')]} 15:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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')]} 15:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:44 INFO - Using env: {'DISPLAY': ':0', 15:54:44 INFO - 'HOME': '/home/cltbld', 15:54:44 INFO - 'LANG': 'en_US.UTF-8', 15:54:44 INFO - 'LANGUAGE': 'en_US:en', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MAIL': '/var/mail/cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SHLVL': '1', 15:54:44 INFO - 'TERM': 'linux', 15:54:44 INFO - 'TMOUT': '86400', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - '_': '/tools/buildbot/bin/python'} 15:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:54:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:54:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:54:46 INFO - Installing collected packages: mozsystemmonitor 15:54:46 INFO - Running setup.py install for mozsystemmonitor 15:54:46 INFO - Successfully installed mozsystemmonitor 15:54:46 INFO - Cleaning up... 15:54:46 INFO - Return code: 0 15:54:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:54: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')]} 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:46 INFO - Using env: {'DISPLAY': ':0', 15:54:46 INFO - 'HOME': '/home/cltbld', 15:54:46 INFO - 'LANG': 'en_US.UTF-8', 15:54:46 INFO - 'LANGUAGE': 'en_US:en', 15:54:46 INFO - 'LOGNAME': 'cltbld', 15:54:46 INFO - 'MAIL': '/var/mail/cltbld', 15:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:46 INFO - 'MOZ_NO_REMOTE': '1', 15:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:46 INFO - 'NO_EM_RESTART': '1', 15:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:46 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:46 INFO - 'SHELL': '/bin/bash', 15:54:46 INFO - 'SHLVL': '1', 15:54:46 INFO - 'TERM': 'linux', 15:54:46 INFO - 'TMOUT': '86400', 15:54:46 INFO - 'USER': 'cltbld', 15:54:46 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:46 INFO - '_': '/tools/buildbot/bin/python'} 15:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:54:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:54:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:49 INFO - Downloading docopt-0.6.1.tar.gz 15:54:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:49 INFO - Running setup.py install for blobuploader 15:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:54:49 INFO - Running setup.py install for requests 15:54:49 INFO - Running setup.py install for docopt 15:54:49 INFO - Successfully installed blobuploader requests docopt 15:54:49 INFO - Cleaning up... 15:54:49 INFO - Return code: 0 15:54:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:49 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')]} 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:49 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')]} 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:49 INFO - Using env: {'DISPLAY': ':0', 15:54:49 INFO - 'HOME': '/home/cltbld', 15:54:49 INFO - 'LANG': 'en_US.UTF-8', 15:54:49 INFO - 'LANGUAGE': 'en_US:en', 15:54:49 INFO - 'LOGNAME': 'cltbld', 15:54:49 INFO - 'MAIL': '/var/mail/cltbld', 15:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:49 INFO - 'MOZ_NO_REMOTE': '1', 15:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:49 INFO - 'NO_EM_RESTART': '1', 15:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:49 INFO - 'SHELL': '/bin/bash', 15:54:49 INFO - 'SHLVL': '1', 15:54:49 INFO - 'TERM': 'linux', 15:54:49 INFO - 'TMOUT': '86400', 15:54:49 INFO - 'USER': 'cltbld', 15:54:49 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:49 INFO - '_': '/tools/buildbot/bin/python'} 15:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:50 INFO - Running setup.py (path:/tmp/pip-ms_YIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:50 INFO - Running setup.py (path:/tmp/pip-UcUlx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:50 INFO - Running setup.py (path:/tmp/pip-dUqZ_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:50 INFO - Running setup.py (path:/tmp/pip-_FmAlc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:50 INFO - Running setup.py (path:/tmp/pip-zfUTLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:50 INFO - Running setup.py (path:/tmp/pip-AawDVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:50 INFO - Running setup.py (path:/tmp/pip-5lr1F4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:50 INFO - Running setup.py (path:/tmp/pip-Ytvnnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:50 INFO - Running setup.py (path:/tmp/pip-oRllLL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:50 INFO - Running setup.py (path:/tmp/pip-3hSFFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:50 INFO - Running setup.py (path:/tmp/pip-tNZsuD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:50 INFO - Running setup.py (path:/tmp/pip-3kukak-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:50 INFO - Running setup.py (path:/tmp/pip-VInBCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:50 INFO - Running setup.py (path:/tmp/pip-6NxfJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Running setup.py (path:/tmp/pip-y7MHWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:51 INFO - Running setup.py (path:/tmp/pip-OCD9G0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:51 INFO - Running setup.py (path:/tmp/pip-8GzPau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:51 INFO - Running setup.py install for manifestparser 15:54:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:54:51 INFO - Running setup.py install for mozcrash 15:54:51 INFO - Running setup.py install for mozdebug 15:54:51 INFO - Running setup.py install for mozdevice 15:54:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:54:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:54:51 INFO - Running setup.py install for mozfile 15:54:51 INFO - Running setup.py install for mozhttpd 15:54:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:54:51 INFO - Running setup.py install for mozinfo 15:54:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:54:51 INFO - Running setup.py install for mozInstall 15:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozleak 15:54:52 INFO - Running setup.py install for mozlog 15:54:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for moznetwork 15:54:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozprocess 15:54:52 INFO - Running setup.py install for mozprofile 15:54:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozrunner 15:54:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozscreenshot 15:54:52 INFO - Running setup.py install for moztest 15:54:52 INFO - Running setup.py install for mozversion 15:54:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:53 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')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 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')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:53 INFO - Using env: {'DISPLAY': ':0', 15:54:53 INFO - 'HOME': '/home/cltbld', 15:54:53 INFO - 'LANG': 'en_US.UTF-8', 15:54:53 INFO - 'LANGUAGE': 'en_US:en', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MAIL': '/var/mail/cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SHLVL': '1', 15:54:53 INFO - 'TERM': 'linux', 15:54:53 INFO - 'TMOUT': '86400', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - '_': '/tools/buildbot/bin/python'} 15:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:53 INFO - Running setup.py (path:/tmp/pip-AMUyj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:53 INFO - Running setup.py (path:/tmp/pip-wfn0Lz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:53 INFO - Running setup.py (path:/tmp/pip-AKvWTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:53 INFO - Running setup.py (path:/tmp/pip-6lP7Mq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:53 INFO - Running setup.py (path:/tmp/pip-TTpotU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:53 INFO - Running setup.py (path:/tmp/pip-c6agaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:53 INFO - Running setup.py (path:/tmp/pip-NMCRDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:53 INFO - Running setup.py (path:/tmp/pip-W66j0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:53 INFO - Running setup.py (path:/tmp/pip-WbglKT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:53 INFO - Running setup.py (path:/tmp/pip-Nomuip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:53 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)) 15:54:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:53 INFO - Running setup.py (path:/tmp/pip-ISLZ4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:54 INFO - Running setup.py (path:/tmp/pip-G0XL3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:54 INFO - Running setup.py (path:/tmp/pip-sDYbTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:54 INFO - Running setup.py (path:/tmp/pip-A0_MRw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:54 INFO - Running setup.py (path:/tmp/pip-VxBd8j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:54 INFO - Running setup.py (path:/tmp/pip-8rPocb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:54 INFO - Running setup.py (path:/tmp/pip-KPjaTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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)) 15:54:54 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:54 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:54 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 15:54:56 INFO - Downloading blessings-1.5.1.tar.gz 15:54:56 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:54:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:56 INFO - Installing collected packages: blessings 15:54:56 INFO - Running setup.py install for blessings 15:54:56 INFO - Successfully installed blessings 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:54:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:54:56 INFO - Reading from file tmpfile_stdout 15:54:56 INFO - Current package versions: 15:54:56 INFO - argparse == 1.2.1 15:54:56 INFO - blessings == 1.5.1 15:54:56 INFO - blobuploader == 1.2.4 15:54:56 INFO - docopt == 0.6.1 15:54:56 INFO - manifestparser == 1.1 15:54:56 INFO - mozInstall == 1.12 15:54:56 INFO - mozcrash == 0.16 15:54:56 INFO - mozdebug == 0.1 15:54:56 INFO - mozdevice == 0.47 15:54:56 INFO - mozfile == 1.2 15:54:56 INFO - mozhttpd == 0.7 15:54:56 INFO - mozinfo == 0.9 15:54:56 INFO - mozleak == 0.1 15:54:56 INFO - mozlog == 3.1 15:54:56 INFO - moznetwork == 0.27 15:54:56 INFO - mozprocess == 0.22 15:54:56 INFO - mozprofile == 0.28 15:54:56 INFO - mozrunner == 6.11 15:54:56 INFO - mozscreenshot == 0.1 15:54:56 INFO - mozsystemmonitor == 0.0 15:54:56 INFO - moztest == 0.7 15:54:56 INFO - mozversion == 1.4 15:54:56 INFO - psutil == 3.1.1 15:54:56 INFO - requests == 1.2.3 15:54:56 INFO - wsgiref == 0.1.2 15:54:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:56 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')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 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)) 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:54:56 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')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:57 INFO - Downloading/unpacking jsonschema 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:54:58 INFO - Downloading/unpacking functools32 (from jsonschema) 15:54:58 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 15:54:58 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 15:54:58 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 15:54:58 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 15:54:58 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 15:54:58 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 15:54:58 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:54:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:58 INFO - warning: no files found matching '*.txt' 15:54:58 INFO - no previously-included directories found matching 'build' 15:54:58 INFO - no previously-included directories found matching 'dist' 15:54:58 INFO - no previously-included directories found matching '.git*' 15:54:59 INFO - Installing collected packages: jsonschema, functools32 15:54:59 INFO - Running setup.py install for functools32 15:54:59 INFO - warning: no files found matching '*.txt' 15:54:59 INFO - no previously-included directories found matching 'build' 15:54:59 INFO - no previously-included directories found matching 'dist' 15:54:59 INFO - no previously-included directories found matching '.git*' 15:54:59 INFO - Successfully installed jsonschema functools32 15:54:59 INFO - Cleaning up... 15:54:59 INFO - Return code: 0 15:54:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:54: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')]} 15:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f482643df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', '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 15:54:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 15:54:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 15:54:59 INFO - Using env: {'DISPLAY': ':0', 15:54:59 INFO - 'HOME': '/home/cltbld', 15:54:59 INFO - 'LANG': 'en_US.UTF-8', 15:54:59 INFO - 'LANGUAGE': 'en_US:en', 15:54:59 INFO - 'LOGNAME': 'cltbld', 15:54:59 INFO - 'MAIL': '/var/mail/cltbld', 15:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:59 INFO - 'MOZ_NO_REMOTE': '1', 15:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:59 INFO - 'NO_EM_RESTART': '1', 15:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:59 INFO - 'SHELL': '/bin/bash', 15:54:59 INFO - 'SHLVL': '1', 15:54:59 INFO - 'TERM': 'linux', 15:54:59 INFO - 'TMOUT': '86400', 15:54:59 INFO - 'USER': 'cltbld', 15:54:59 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:59 INFO - '_': '/tools/buildbot/bin/python'} 15:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:59 INFO - Downloading/unpacking flake8 15:54:59 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 15:54:59 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 15:54:59 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 15:54:59 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 15:54:59 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 15:54:59 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 15:55:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:55:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:55:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:55:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:55:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:01 INFO - no previously-included directories found matching 'docs/_build' 15:55:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:55:01 INFO - Running setup.py install for pep8 15:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:01 INFO - no previously-included directories found matching 'docs/_build' 15:55:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:55:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:55:01 INFO - Cleaning up... 15:55:02 INFO - Return code: 0 15:55:02 INFO - Running post-action listener: _resource_record_post_action 15:55:02 INFO - Running post-action listener: _start_resource_monitoring 15:55:02 INFO - Starting resource monitoring. 15:55:02 INFO - ##### 15:55:02 INFO - ##### Running install step. 15:55:02 INFO - ##### 15:55:02 INFO - Running pre-action listener: _resource_record_pre_action 15:55:02 INFO - Running main action method: install 15:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:55:02 INFO - Reading from file tmpfile_stdout 15:55:02 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:55:02 INFO - Reading from file tmpfile_stdout 15:55:02 INFO - Output received: 15:55:02 INFO - Usage: mozinstall [options] installer 15:55:02 INFO - Options: 15:55:02 INFO - -h, --help show this help message and exit 15:55:02 INFO - -d DEST, --destination=DEST 15:55:02 INFO - Directory to install application into. [default: 15:55:02 INFO - "/builds/slave/test-pgo"] 15:55:02 INFO - --app=APP Application being installed. [default: firefox] 15:55:02 INFO - mkdir: /builds/slave/test-pgo/build/application 15:55:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:55:18 INFO - Reading from file tmpfile_stdout 15:55:18 INFO - Output received: 15:55:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:55:18 INFO - Running post-action listener: _resource_record_post_action 15:55:18 INFO - ##### 15:55:18 INFO - ##### Running run-tests step. 15:55:18 INFO - ##### 15:55:18 INFO - Running pre-action listener: _resource_record_pre_action 15:55:18 INFO - Running main action method: run_tests 15:55:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:55:18 INFO - Python 2.7.3 15:55:18 INFO - Return code: 0 15:55:18 INFO - grabbing minidump binary from tooltool 15:55:18 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')]} 15:55:18 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 0x222e7f0>, '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 0x219a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x219a760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:55:18 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 15:55:18 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 15:55:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:18 INFO - Return code: 0 15:55:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:55:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:55:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:55:19 INFO - Return code: 0 15:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 15:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 15:55:19 INFO - Using env: {'DISPLAY': ':0', 15:55:19 INFO - 'HOME': '/home/cltbld', 15:55:19 INFO - 'LANG': 'en_US.UTF-8', 15:55:19 INFO - 'LANGUAGE': 'en_US:en', 15:55:19 INFO - 'LOGNAME': 'cltbld', 15:55:19 INFO - 'MAIL': '/var/mail/cltbld', 15:55:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:55:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:19 INFO - 'MOZ_NO_REMOTE': '1', 15:55:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:19 INFO - 'NO_EM_RESTART': '1', 15:55:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:55:19 INFO - 'PWD': '/builds/slave/test-pgo', 15:55:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:55:19 INFO - 'SHELL': '/bin/bash', 15:55:19 INFO - 'SHLVL': '1', 15:55:19 INFO - 'TERM': 'linux', 15:55:19 INFO - 'TMOUT': '86400', 15:55:19 INFO - 'USER': 'cltbld', 15:55:19 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444', 15:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:19 INFO - '_': '/tools/buildbot/bin/python'} 15:55:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 15:55:19 INFO - mozversion application_buildid: 20151227133005 15:55:19 INFO - mozversion application_changeset: f96142e950e08c82b0d6f0f87b95ec58fcd06ea7 15:55:19 INFO - mozversion application_display_name: Nightly 15:55:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:19 INFO - mozversion application_name: Firefox 15:55:19 INFO - mozversion application_remotingname: firefox 15:55:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:55:19 INFO - mozversion application_vendor: Mozilla 15:55:19 INFO - mozversion application_version: 46.0a1 15:55:19 INFO - mozversion platform_buildid: 20151227133005 15:55:19 INFO - mozversion platform_changeset: f96142e950e08c82b0d6f0f87b95ec58fcd06ea7 15:55:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:55:19 INFO - mozversion platform_version: 46.0a1 15:55:19 INFO - using testdate: 1451260519 15:55:19 INFO - actual date: 1451260519 15:55:19 INFO - starting webserver on 'localhost:35901' 15:55:19 INFO - SUITE-START | Running 3 tests 15:55:19 INFO - TEST-START | dromaeo_css 15:55:19 INFO - operating with platform_type : linux_ 15:55:19 INFO - Initialising browser for dromaeo_css test... 15:55:19 INFO - TEST-INFO | started process 1612 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxCT2NI/profile http://localhost:35901/getInfo.html) 15:55:24 INFO - PROCESS | 1612 | __metrics Screen width/height:1600/1200 15:55:24 INFO - PROCESS | 1612 | colorDepth:24 15:55:24 INFO - PROCESS | 1612 | Browser inner width/height: 1024/697 15:55:24 INFO - PROCESS | 1612 | __metrics 15:55:24 INFO - PROCESS | 1612 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:55:25 INFO - TEST-INFO | 1612: exit 0 15:55:25 INFO - Browser initialized. 15:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:25 INFO - TEST-INFO | started process 1746 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxCT2NI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:36 INFO - PROCESS | 1746 | RSS: Main: 149344256 15:55:36 INFO - PROCESS | 1746 | 15:56:26 INFO - PROCESS | 1746 | 1451260586590 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] 15:58:35 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35901/tests/dromaeo/cssquery-ext.html) 15:58:36 INFO - PROCESS | 1746 | RSS: Main: 157417472 15:58:36 INFO - PROCESS | 1746 | 16:01:38 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-ext.html (next: http://localhost:35901/tests/dromaeo/cssquery-jquery.html) 16:01:39 INFO - PROCESS | 1746 | RSS: Main: 155049984 16:01:39 INFO - PROCESS | 1746 | 16:04:41 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35901/tests/dromaeo/cssquery-mootools.html) 16:04:41 INFO - PROCESS | 1746 | RSS: Main: 153354240 16:04:41 INFO - PROCESS | 1746 | 16:07:43 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35901/tests/dromaeo/cssquery-prototype.html) 16:07:44 INFO - PROCESS | 1746 | RSS: Main: 151207936 16:07:44 INFO - PROCESS | 1746 | 16:10:46 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35901/tests/dromaeo/cssquery-yui.html) 16:10:47 INFO - PROCESS | 1746 | RSS: Main: 153415680 16:10:47 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | Cycle 1(1): loaded http://localhost:35901/tests/dromaeo/cssquery-yui.html (next: http://localhost:35901/tests/dromaeo/cssquery-dojo.html) 16:13:49 INFO - PROCESS | 1746 | RSS: Main: 155582464 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | __start_tp_report 16:13:49 INFO - PROCESS | 1746 | _x_x_mozilla_page_load 16:13:49 INFO - PROCESS | 1746 | _x_x_mozilla_page_load_details 16:13:49 INFO - PROCESS | 1746 | |i|pagename|runs| 16:13:49 INFO - PROCESS | 1746 | |0;dojo.html;3135.278885856253;3189.521571764235;3198.056573310873;3203.535487354335;3233.8221397823127;5205.8698532536655;5253.60597955153;5254.422013578508;5308.044551980642;5308.044551980652;5193.558547523465;5212.921806172911;5219.060569097561;5222.843314700555;5232.764525596348;4794.928076078853;4816.686915350509;4853.878653033667;4873.122837889178;4895.0209958008545;4870.123377792013;4945.184044632631;4947.554720075193;4954.232094025414;5030.270610761438;4935.728534930578;4942.481039490855;4959.156943319626;4975.104481193383;4996.650234483587;4758.405199350082;4877.6829506081995;4891.51084891508;4892.902141957141;4915.557599815998;4824.903501929977;4870.196417591093;4871.512848715136;4893.510648935114;4936.136176169156;5067.290579318861;5177.637565370425;5194.428612852583;5232.110541208004;5265.684058956436;5719.542436605062;5723.112917497794;5761.366249712528;5765;5797.217375654275;5808.738606762706;5821.53427725781;5846.473817356416;5847;5858.912116318259;5270.6574072685535;5298.337707786527;5440.782368705287;5451.046066938309;5476.698781567012;5736.827895163152;5825.300963884361;5831.241938547962;5899.292084949748;5908;5553.16702494629;5614.775408983676;5620.606557540933;5620.690862002547;5635.464630860061;5681.943180568224;5713.542916566747;5717.313922329264;5726.0838265877255;5773.220615216976;5554.638948468337;5577.609567330329;5582.051051321285;5647.0964645656495;5654.717264136777;5549.72251387429;5582.078956972054;5589.692566908778;5592.552595792326;5615.803446879339;4312.245357062501;4334.28484300087;4389.1660584488845;4389.648828093745;4413.1394378095965;3924.6664033557468;3942.448057271984;3953.604639536081;3966.2067586482817;3994.7603143811466;5235.240890070919;5279.709615971158;5307.867303317371;5311.362636483646;5364.275822763955;5600.4959553640365;5700.572457065654;5717.285339332583;5759.308882934075;5847.210626565359;5208.895822083613;5252.606054545924;5301.893962120736;5312;5314.096603577401;4977.32806071183;4982.850514484571;4989.775460104304;5007.298978143063;5040.621953353513;5719.370869204384;5774.711264436762;5796.101604251264;5837.591368604242;5912.201852749909;5747.683877386784;5763.135529670415;5770.711464426846;5772.336181339199;5790.334111577054;5748;5821.476067153976;5829.621074630136;5877;5900.350961394157;5639.689817060101;5695.7436915338085;5708.857278568069;5711.171880077449;5762.337331206965;5702.60081794287;5714.428557144252;5739.196512488338;5760.0783874579865;5770.192173095854;5515.365732940763;5585.385607583244;5586.301712285965;5624.634398764068;5625.324961004706;5526.972365138148;5660.29246344207;5740.368559458373;5752.913706294493;5784.4504772046585;5451;5492.038893193755;5506.531944784738;5514.393416724238;5529.474699903502;5476.507114359727;5593.972030139823;5623.634463759842;5632.183333416549;5674.460926212003;5527.391986881359;5551.916721249104;5614.270144881302;5619.044762390322;5671.517920976763 16:13:49 INFO - PROCESS | 1746 | |1;ext.html;534.7039644056845;599.098356972756;604.6402390577605;607.9240094988127;610.2280615021995;34227.31545369094;34479.13802154947;34601.82699086508;34743;34839.47740783887;38444.80777596108;38682.80658596703;38798.61201387992;38901.610983890154;39109.41335879957;8349.206825351597;8424.789380265513;8451.154884511561;8486.78783030423;8510.78723031926;8301.750947471586;8390.83218335633;8429.536375499345;8464.78838029048;8465.195806398382;8488.193621605938;8660;8686.522241276758;8689.695860644879;8704.086070962552;8615.526146061964;8706.825863482758;8730.51982140982;8730.563471826415;8764.430312029697;8441.282490988273;8564.957175214146;8606.053334133241;8624.61189246479;8642.827143457158;39272;39564;39564.20871582552;39858.800705996575;39888.80055599703;2982.4184284064618;3030.969690303091;3162.699543543383;3184.2039490127468;3670.541182352206;28231.57652635212;28714.71285287162;28740.42519149605;29253.853730731422;29370.265743356587;3588.102974256436;3606.819659017065;3702.9259414811822;3752.43713442983;3768.5289338832645;256875;260458;260469.9999999981;260488;261081;51877.74061129746;58328;58418.707906461044;58551.12173317403;58849;47703.76148119237;63500.682496588146;64239.678801605696;64523.67738161279;64567.35432645614;13494.190348579117;13527.120737152054;13573.253471059186;13619.659508512168;13643.113197642122;10412.47937603132;10478.214133939984;10483.056524912794;10501.054905058581;10507.159427245802;19411.3206037788;19541.68269494959;20097.19611215564;20263.696044559343;20298.39104826828;7789.961050194713;7826.530408175528;7927.246911543394;7937.166597507294;8043.11525732169;923.6859467780987;939.3800091939287;984.9409035457895;1039;1135.846660700795;27908.30229244285;28096.85951570229;28301.71698283032;28482.572761408595;28639.85680071628;1030.3508789462592;1047.8847326794046;1095.1622009162998;1110.8778034416207;1118.8713297970676;13747.793783093262;13968.790468142986;15826.208689565476;16385.754213686803;16408.83591164073;275764;277850;277896;278072;281277;48495;48596.27105593419;48612.75693621509;48910;49054.28310009133;1294.643972907458;1303.2636560343376;1308.9541866034642;1321.1082519299628;1333.9466421343038;27886.745096470302;29312.706872930998;29793.851030745576;29852.253693657833;30064.3987120252;45205;45570.08859822851;45796.7710161447;45902.77048614869;45944.54055459402;288951;290133;290825;291226;291637;30711;41215.79392103021;42089;42388.36417453802;42585;38209;38412.2317553653;38801;38961.805190973864;39410.80294598509;32061;32077.839610801795;32266.516002260454;32984.83507582447;33157.50263745998;34714;35253.471197932566;35475.290494190485;35675;35688.28623427465;33098.83450582732;33739.15652108717;33790.49314260337;33913.49129763006;34112.317753645286;29420.852895735385;32192.517112243804;32523.18692032718;32527.34945301128;32590.34819303648;24537;26982.32544186411;28127.71872281251;28183;28376.43247135087 16:13:49 INFO - PROCESS | 1746 | |2;jquery.html;349.43740577669945;351.1099363114505;351.506133881896;360.41252758004464;361.1566991075838;16996.575085622866;17521.21154548045;17576.121193940315;17852.196651150713;18047.819521804777;14890.404383824662;14982.576655217765;15134.545963621082;15158.090514569134;15234.54296371108;4760.714357138574;4875.268709693539;4891.5842153416825;4909.582685471739;4962.950370496285;4847.612191024709;4925.532074452939;4931.679440836352;4960.479149689285;4976.203807390818;4278.37963495293;5173.017126745906;5315.229291752694;5327.440618735035;5371.59713021523;5302.681839089629;5312.867178320535;5360.142377219626;5377.596680248997;5379.085555455582;5129.230615407681;5139.614528910347;5144.536991670768;5149.201873709581;5296.496832800878;12882.291473968928;12922.095453318272;12954.352282385844;15373.692526149527;19359.612807743768;1952.8535359847926;2050.8974551272377;2059.3101311060814;2092.6442504774227;2093.2359688713664;8943.373963822534;9014.143656352702;9171.633134674605;9277.35058545902;9407.153356197907;1798.847097996672;1812.8277813607685;1814.6189300246965;1820.836124748779;1847.353426300784;57587.712061439845;61873.690631547004;62209.37790622081;62282.68858655723;64142.3585764141;10259.692209233586;10321;10335.689929302132;10345.844812327821;10461.372317660966;13551.661208469866;13608.115472494255;13610;13636.65908352299;13715.519956801463;7568.735094271784;7671.501352412075;7690.769276921701;7733.072031356273;7779.4943328684585;7276.890846637305;7352;7407.962960185165;7423.4061275097865;7453.478256522099;4511;4540.79668887745;4541.659375546781;4544.772911313927;4568.269076947672;1824.042377751691;1844.4190080124717;1868.588910439701;1870.4108205915093;1910.5414700471786;468.4795798603559;474.006955428377;859.6690274244461;903.8418276801533;1009.9444530550891;10656.413897235727;10887.727806804734;11220.607278745205;11313.321200727984;11643.301401915913;450.49544510148843;456.5959126173294;480.19327529750353;485.66489122506067;860.1527495417009;8752.824943501095;8758.781030474162;8801.735947921572;8901.73294801157;8991.55042247885;508218;514847;525860;525880;526092;79524;79626;81091.59454202691;83346.16653833505;83618.16381836226;1115.6597237842373;1128.7065363005677;1129.6498085593491;1140.703417111557;1169.4620474581789;14408.639784005065;14558.854411456174;14607.92696036513;14663.56009319722;14897.702045959237;32400.189995249366;32542.53558589822;32839.67160328366;33241.667583323855;33938.15154621055;45341.31988020116;46479.30281045719;46603.30095048509;46777.83055423642;47963.520364795906;9340.953295233481;9663.806723865624;9802.411855288705;9808.411495310304;9870;11540.480678369662;11544.884551154717;11601.883981160081;11652.126090543074;13843.307834608027;14104.36530356157;14185.290735463392;14309.356078976263;14570.417183312973;14624.780628290797;13752.93123534376;13952.302384880919;14044.227567483886;14080.507182248572;14416.927915360357;14017.369218384993;14928.776068358766;15050.247487625795;15077.849221508084;15206.619834504227;9415.105564971316;9542.666006689733;9716.368436051634;9769.071938165864;9800.31397802147;13926.860731392557;14037.859621403655;14231.928840355731;14273;14432.061915975428 16:13:49 INFO - PROCESS | 1746 | |3;mootools.html;1440.3950340856838;1449.8115245018146;1616.7251567233568;1763.312308199803;1792.471220989808;7444.776656700301;7496.662650180741;7539.132999705035;7586.96206518968;7608.353289970352;7516.098068231806;7585.279398457138;7597.92402075979;7637.968874201981;7652.961735191317;2235.094786611421;2268.1381075191402;2277.81777457803;2286.302677683306;2292.0946226240626;2259.67234750961;2263.592553340406;2274.8293877959136;2291.873946932918;2323.256557901472;2240.260713964396;2261.208576998054;2283.6346184610466;2308.7114110736156;2319.118734880743;2255.391044418014;2270.8069814065825;2284.4060544258446;2290.038183962731;2292.0946226240626;2281.418238349227;2295.21962532738;2304.446932736148;2310.6418505131733;2317.9652305215436;7420.220876807912;7484.812879677997;7536.8115797104965;7550;7554.546727196331;4648.3259927310355;4740.810367585327;4753.857384278477;4758.738269395182;4759.952400475986;3063.6629970703207;3074.4004919040794;3129.9843500782576;3130.906072817819;3169.3344397676515;967.4678926590348;970.5438443931341;977.5454413697664;978.7063880835792;1004.2116938203549;10215.795684086352;10280.12618927392;10370.37777733331;10376.429296388696;10441.321314114559;4003.259397011562;4021;4040.898977525527;4070.5929407059057;4130.318497447887;8496.107908669625;8542.145785421408;8547.871781923277;8548.316134709332;8549.786255343666;4545.113702827917;4563.95436045642;4576.382188404589;4610.631149508032;4616.330632058332;4197.769122698281;4231.809568569422;4233.7671428071135;4286.592773686495;4298.656107511391;3677.42999835026;3712.9071773205887;3721.404575267944;3735.0662334416397;3736.869209577652;1208.456194712383;1215.1190386969377;1229.6495498782804;1229.9508019679113;1235.1909499277988;1067.9412632305298;1072.2708558180357;1075.5052675769234;1079.8920107989295;1112.0158659586164;6707.664616769142;6744.359285867835;6749.898751518731;6797.1843378794865;6830.965845170742;487.9414470263591;493.1887045809623;493.88146844757;499.05429211644457;504.75519373104015;5151.459096794782;5185.481451854785;5213.6089793265655;5216.1393370094265;5265.657732247391;8619.741407757778;8816.51509167002;8893.199612034949;8981.326400519987;9090.90909090914;8882.911170888337;8987.325950553604;9030.593623286968;9061.864072038925;9114.544272786334;7039.577625342496;7091.219965803757;7117.395021423134;7172.282771722786;7219.747308844166;6485.124508191334;6576.506761992965;6577.408033277028;6609.570377925419;6616.801495955129;7908.209179082276;8088.676452941816;8105.148959359182;8127.065387480516;8244.505329680238;8197.057338406159;8253.33973282148;8277.337812974827;8326.50040997542;8468.703595374132;5865.824025279248;5942.732577033958;6214.658193799384;6418.807435776934;6486.156799616019;6815.727370905108;6847.589144651337;6893.517453778188;6907.654617269217;6940.548864323803;6365.90451143224;6424.550281480251;6454.967725161344;6561.048647946117;6646.102776125162;6455.2576453708425;6462.515311351762;6473.352664733489;6516;6611.206655201407;6330.778422755181;6341.460975816923;6361.173047503795;6372.840678982877;6387.329330420239;5711.3431955324;5788.479036886701;5824.446677565794;5972.58191926561;5989.490893273946;6038.275406951194;6051.4553690168095;6058.303295121117;6066.332703402711;6067.271927368744 16:13:49 INFO - PROCESS | 1746 | |4;prototype.html;329.59789057350025;334.02964388451556;339.3958753418914;339.80291430970027;350.9877154299599;6239.6880155992185;6261.060840873871;6279.905801412982;6311.305756366796;6438.098666186737;6171.259448866131;6236.9708998015385;6247.468965137969;6270.372962703727;6306;4763.880902977418;4766.165920963835;4775.3075804008395;4775.90448191036;4783.33033375326;4773.140834649762;4779.378680771495;4783.067301876135;4804.711717296956;4815.229563269878;4609.446866376023;4727.66906316558;4728.550787675165;4739.052189562084;4739.838739508825;4684.484706682262;4716.410448693913;4721.881952951169;4723.811047558111;4725.149473094842;4091.9795401023102;4102.917941641151;4105.5894410559;4108.1783643271465;4109.835606575733;5925.555583331225;5931.495822855062;5942;5984.132300816401;6009.729562169669;5417.377001644822;5526.171074338841;5528.9723551381985;5536.169574563807;5547.611667183299;6611.636360000198;6648.700808463631;6660.833479163011;6671.666416679195;6674.799756007327;4568.680192386534;4568.908621827578;4570.177368073779;4574.839880604196;4578.725276483422;6822.556533825285;6919.204291506491;6928.4803639726715;6959.269276725921;7012.298770122947;4615.215413379667;4616.746078965689;4631.8378856739855;4632.119897219518;4651.209294419957;4667;4692.835750748707;4700.764961751899;4701.965567575128;4708.952910470852;5481.369642491165;5498.697571633518;5500.22996780451;5504.4495550444635;5505.201745746845;6590.7693230736695;6686.732530698718;6739.326067393319;6756.290589488131;6775.424088952395;1629.1121338870344;1656.2712406541084;1680.1683166832497;1680.4118558504426;1683.7474378843026;1109.1459576126338;1122.1135303110614;1126.8760436351995;1127.182792475465;1134.914881383883;6196.845078872974;6221.751129954751;6283.937160628427;6297.338779428094;6299.275583307886;6853.383195512428;6863.828404289933;6871.759488417982;6874.106366172366;6897.62063086525;6063.454289114001;6190.071489276645;6191.628502289877;6196.0705894115345;6197.876042479125;3740.17716102457;3744.5319335083113;3766.642168993941;3767.4348847672522;3773.52830896138;7022.1924478685605;7024.332688394595;7045.11936007999;7056.470764692566;7066.505344625827;6988.44092472601;7076.044733960953;7117.074780278531;7118.60847653384;7150.642467876585;7156.60638664868;7194.136703595602;7218.169910460364;7224.530405523729;7227.385672217815;7014.508984371045;7016.824784316878;7029.789106326818;7033.261507541839;7040.8591828162125;6823.488238382042;6897.448204143757;6933.0986971693355;6958.79123626292;6982.581045137308;7175.712971481083;7179.605121718147;7182;7191.820204494929;7203.747868824566;4662.440507139165;4711.740854253049;4723.598494128038;4729.5034021427255;4739.952600473951;6867.381935625817;7042.225355211025;7042.43660507148;7054.118235220598;7066.540674856118;6783.762568310085;6816.522843401112;6841.555298905555;6850.246472888078;6859.314068593101;6785.321467853175;6786.524943253925;6807.3873351398615;6821.795346139624;6822.044913711985;6525.314841941527;6663.866722665616;6670.166229221348;6674.83312917181;6688.163979502562;6828.453723701992;6830.556013859084;6841.281665425257;6856.417204537471;6872.965635171992;6633.336666333328;6636.966815165893;6663.633500157344;6664.633445160563;6696.899546506904 16:13:49 INFO - PROCESS | 1746 | |5;yui.html;697.5953946710906;702.3573430311263;764.8929149919009;778.2023425988361;786.9881951770725;11595.478203480843;11709.355985420787;11732.882671173285;11799.528018879246;11824.58613948512;11396;11727.765444691102;11947;12903.419346129424;13075.73848523029;797.7088362747585;816.6733306677347;816.9019717633893;820.3888103363003;820.4871955028108;801.819590592115;811.452269717941;815.3843847894831;815.7838172884191;821.3593397150232;844.7085755414372;848.9702860399888;850.1668365002301;851.7402192331336;857.4940784936886;837.7779888329597;844.8099177685033;845.2266176448542;846.2848892685671;848.1433751910583;622.2346513788066;625.8810825943057;626.6647343671114;628.1237673445518;632.3549979021418;11952.223105498115;12130.393480325949;12155.817662734979;12176.878231217752;12179.39103044853;9582.56878440465;9804.215662747034;10567.15462762977;10648.307859989076;10753.51609177589;8742.213200811893;8979.506127163004;9106.86339704905;9218.308626853013;9395.90604093964;3383.4586466165297;3528.1179705073732;3541.3979623463815;3556.1287484566446;3556.7332450066347;43697.78151109256;44625;44626.55373446256;48727.75636121832;49065.264021039715;9224.215941645036;9247.815043699224;9286.442813431217;9328.300377471716;9457.243420526342;17633;17798.37705680295;17890.463286101436;18044.819551804576;18168.63662726738;7511.286427789351;7624.923750762532;7638.770836874903;7690.192529784404;7772.961135194288;4382.408374869352;4389.934150987738;4401.2297847877135;4411.228035093845;4428.889277768081;3062.433449811792;3069.9869043215685;3078.0458058001645;3085.5988721466065;3096.5974423324824;524.7087866234276;543.5054100768361;553.82000849724;555.5028249716481;555.7304707217078;524.8346770767196;564.25800072904;581.656822474742;603.4439978164838;617.1236843681983;7726.304632583095;7820.178881217504;7826.295633393022;7915.802104947423;8046.718364857202;571.4656795895851;580.3702982264206;595.8569943213685;602.7227475361383;620.8975519039308;3609.115766637138;3819.4461803038403;3866.516685414323;3952.5849785772657;3987;52694;53757.73121134369;54060.18909716357;54147.45852541503;54234.72882635562;48872.755636222304;49431.75284123556;49702;50498;51010.74494627503;46195.307070393974;48756;49110;50482.49517504851;50613.74693126584;7984.321332686554;8017.478863873829;8251.793705157419;8305;8432.45189062709;33003;34110.829445852614;34693;35315.293694126485;35465;38539.42190867083;39045.21909561736;40413;43868.90327741832;43870;10644.574217031231;10928.180386471206;10935.512988664415;10944.616938407118;11271.436428178722;10578.100861426865;10677.305975111592;10691.625793097204;10897.75299425873;11552.768944621228;10208.591656333663;10400.895991039994;10658.573657053632;10705.89294107049;10931.196134825852;10863.185261105291;10956;11042.447877606248;11256.043236325004;11527;9905.356151850106;9999.500024998575;10072.446015468926;10245.897541024495;10404.947975260075;9440.197583205505;9544.33189676716;9835.950820245853;9893.703188904345;9973.750656233362;8556.358273129665;8797.648094076421;8973.587956344727;9247.39891907024;9592.136707696342 16:13:49 INFO - PROCESS | 1746 | __end_tp_report 16:13:49 INFO - PROCESS | 1746 | __start_cc_report 16:13:49 INFO - PROCESS | 1746 | _x_x_mozilla_cycle_collect,304 16:13:49 INFO - PROCESS | 1746 | __end_cc_report 16:13:49 INFO - PROCESS | 1746 | __startTimestamp1451261629469__endTimestamp 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | ------- Summary: start ------- 16:13:49 INFO - PROCESS | 1746 | Number of tests: 6 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#0] dojo.html Cycles:165 Average:5307.86 Median:5527.39 stddev:581.75 (10.5%) stddev-sans-first:558.01 16:13:49 INFO - PROCESS | 1746 | Values: 3135.3 3189.5 3198.1 3203.5 3233.8 5205.9 5253.6 5254.4 5308.0 5308.0 5193.6 5212.9 5219.1 5222.8 5232.8 4794.9 4816.7 4853.9 4873.1 4895.0 4870.1 4945.2 4947.6 4954.2 5030.3 4935.7 4942.5 4959.2 4975.1 4996.7 4758.4 4877.7 4891.5 4892.9 4915.6 4824.9 4870.2 4871.5 4893.5 4936.1 5067.3 5177.6 5194.4 5232.1 5265.7 5719.5 5723.1 5761.4 5765.0 5797.2 5808.7 5821.5 5846.5 5847.0 5858.9 5270.7 5298.3 5440.8 5451.0 5476.7 5736.8 5825.3 5831.2 5899.3 5908.0 5553.2 5614.8 5620.6 5620.7 5635.5 5681.9 5713.5 5717.3 5726.1 5773.2 5554.6 5577.6 5582.1 5647.1 5654.7 5549.7 5582.1 5589.7 5592.6 5615.8 4312.2 4334.3 4389.2 4389.6 4413.1 3924.7 3942.4 3953.6 3966.2 3994.8 5235.2 5279.7 5307.9 5311.4 5364.3 5600.5 5700.6 5717.3 5759.3 5847.2 5208.9 5252.6 5301.9 5312.0 5314.1 4977.3 4982.9 4989.8 5007.3 5040.6 5719.4 5774.7 5796.1 5837.6 5912.2 5747.7 5763.1 5770.7 5772.3 5790.3 5748.0 5821.5 5829.6 5877.0 5900.4 5639.7 5695.7 5708.9 5711.2 5762.3 5702.6 5714.4 5739.2 5760.1 5770.2 5515.4 5585.4 5586.3 5624.6 5625.3 5527.0 5660.3 5740.4 5752.9 5784.5 5451.0 5492.0 5506.5 5514.4 5529.5 5476.5 5594.0 5623.6 5632.2 5674.5 5527.4 5551.9 5614.3 5619.0 5671.5 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#1] ext.html Cycles:180 Average:44464.26 Median:34728.50 stddev:72104.46 (207.6%) stddev-sans-first:72231.29 16:13:49 INFO - PROCESS | 1746 | Values: 534.7 599.1 604.6 607.9 610.2 34227.3 34479.1 34601.8 34743.0 34839.5 38444.8 38682.8 38798.6 38901.6 39109.4 8349.2 8424.8 8451.2 8486.8 8510.8 8301.8 8390.8 8429.5 8464.8 8465.2 8488.2 8660.0 8686.5 8689.7 8704.1 8615.5 8706.8 8730.5 8730.6 8764.4 8441.3 8565.0 8606.1 8624.6 8642.8 39272.0 39564.0 39564.2 39858.8 39888.8 2982.4 3031.0 3162.7 3184.2 3670.5 28231.6 28714.7 28740.4 29253.9 29370.3 3588.1 3606.8 3702.9 3752.4 3768.5 256875.0 260458.0 260470.0 260488.0 261081.0 51877.7 58328.0 58418.7 58551.1 58849.0 47703.8 63500.7 64239.7 64523.7 64567.4 13494.2 13527.1 13573.3 13619.7 13643.1 10412.5 10478.2 10483.1 10501.1 10507.2 19411.3 19541.7 20097.2 20263.7 20298.4 7790.0 7826.5 7927.2 7937.2 8043.1 923.7 939.4 984.9 1039.0 1135.8 27908.3 28096.9 28301.7 28482.6 28639.9 1030.4 1047.9 1095.2 1110.9 1118.9 13747.8 13968.8 15826.2 16385.8 16408.8 275764.0 277850.0 277896.0 278072.0 281277.0 48495.0 48596.3 48612.8 48910.0 49054.3 1294.6 1303.3 1309.0 1321.1 1333.9 27886.7 29312.7 29793.9 29852.3 30064.4 45205.0 45570.1 45796.8 45902.8 45944.5 288951.0 290133.0 290825.0 291226.0 291637.0 30711.0 41215.8 42089.0 42388.4 42585.0 38209.0 38412.2 38801.0 38961.8 39410.8 32061.0 32077.8 32266.5 32984.8 33157.5 34714.0 35253.5 35475.3 35675.0 35688.3 33098.8 33739.2 33790.5 33913.5 34112.3 29420.9 32192.5 32523.2 32527.3 32590.3 24537.0 26982.3 28127.7 28183.0 28376.4 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#2] jquery.html Cycles:180 Average:27787.79 Median:2319.77 stddev:85144.14 (3670.4%) stddev-sans-first:85358.07 16:13:49 INFO - PROCESS | 1746 | Values: 349.4 351.1 351.5 360.4 361.2 16996.6 17521.2 17576.1 17852.2 18047.8 14890.4 14982.6 15134.5 15158.1 15234.5 4760.7 4875.3 4891.6 4909.6 4963.0 4847.6 4925.5 4931.7 4960.5 4976.2 4278.4 5173.0 5315.2 5327.4 5371.6 5302.7 5312.9 5360.1 5377.6 5379.1 5129.2 5139.6 5144.5 5149.2 5296.5 12882.3 12922.1 12954.4 15373.7 19359.6 1952.9 2050.9 2059.3 2092.6 2093.2 8943.4 9014.1 9171.6 9277.4 9407.2 1798.8 1812.8 1814.6 1820.8 1847.4 57587.7 61873.7 62209.4 62282.7 64142.4 10259.7 10321.0 10335.7 10345.8 10461.4 13551.7 13608.1 13610.0 13636.7 13715.5 7568.7 7671.5 7690.8 7733.1 7779.5 7276.9 7352.0 7408.0 7423.4 7453.5 4511.0 4540.8 4541.7 4544.8 4568.3 1824.0 1844.4 1868.6 1870.4 1910.5 468.5 474.0 859.7 903.8 1009.9 10656.4 10887.7 11220.6 11313.3 11643.3 450.5 456.6 480.2 485.7 860.2 8752.8 8758.8 8801.7 8901.7 8991.6 508218.0 514847.0 525860.0 525880.0 526092.0 79524.0 79626.0 81091.6 83346.2 83618.2 1115.7 1128.7 1129.6 1140.7 1169.5 14408.6 14558.9 14607.9 14663.6 14897.7 32400.2 32542.5 32839.7 33241.7 33938.2 45341.3 46479.3 46603.3 46777.8 47963.5 9341.0 9663.8 9802.4 9808.4 9870.0 11540.5 11544.9 11601.9 11652.1 13843.3 14104.4 14185.3 14309.4 14570.4 14624.8 13752.9 13952.3 14044.2 14080.5 14416.9 14017.4 14928.8 15050.2 15077.8 15206.6 9415.1 9542.7 9716.4 9769.1 9800.3 13926.9 14037.9 14231.9 14273.0 14432.1 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#3] mootools.html Cycles:180 Average:5196.58 Median:5957.66 stddev:2671.94 (44.8%) stddev-sans-first:2664.52 16:13:49 INFO - PROCESS | 1746 | Values: 1440.4 1449.8 1616.7 1763.3 1792.5 7444.8 7496.7 7539.1 7587.0 7608.4 7516.1 7585.3 7597.9 7638.0 7653.0 2235.1 2268.1 2277.8 2286.3 2292.1 2259.7 2263.6 2274.8 2291.9 2323.3 2240.3 2261.2 2283.6 2308.7 2319.1 2255.4 2270.8 2284.4 2290.0 2292.1 2281.4 2295.2 2304.4 2310.6 2318.0 7420.2 7484.8 7536.8 7550.0 7554.5 4648.3 4740.8 4753.9 4758.7 4760.0 3063.7 3074.4 3130.0 3130.9 3169.3 967.5 970.5 977.5 978.7 1004.2 10215.8 10280.1 10370.4 10376.4 10441.3 4003.3 4021.0 4040.9 4070.6 4130.3 8496.1 8542.1 8547.9 8548.3 8549.8 4545.1 4564.0 4576.4 4610.6 4616.3 4197.8 4231.8 4233.8 4286.6 4298.7 3677.4 3712.9 3721.4 3735.1 3736.9 1208.5 1215.1 1229.6 1230.0 1235.2 1067.9 1072.3 1075.5 1079.9 1112.0 6707.7 6744.4 6749.9 6797.2 6831.0 487.9 493.2 493.9 499.1 504.8 5151.5 5185.5 5213.6 5216.1 5265.7 8619.7 8816.5 8893.2 8981.3 9090.9 8882.9 8987.3 9030.6 9061.9 9114.5 7039.6 7091.2 7117.4 7172.3 7219.7 6485.1 6576.5 6577.4 6609.6 6616.8 7908.2 8088.7 8105.1 8127.1 8244.5 8197.1 8253.3 8277.3 8326.5 8468.7 5865.8 5942.7 6214.7 6418.8 6486.2 6815.7 6847.6 6893.5 6907.7 6940.5 6365.9 6424.6 6455.0 6561.0 6646.1 6455.3 6462.5 6473.4 6516.0 6611.2 6330.8 6341.5 6361.2 6372.8 6387.3 5711.3 5788.5 5824.4 5972.6 5989.5 6038.3 6051.5 6058.3 6066.3 6067.3 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#4] prototype.html Cycles:180 Average:5582.45 Median:6254.26 stddev:1711.16 (27.4%) stddev-sans-first:1669.92 16:13:49 INFO - PROCESS | 1746 | Values: 329.6 334.0 339.4 339.8 351.0 6239.7 6261.1 6279.9 6311.3 6438.1 6171.3 6237.0 6247.5 6270.4 6306.0 4763.9 4766.2 4775.3 4775.9 4783.3 4773.1 4779.4 4783.1 4804.7 4815.2 4609.4 4727.7 4728.6 4739.1 4739.8 4684.5 4716.4 4721.9 4723.8 4725.1 4092.0 4102.9 4105.6 4108.2 4109.8 5925.6 5931.5 5942.0 5984.1 6009.7 5417.4 5526.2 5529.0 5536.2 5547.6 6611.6 6648.7 6660.8 6671.7 6674.8 4568.7 4568.9 4570.2 4574.8 4578.7 6822.6 6919.2 6928.5 6959.3 7012.3 4615.2 4616.7 4631.8 4632.1 4651.2 4667.0 4692.8 4700.8 4702.0 4709.0 5481.4 5498.7 5500.2 5504.4 5505.2 6590.8 6686.7 6739.3 6756.3 6775.4 1629.1 1656.3 1680.2 1680.4 1683.7 1109.1 1122.1 1126.9 1127.2 1134.9 6196.8 6221.8 6283.9 6297.3 6299.3 6853.4 6863.8 6871.8 6874.1 6897.6 6063.5 6190.1 6191.6 6196.1 6197.9 3740.2 3744.5 3766.6 3767.4 3773.5 7022.2 7024.3 7045.1 7056.5 7066.5 6988.4 7076.0 7117.1 7118.6 7150.6 7156.6 7194.1 7218.2 7224.5 7227.4 7014.5 7016.8 7029.8 7033.3 7040.9 6823.5 6897.4 6933.1 6958.8 6982.6 7175.7 7179.6 7182.0 7191.8 7203.7 4662.4 4711.7 4723.6 4729.5 4740.0 6867.4 7042.2 7042.4 7054.1 7066.5 6783.8 6816.5 6841.6 6850.2 6859.3 6785.3 6786.5 6807.4 6821.8 6822.0 6525.3 6663.9 6670.2 6674.8 6688.2 6828.5 6830.6 6841.3 6856.4 6873.0 6633.3 6637.0 6663.6 6664.6 6696.9 16:13:49 INFO - PROCESS | 1746 | 16:13:49 INFO - PROCESS | 1746 | [#5] yui.html Cycles:180 Average:13182.32 Median:25767.73 stddev:15491.24 (60.1%) stddev-sans-first:15506.33 16:13:49 INFO - PROCESS | 1746 | Values: 697.6 702.4 764.9 778.2 787.0 11595.5 11709.4 11732.9 11799.5 11824.6 11396.0 11727.8 11947.0 12903.4 13075.7 797.7 816.7 816.9 820.4 820.5 801.8 811.5 815.4 815.8 821.4 844.7 849.0 850.2 851.7 857.5 837.8 844.8 845.2 846.3 848.1 622.2 625.9 626.7 628.1 632.4 11952.2 12130.4 12155.8 12176.9 12179.4 9582.6 9804.2 10567.2 10648.3 10753.5 8742.2 8979.5 9106.9 9218.3 9395.9 3383.5 3528.1 3541.4 3556.1 3556.7 43697.8 44625.0 44626.6 48727.8 49065.3 9224.2 9247.8 9286.4 9328.3 9457.2 17633.0 17798.4 17890.5 18044.8 18168.6 7511.3 7624.9 7638.8 7690.2 7773.0 4382.4 4389.9 4401.2 4411.2 4428.9 3062.4 3070.0 3078.0 3085.6 3096.6 524.7 543.5 553.8 555.5 555.7 524.8 564.3 581.7 603.4 617.1 7726.3 7820.2 7826.3 7915.8 8046.7 571.5 580.4 595.9 602.7 620.9 3609.1 3819.4 3866.5 3952.6 3987.0 52694.0 53757.7 54060.2 54147.5 54234.7 48872.8 49431.8 49702.0 50498.0 51010.7 46195.3 48756.0 49110.0 50482.5 50613.7 7984.3 8017.5 8251.8 8305.0 8432.5 33003.0 34110.8 34693.0 35315.3 35465.0 38539.4 39045.2 40413.0 43868.9 43870.0 10644.6 10928.2 10935.5 10944.6 11271.4 10578.1 10677.3 10691.6 10897.8 11552.8 10208.6 10400.9 10658.6 10705.9 10931.2 10863.2 10956.0 11042.4 11256.0 11527.0 9905.4 9999.5 10072.4 10245.9 10404.9 9440.2 9544.3 9836.0 9893.7 9973.8 8556.4 8797.6 8973.6 9247.4 9592.1 16:13:49 INFO - PROCESS | 1746 | -------- Summary: end -------- 16:13:49 INFO - PROCESS | 1746 | 16:13:50 INFO - TEST-INFO | 1746: exit 0 16:13:50 INFO - TEST-OK | dromaeo_css | took 1110769ms 16:13:50 INFO - TEST-START | kraken 16:13:50 INFO - operating with platform_type : linux_ 16:13:50 INFO - Initialising browser for kraken test... 16:13:50 INFO - TEST-INFO | started process 1982 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcttj3x/profile http://localhost:35901/getInfo.html) 16:13:54 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 16:13:54 INFO - PROCESS | 1982 | colorDepth:24 16:13:54 INFO - PROCESS | 1982 | Browser inner width/height: 1024/697 16:13:54 INFO - PROCESS | 1982 | __metrics 16:13:54 INFO - PROCESS | 1982 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:13:55 INFO - TEST-INFO | 1982: exit 0 16:13:55 INFO - Browser initialized. 16:13:55 INFO - Running cycle 1/1 for kraken test... 16:13:55 INFO - TEST-INFO | started process 2104 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcttj3x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:07 INFO - PROCESS | 2104 | RSS: Main: 149917696 16:14:07 INFO - PROCESS | 2104 | 16:14:09 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35901/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:10 INFO - PROCESS | 2104 | RSS: Main: 151101440 16:14:10 INFO - PROCESS | 2104 | 16:14:13 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35901/tests/kraken/driver.html?testName=audio-dft) 16:14:13 INFO - PROCESS | 2104 | RSS: Main: 151842816 16:14:13 INFO - PROCESS | 2104 | 16:14:16 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35901/tests/kraken/driver.html?testName=audio-fft) 16:14:17 INFO - PROCESS | 2104 | RSS: Main: 145780736 16:14:17 INFO - PROCESS | 2104 | 16:14:19 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35901/tests/kraken/driver.html?testName=audio-oscillator) 16:14:20 INFO - PROCESS | 2104 | RSS: Main: 146636800 16:14:20 INFO - PROCESS | 2104 | 16:14:22 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35901/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:22 INFO - PROCESS | 2104 | RSS: Main: 147333120 16:14:22 INFO - PROCESS | 2104 | 16:14:25 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35901/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:26 INFO - PROCESS | 2104 | RSS: Main: 146866176 16:14:26 INFO - PROCESS | 2104 | 16:14:29 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35901/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:30 INFO - PROCESS | 2104 | RSS: Main: 148713472 16:14:30 INFO - PROCESS | 2104 | 16:14:33 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35901/tests/kraken/driver.html?testName=json-parse-financial) 16:14:33 INFO - PROCESS | 2104 | RSS: Main: 149180416 16:14:33 INFO - PROCESS | 2104 | 16:14:35 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35901/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:36 INFO - PROCESS | 2104 | RSS: Main: 148316160 16:14:36 INFO - PROCESS | 2104 | 16:14:37 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:38 INFO - PROCESS | 2104 | RSS: Main: 149082112 16:14:38 INFO - PROCESS | 2104 | 16:14:40 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:41 INFO - PROCESS | 2104 | RSS: Main: 149221376 16:14:41 INFO - PROCESS | 2104 | 16:14:43 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:44 INFO - PROCESS | 2104 | RSS: Main: 149553152 16:14:44 INFO - PROCESS | 2104 | 16:14:46 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:47 INFO - PROCESS | 2104 | RSS: Main: 148279296 16:14:47 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | Cycle 1(1): loaded http://localhost:35901/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35901/tests/kraken/driver.html?testName=ai-astar) 16:14:49 INFO - PROCESS | 2104 | RSS: Main: 148246528 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | __start_tp_report 16:14:49 INFO - PROCESS | 2104 | _x_x_mozilla_page_load 16:14:49 INFO - PROCESS | 2104 | _x_x_mozilla_page_load_details 16:14:49 INFO - PROCESS | 2104 | |i|pagename|runs| 16:14:49 INFO - PROCESS | 2104 | |0;ai-astar;113;104;113;112;113;123;113;111;113;114 16:14:49 INFO - PROCESS | 2104 | |1;audio-beat-detection;156;124;163;168;135;152;162;127;166;135 16:14:49 INFO - PROCESS | 2104 | |2;audio-dft;163;167;163;166;162;164;168;170;165;165 16:14:49 INFO - PROCESS | 2104 | |3;audio-fft;72;74;76;74;74;74;73;133;80;72 16:14:49 INFO - PROCESS | 2104 | |4;audio-oscillator;97;97;139;96;97;97;136;97;97;137 16:14:49 INFO - PROCESS | 2104 | |5;imaging-gaussian-blur;109;111;110;111;109;111;110;112;110;111 16:14:49 INFO - PROCESS | 2104 | |6;imaging-darkroom;148;147;147;147;148;147;149;147;147;147 16:14:49 INFO - PROCESS | 2104 | |7;imaging-desaturate;97;97;96;98;97;96;96;97;97;97 16:14:49 INFO - PROCESS | 2104 | |8;json-parse-financial;62;61;60;63;63;60;60;61;58;58 16:14:49 INFO - PROCESS | 2104 | |9;json-stringify-tinderbox;68;69;69;68;69;70;71;69;69;68 16:14:49 INFO - PROCESS | 2104 | |10;stanford-crypto-aes;93;87;88;98;87;88;88;89;88;87 16:14:49 INFO - PROCESS | 2104 | |11;stanford-crypto-ccm;121;121;119;126;121;120;130;123;125;117 16:14:49 INFO - PROCESS | 2104 | |12;stanford-crypto-pbkdf2;140;157;152;152;155;147;154;150;151;157 16:14:49 INFO - PROCESS | 2104 | |13;stanford-crypto-sha256-iterative;66;67;69;69;71;67;67;68;69;79 16:14:49 INFO - PROCESS | 2104 | __end_tp_report 16:14:49 INFO - PROCESS | 2104 | __start_cc_report 16:14:49 INFO - PROCESS | 2104 | _x_x_mozilla_cycle_collect,746 16:14:49 INFO - PROCESS | 2104 | __end_cc_report 16:14:49 INFO - PROCESS | 2104 | __startTimestamp1451261689496__endTimestamp 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | ------- Summary: start ------- 16:14:49 INFO - PROCESS | 2104 | Number of tests: 14 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:4.56 (4.0%) stddev-sans-first:4.83 16:14:49 INFO - PROCESS | 2104 | Values: 113.0 104.0 113.0 112.0 113.0 123.0 113.0 111.0 113.0 114.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:159.00 stddev:16.91 (10.6%) stddev-sans-first:17.73 16:14:49 INFO - PROCESS | 2104 | Values: 156.0 124.0 163.0 168.0 135.0 152.0 162.0 127.0 166.0 135.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:2.50 (1.5%) stddev-sans-first:2.51 16:14:49 INFO - PROCESS | 2104 | Values: 163.0 167.0 163.0 166.0 162.0 164.0 168.0 170.0 165.0 165.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#3] audio-fft Cycles:10 Average:80.20 Median:74.00 stddev:18.70 (25.3%) stddev-sans-first:19.59 16:14:49 INFO - PROCESS | 2104 | Values: 72.0 74.0 76.0 74.0 74.0 74.0 73.0 133.0 80.0 72.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:97.00 stddev:19.57 (20.2%) stddev-sans-first:20.27 16:14:49 INFO - PROCESS | 2104 | Values: 97.0 97.0 139.0 96.0 97.0 97.0 136.0 97.0 97.0 137.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 16:14:49 INFO - PROCESS | 2104 | Values: 109.0 111.0 110.0 111.0 109.0 111.0 110.0 112.0 110.0 111.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 16:14:49 INFO - PROCESS | 2104 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 149.0 147.0 147.0 147.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:14:49 INFO - PROCESS | 2104 | Values: 97.0 97.0 96.0 98.0 97.0 96.0 96.0 97.0 97.0 97.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:61.00 stddev:1.78 (2.9%) stddev-sans-first:1.81 16:14:49 INFO - PROCESS | 2104 | Values: 62.0 61.0 60.0 63.0 63.0 60.0 60.0 61.0 58.0 58.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.94 (1.4%) stddev-sans-first:0.93 16:14:49 INFO - PROCESS | 2104 | Values: 68.0 69.0 69.0 68.0 69.0 70.0 71.0 69.0 69.0 68.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.00 stddev:3.53 (4.0%) stddev-sans-first:3.48 16:14:49 INFO - PROCESS | 2104 | Values: 93.0 87.0 88.0 98.0 87.0 88.0 88.0 89.0 88.0 87.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:122.00 stddev:3.80 (3.1%) stddev-sans-first:4.00 16:14:49 INFO - PROCESS | 2104 | Values: 121.0 121.0 119.0 126.0 121.0 120.0 130.0 123.0 125.0 117.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:153.00 stddev:5.10 (3.3%) stddev-sans-first:3.31 16:14:49 INFO - PROCESS | 2104 | Values: 140.0 157.0 152.0 152.0 155.0 147.0 154.0 150.0 151.0 157.0 16:14:49 INFO - PROCESS | 2104 | 16:14:49 INFO - PROCESS | 2104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:3.74 (5.4%) stddev-sans-first:3.78 16:14:49 INFO - PROCESS | 2104 | Values: 66.0 67.0 69.0 69.0 71.0 67.0 67.0 68.0 69.0 79.0 16:14:49 INFO - PROCESS | 2104 | -------- Summary: end -------- 16:14:49 INFO - PROCESS | 2104 | 16:14:50 INFO - TEST-INFO | 2104: exit 0 16:14:50 INFO - TEST-OK | kraken | took 60186ms 16:14:50 INFO - TEST-START | v8_7 16:14:50 INFO - operating with platform_type : linux_ 16:14:50 INFO - Initialising browser for v8_7 test... 16:14:50 INFO - TEST-INFO | started process 2468 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIZlZof/profile http://localhost:35901/getInfo.html) 16:14:54 INFO - PROCESS | 2468 | __metrics Screen width/height:1600/1200 16:14:54 INFO - PROCESS | 2468 | colorDepth:24 16:14:54 INFO - PROCESS | 2468 | Browser inner width/height: 1024/697 16:14:54 INFO - PROCESS | 2468 | __metrics 16:14:54 INFO - PROCESS | 2468 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:14:55 INFO - TEST-INFO | 2468: exit 0 16:14:55 INFO - Browser initialized. 16:14:55 INFO - Running cycle 1/1 for v8_7 test... 16:14:55 INFO - TEST-INFO | started process 2609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIZlZof/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:07 INFO - PROCESS | 2609 | RSS: Main: 149291008 16:15:07 INFO - PROCESS | 2609 | 16:15:28 INFO - PROCESS | 2609 | Cycle 1(1): loaded http://localhost:35901/tests/v8_7/run.html (next: http://localhost:35901/tests/v8_7/run.html) 16:15:29 INFO - PROCESS | 2609 | RSS: Main: 146030592 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | __start_tp_report 16:15:29 INFO - PROCESS | 2609 | _x_x_mozilla_page_load 16:15:29 INFO - PROCESS | 2609 | _x_x_mozilla_page_load_details 16:15:29 INFO - PROCESS | 2609 | |i|pagename|runs| 16:15:29 INFO - PROCESS | 2609 | |0;Richards;166.80567139282735 16:15:29 INFO - PROCESS | 2609 | |1;DeltaBlue;197.667523225934 16:15:29 INFO - PROCESS | 2609 | |2;Encrypt;285.30670470756064 16:15:29 INFO - PROCESS | 2609 | |3;Decrypt;5229.166666666667 16:15:29 INFO - PROCESS | 2609 | |4;RayTrace;1049.3179433368311 16:15:29 INFO - PROCESS | 2609 | |5;Earley;725.6894049346879 16:15:29 INFO - PROCESS | 2609 | |6;Boyer;12358.024691358025 16:15:29 INFO - PROCESS | 2609 | |7;RegExp;25769.23076923077 16:15:29 INFO - PROCESS | 2609 | |8;Splay;630.9148264984227 16:15:29 INFO - PROCESS | 2609 | |9;NavierStokes;4840.579710144928 16:15:29 INFO - PROCESS | 2609 | __end_tp_report 16:15:29 INFO - PROCESS | 2609 | __startTimestamp1451261729157__endTimestamp 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | ------- Summary: start ------- 16:15:29 INFO - PROCESS | 2609 | Number of tests: 10 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 166.8 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#1] DeltaBlue Cycles:1 Average:197.67 Median:197.67 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 197.7 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#2] Encrypt Cycles:1 Average:285.31 Median:285.31 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 285.3 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 5229.2 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#4] RayTrace Cycles:1 Average:1049.32 Median:1049.32 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 1049.3 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#5] Earley Cycles:1 Average:725.69 Median:725.69 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 725.7 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 12358.0 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#7] RegExp Cycles:1 Average:25769.23 Median:25769.23 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 25769.2 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#8] Splay Cycles:1 Average:630.91 Median:630.91 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 630.9 16:15:29 INFO - PROCESS | 2609 | 16:15:29 INFO - PROCESS | 2609 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:15:29 INFO - PROCESS | 2609 | Values: 4840.6 16:15:29 INFO - PROCESS | 2609 | -------- Summary: end -------- 16:15:29 INFO - PROCESS | 2609 | 16:15:30 INFO - TEST-INFO | 2609: exit 0 16:15:30 INFO - TEST-OK | v8_7 | took 39694ms 16:15:30 INFO - SUITE-END | took 1210s 16:15:30 INFO - Completed test suite (00:20:10) 16:15:30 INFO - Working with test: dromaeo_css 16:15:30 INFO - Generating results file: dromaeo_css 16:15:30 INFO - Working with test: kraken 16:15:30 INFO - Generating results file: kraken 16:15:30 INFO - javascript benchmark 16:15:30 INFO - Working with test: v8_7 16:15:30 INFO - Generating results file: v8_7 16:15:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:15:30 INFO - process_Request line: dromaeo_css 6828.57 graph.html#tests=[[72,63,43]] 16:15:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:30 INFO - process_Request line: kraken 1532.70 graph.html#tests=[[232,63,43]] 16:15:30 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:15:30 INFO - process_Request line: v8_7 21054.57 graph.html#tests=[[230,63,43]] 16:15:30 INFO - RETURN: dromaeo_css: 6828.57 16:15:30 INFO - RETURN: kraken: 1532.70 16:15:30 INFO - RETURN: v8_7: 21054.57 16:15:30 INFO - javascript benchmark 16:15:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3135.278885856253, 3189.521571764235, 3198.056573310873, 3203.535487354335, 3233.8221397823127, 5205.8698532536655, 5253.60597955153, 5254.422013578508, 5308.044551980642, 5308.044551980652, 5193.558547523465, 5212.921806172911, 5219.060569097561, 5222.843314700555, 5232.764525596348, 4794.928076078853, 4816.686915350509, 4853.878653033667, 4873.122837889178, 4895.0209958008545, 4870.123377792013, 4945.184044632631, 4947.554720075193, 4954.232094025414, 5030.270610761438, 4935.728534930578, 4942.481039490855, 4959.156943319626, 4975.104481193383, 4996.650234483587, 4758.405199350082, 4877.6829506081995, 4891.51084891508, 4892.902141957141, 4915.557599815998, 4824.903501929977, 4870.196417591093, 4871.512848715136, 4893.510648935114, 4936.136176169156, 5067.290579318861, 5177.637565370425, 5194.428612852583, 5232.110541208004, 5265.684058956436, 5719.542436605062, 5723.112917497794, 5761.366249712528, 5765.0, 5797.217375654275, 5808.738606762706, 5821.53427725781, 5846.473817356416, 5847.0, 5858.912116318259, 5270.6574072685535, 5298.337707786527, 5440.782368705287, 5451.046066938309, 5476.698781567012, 5736.827895163152, 5825.300963884361, 5831.241938547962, 5899.292084949748, 5908.0, 5553.16702494629, 5614.775408983676, 5620.606557540933, 5620.690862002547, 5635.464630860061, 5681.943180568224, 5713.542916566747, 5717.313922329264, 5726.0838265877255, 5773.220615216976, 5554.638948468337, 5577.609567330329, 5582.051051321285, 5647.0964645656495, 5654.717264136777, 5549.72251387429, 5582.078956972054, 5589.692566908778, 5592.552595792326, 5615.803446879339, 4312.245357062501, 4334.28484300087, 4389.1660584488845, 4389.648828093745, 4413.1394378095965, 3924.6664033557468, 3942.448057271984, 3953.604639536081, 3966.2067586482817, 3994.7603143811466, 5235.240890070919, 5279.709615971158, 5307.867303317371, 5311.362636483646, 5364.275822763955, 5600.4959553640365, 5700.572457065654, 5717.285339332583, 5759.308882934075, 5847.210626565359, 5208.895822083613, 5252.606054545924, 5301.893962120736, 5312.0, 5314.096603577401, 4977.32806071183, 4982.850514484571, 4989.775460104304, 5007.298978143063, 5040.621953353513, 5719.370869204384, 5774.711264436762, 5796.101604251264, 5837.591368604242, 5912.201852749909, 5747.683877386784, 5763.135529670415, 5770.711464426846, 5772.336181339199, 5790.334111577054, 5748.0, 5821.476067153976, 5829.621074630136, 5877.0, 5900.350961394157, 5639.689817060101, 5695.7436915338085, 5708.857278568069, 5711.171880077449, 5762.337331206965, 5702.60081794287, 5714.428557144252, 5739.196512488338, 5760.0783874579865, 5770.192173095854, 5515.365732940763, 5585.385607583244, 5586.301712285965, 5624.634398764068, 5625.324961004706, 5526.972365138148, 5660.29246344207, 5740.368559458373, 5752.913706294493, 5784.4504772046585, 5451.0, 5492.038893193755, 5506.531944784738, 5514.393416724238, 5529.474699903502, 5476.507114359727, 5593.972030139823, 5623.634463759842, 5632.183333416549, 5674.460926212003, 5527.391986881359, 5551.916721249104, 5614.270144881302, 5619.044762390322, 5671.517920976763], "unit": "score", "name": "dojo.html", "value": 5270.4545232954}, {"lowerIsBetter": false, "replicates": [534.7039644056845, 599.098356972756, 604.6402390577605, 607.9240094988127, 610.2280615021995, 34227.31545369094, 34479.13802154947, 34601.82699086508, 34743.0, 34839.47740783887, 38444.80777596108, 38682.80658596703, 38798.61201387992, 38901.610983890154, 39109.41335879957, 8349.206825351597, 8424.789380265513, 8451.154884511561, 8486.78783030423, 8510.78723031926, 8301.750947471586, 8390.83218335633, 8429.536375499345, 8464.78838029048, 8465.195806398382, 8488.193621605938, 8660.0, 8686.522241276758, 8689.695860644879, 8704.086070962552, 8615.526146061964, 8706.825863482758, 8730.51982140982, 8730.563471826415, 8764.430312029697, 8441.282490988273, 8564.957175214146, 8606.053334133241, 8624.61189246479, 8642.827143457158, 39272.0, 39564.0, 39564.20871582552, 39858.800705996575, 39888.80055599703, 2982.4184284064618, 3030.969690303091, 3162.699543543383, 3184.2039490127468, 3670.541182352206, 28231.57652635212, 28714.71285287162, 28740.42519149605, 29253.853730731422, 29370.265743356587, 3588.102974256436, 3606.819659017065, 3702.9259414811822, 3752.43713442983, 3768.5289338832645, 256875.0, 260458.0, 260469.9999999981, 260488.0, 261081.0, 51877.74061129746, 58328.0, 58418.707906461044, 58551.12173317403, 58849.0, 47703.76148119237, 63500.682496588146, 64239.678801605696, 64523.67738161279, 64567.35432645614, 13494.190348579117, 13527.120737152054, 13573.253471059186, 13619.659508512168, 13643.113197642122, 10412.47937603132, 10478.214133939984, 10483.056524912794, 10501.054905058581, 10507.159427245802, 19411.3206037788, 19541.68269494959, 20097.19611215564, 20263.696044559343, 20298.39104826828, 7789.961050194713, 7826.530408175528, 7927.246911543394, 7937.166597507294, 8043.11525732169, 923.6859467780987, 939.3800091939287, 984.9409035457895, 1039.0, 1135.846660700795, 27908.30229244285, 28096.85951570229, 28301.71698283032, 28482.572761408595, 28639.85680071628, 1030.3508789462592, 1047.8847326794046, 1095.1622009162998, 1110.8778034416207, 1118.8713297970676, 13747.793783093262, 13968.790468142986, 15826.208689565476, 16385.754213686803, 16408.83591164073, 275764.0, 277850.0, 277896.0, 278072.0, 281277.0, 48495.0, 48596.27105593419, 48612.75693621509, 48910.0, 49054.28310009133, 1294.643972907458, 1303.2636560343376, 1308.9541866034642, 1321.1082519299628, 1333.9466421343038, 27886.745096470302, 29312.706872930998, 29793.851030745576, 29852.253693657833, 30064.3987120252, 45205.0, 45570.08859822851, 45796.7710161447, 45902.77048614869, 45944.54055459402, 288951.0, 290133.0, 290825.0, 291226.0, 291637.0, 30711.0, 41215.79392103021, 42089.0, 42388.36417453802, 42585.0, 38209.0, 38412.2317553653, 38801.0, 38961.805190973864, 39410.80294598509, 32061.0, 32077.839610801795, 32266.516002260454, 32984.83507582447, 33157.50263745998, 34714.0, 35253.471197932566, 35475.290494190485, 35675.0, 35688.28623427465, 33098.83450582732, 33739.15652108717, 33790.49314260337, 33913.49129763006, 34112.317753645286, 29420.852895735385, 32192.517112243804, 32523.18692032718, 32527.34945301128, 32590.34819303648, 24537.0, 26982.32544186411, 28127.71872281251, 28183.0, 28376.43247135087], "unit": "score", "name": "ext.html", "value": 18043.663748754807}, {"lowerIsBetter": false, "replicates": [349.43740577669945, 351.1099363114505, 351.506133881896, 360.41252758004464, 361.1566991075838, 16996.575085622866, 17521.21154548045, 17576.121193940315, 17852.196651150713, 18047.819521804777, 14890.404383824662, 14982.576655217765, 15134.545963621082, 15158.090514569134, 15234.54296371108, 4760.714357138574, 4875.268709693539, 4891.5842153416825, 4909.582685471739, 4962.950370496285, 4847.612191024709, 4925.532074452939, 4931.679440836352, 4960.479149689285, 4976.203807390818, 4278.37963495293, 5173.017126745906, 5315.229291752694, 5327.440618735035, 5371.59713021523, 5302.681839089629, 5312.867178320535, 5360.142377219626, 5377.596680248997, 5379.085555455582, 5129.230615407681, 5139.614528910347, 5144.536991670768, 5149.201873709581, 5296.496832800878, 12882.291473968928, 12922.095453318272, 12954.352282385844, 15373.692526149527, 19359.612807743768, 1952.8535359847926, 2050.8974551272377, 2059.3101311060814, 2092.6442504774227, 2093.2359688713664, 8943.373963822534, 9014.143656352702, 9171.633134674605, 9277.35058545902, 9407.153356197907, 1798.847097996672, 1812.8277813607685, 1814.6189300246965, 1820.836124748779, 1847.353426300784, 57587.712061439845, 61873.690631547004, 62209.37790622081, 62282.68858655723, 64142.3585764141, 10259.692209233586, 10321.0, 10335.689929302132, 10345.844812327821, 10461.372317660966, 13551.661208469866, 13608.115472494255, 13610.0, 13636.65908352299, 13715.519956801463, 7568.735094271784, 7671.501352412075, 7690.769276921701, 7733.072031356273, 7779.4943328684585, 7276.890846637305, 7352.0, 7407.962960185165, 7423.4061275097865, 7453.478256522099, 4511.0, 4540.79668887745, 4541.659375546781, 4544.772911313927, 4568.269076947672, 1824.042377751691, 1844.4190080124717, 1868.588910439701, 1870.4108205915093, 1910.5414700471786, 468.4795798603559, 474.006955428377, 859.6690274244461, 903.8418276801533, 1009.9444530550891, 10656.413897235727, 10887.727806804734, 11220.607278745205, 11313.321200727984, 11643.301401915913, 450.49544510148843, 456.5959126173294, 480.19327529750353, 485.66489122506067, 860.1527495417009, 8752.824943501095, 8758.781030474162, 8801.735947921572, 8901.73294801157, 8991.55042247885, 508218.0, 514847.0, 525860.0, 525880.0, 526092.0, 79524.0, 79626.0, 81091.59454202691, 83346.16653833505, 83618.16381836226, 1115.6597237842373, 1128.7065363005677, 1129.6498085593491, 1140.703417111557, 1169.4620474581789, 14408.639784005065, 14558.854411456174, 14607.92696036513, 14663.56009319722, 14897.702045959237, 32400.189995249366, 32542.53558589822, 32839.67160328366, 33241.667583323855, 33938.15154621055, 45341.31988020116, 46479.30281045719, 46603.30095048509, 46777.83055423642, 47963.520364795906, 9340.953295233481, 9663.806723865624, 9802.411855288705, 9808.411495310304, 9870.0, 11540.480678369662, 11544.884551154717, 11601.883981160081, 11652.126090543074, 13843.307834608027, 14104.36530356157, 14185.290735463392, 14309.356078976263, 14570.417183312973, 14624.780628290797, 13752.93123534376, 13952.302384880919, 14044.227567483886, 14080.507182248572, 14416.927915360357, 14017.369218384993, 14928.776068358766, 15050.247487625795, 15077.849221508084, 15206.619834504227, 9415.105564971316, 9542.666006689733, 9716.368436051634, 9769.071938165864, 9800.31397802147, 13926.860731392557, 14037.859621403655, 14231.928840355731, 14273.0, 14432.061915975428], "unit": "score", "name": "jquery.html", "value": 8331.000428541838}, {"lowerIsBetter": false, "replicates": [1440.3950340856838, 1449.8115245018146, 1616.7251567233568, 1763.312308199803, 1792.471220989808, 7444.776656700301, 7496.662650180741, 7539.132999705035, 7586.96206518968, 7608.353289970352, 7516.098068231806, 7585.279398457138, 7597.92402075979, 7637.968874201981, 7652.961735191317, 2235.094786611421, 2268.1381075191402, 2277.81777457803, 2286.302677683306, 2292.0946226240626, 2259.67234750961, 2263.592553340406, 2274.8293877959136, 2291.873946932918, 2323.256557901472, 2240.260713964396, 2261.208576998054, 2283.6346184610466, 2308.7114110736156, 2319.118734880743, 2255.391044418014, 2270.8069814065825, 2284.4060544258446, 2290.038183962731, 2292.0946226240626, 2281.418238349227, 2295.21962532738, 2304.446932736148, 2310.6418505131733, 2317.9652305215436, 7420.220876807912, 7484.812879677997, 7536.8115797104965, 7550.0, 7554.546727196331, 4648.3259927310355, 4740.810367585327, 4753.857384278477, 4758.738269395182, 4759.952400475986, 3063.6629970703207, 3074.4004919040794, 3129.9843500782576, 3130.906072817819, 3169.3344397676515, 967.4678926590348, 970.5438443931341, 977.5454413697664, 978.7063880835792, 1004.2116938203549, 10215.795684086352, 10280.12618927392, 10370.37777733331, 10376.429296388696, 10441.321314114559, 4003.259397011562, 4021.0, 4040.898977525527, 4070.5929407059057, 4130.318497447887, 8496.107908669625, 8542.145785421408, 8547.871781923277, 8548.316134709332, 8549.786255343666, 4545.113702827917, 4563.95436045642, 4576.382188404589, 4610.631149508032, 4616.330632058332, 4197.769122698281, 4231.809568569422, 4233.7671428071135, 4286.592773686495, 4298.656107511391, 3677.42999835026, 3712.9071773205887, 3721.404575267944, 3735.0662334416397, 3736.869209577652, 1208.456194712383, 1215.1190386969377, 1229.6495498782804, 1229.9508019679113, 1235.1909499277988, 1067.9412632305298, 1072.2708558180357, 1075.5052675769234, 1079.8920107989295, 1112.0158659586164, 6707.664616769142, 6744.359285867835, 6749.898751518731, 6797.1843378794865, 6830.965845170742, 487.9414470263591, 493.1887045809623, 493.88146844757, 499.05429211644457, 504.75519373104015, 5151.459096794782, 5185.481451854785, 5213.6089793265655, 5216.1393370094265, 5265.657732247391, 8619.741407757778, 8816.51509167002, 8893.199612034949, 8981.326400519987, 9090.90909090914, 8882.911170888337, 8987.325950553604, 9030.593623286968, 9061.864072038925, 9114.544272786334, 7039.577625342496, 7091.219965803757, 7117.395021423134, 7172.282771722786, 7219.747308844166, 6485.124508191334, 6576.506761992965, 6577.408033277028, 6609.570377925419, 6616.801495955129, 7908.209179082276, 8088.676452941816, 8105.148959359182, 8127.065387480516, 8244.505329680238, 8197.057338406159, 8253.33973282148, 8277.337812974827, 8326.50040997542, 8468.703595374132, 5865.824025279248, 5942.732577033958, 6214.658193799384, 6418.807435776934, 6486.156799616019, 6815.727370905108, 6847.589144651337, 6893.517453778188, 6907.654617269217, 6940.548864323803, 6365.90451143224, 6424.550281480251, 6454.967725161344, 6561.048647946117, 6646.102776125162, 6455.2576453708425, 6462.515311351762, 6473.352664733489, 6516.0, 6611.206655201407, 6330.778422755181, 6341.460975816923, 6361.173047503795, 6372.840678982877, 6387.329330420239, 5711.3431955324, 5788.479036886701, 5824.446677565794, 5972.58191926561, 5989.490893273946, 6038.275406951194, 6051.4553690168095, 6058.303295121117, 6066.332703402711, 6067.271927368744], "unit": "score", "name": "mootools.html", "value": 4238.926914698963}, {"lowerIsBetter": false, "replicates": [329.59789057350025, 334.02964388451556, 339.3958753418914, 339.80291430970027, 350.9877154299599, 6239.6880155992185, 6261.060840873871, 6279.905801412982, 6311.305756366796, 6438.098666186737, 6171.259448866131, 6236.9708998015385, 6247.468965137969, 6270.372962703727, 6306.0, 4763.880902977418, 4766.165920963835, 4775.3075804008395, 4775.90448191036, 4783.33033375326, 4773.140834649762, 4779.378680771495, 4783.067301876135, 4804.711717296956, 4815.229563269878, 4609.446866376023, 4727.66906316558, 4728.550787675165, 4739.052189562084, 4739.838739508825, 4684.484706682262, 4716.410448693913, 4721.881952951169, 4723.811047558111, 4725.149473094842, 4091.9795401023102, 4102.917941641151, 4105.5894410559, 4108.1783643271465, 4109.835606575733, 5925.555583331225, 5931.495822855062, 5942.0, 5984.132300816401, 6009.729562169669, 5417.377001644822, 5526.171074338841, 5528.9723551381985, 5536.169574563807, 5547.611667183299, 6611.636360000198, 6648.700808463631, 6660.833479163011, 6671.666416679195, 6674.799756007327, 4568.680192386534, 4568.908621827578, 4570.177368073779, 4574.839880604196, 4578.725276483422, 6822.556533825285, 6919.204291506491, 6928.4803639726715, 6959.269276725921, 7012.298770122947, 4615.215413379667, 4616.746078965689, 4631.8378856739855, 4632.119897219518, 4651.209294419957, 4667.0, 4692.835750748707, 4700.764961751899, 4701.965567575128, 4708.952910470852, 5481.369642491165, 5498.697571633518, 5500.22996780451, 5504.4495550444635, 5505.201745746845, 6590.7693230736695, 6686.732530698718, 6739.326067393319, 6756.290589488131, 6775.424088952395, 1629.1121338870344, 1656.2712406541084, 1680.1683166832497, 1680.4118558504426, 1683.7474378843026, 1109.1459576126338, 1122.1135303110614, 1126.8760436351995, 1127.182792475465, 1134.914881383883, 6196.845078872974, 6221.751129954751, 6283.937160628427, 6297.338779428094, 6299.275583307886, 6853.383195512428, 6863.828404289933, 6871.759488417982, 6874.106366172366, 6897.62063086525, 6063.454289114001, 6190.071489276645, 6191.628502289877, 6196.0705894115345, 6197.876042479125, 3740.17716102457, 3744.5319335083113, 3766.642168993941, 3767.4348847672522, 3773.52830896138, 7022.1924478685605, 7024.332688394595, 7045.11936007999, 7056.470764692566, 7066.505344625827, 6988.44092472601, 7076.044733960953, 7117.074780278531, 7118.60847653384, 7150.642467876585, 7156.60638664868, 7194.136703595602, 7218.169910460364, 7224.530405523729, 7227.385672217815, 7014.508984371045, 7016.824784316878, 7029.789106326818, 7033.261507541839, 7040.8591828162125, 6823.488238382042, 6897.448204143757, 6933.0986971693355, 6958.79123626292, 6982.581045137308, 7175.712971481083, 7179.605121718147, 7182.0, 7191.820204494929, 7203.747868824566, 4662.440507139165, 4711.740854253049, 4723.598494128038, 4729.5034021427255, 4739.952600473951, 6867.381935625817, 7042.225355211025, 7042.43660507148, 7054.118235220598, 7066.540674856118, 6783.762568310085, 6816.522843401112, 6841.555298905555, 6850.246472888078, 6859.314068593101, 6785.321467853175, 6786.524943253925, 6807.3873351398615, 6821.795346139624, 6822.044913711985, 6525.314841941527, 6663.866722665616, 6670.166229221348, 6674.83312917181, 6688.163979502562, 6828.453723701992, 6830.556013859084, 6841.281665425257, 6856.417204537471, 6872.965635171992, 6633.336666333328, 6636.966815165893, 6663.633500157344, 6664.633445160563, 6696.899546506904], "unit": "score", "name": "prototype.html", "value": 5020.852276496566}, {"lowerIsBetter": false, "replicates": [697.5953946710906, 702.3573430311263, 764.8929149919009, 778.2023425988361, 786.9881951770725, 11595.478203480843, 11709.355985420787, 11732.882671173285, 11799.528018879246, 11824.58613948512, 11396.0, 11727.765444691102, 11947.0, 12903.419346129424, 13075.73848523029, 797.7088362747585, 816.6733306677347, 816.9019717633893, 820.3888103363003, 820.4871955028108, 801.819590592115, 811.452269717941, 815.3843847894831, 815.7838172884191, 821.3593397150232, 844.7085755414372, 848.9702860399888, 850.1668365002301, 851.7402192331336, 857.4940784936886, 837.7779888329597, 844.8099177685033, 845.2266176448542, 846.2848892685671, 848.1433751910583, 622.2346513788066, 625.8810825943057, 626.6647343671114, 628.1237673445518, 632.3549979021418, 11952.223105498115, 12130.393480325949, 12155.817662734979, 12176.878231217752, 12179.39103044853, 9582.56878440465, 9804.215662747034, 10567.15462762977, 10648.307859989076, 10753.51609177589, 8742.213200811893, 8979.506127163004, 9106.86339704905, 9218.308626853013, 9395.90604093964, 3383.4586466165297, 3528.1179705073732, 3541.3979623463815, 3556.1287484566446, 3556.7332450066347, 43697.78151109256, 44625.0, 44626.55373446256, 48727.75636121832, 49065.264021039715, 9224.215941645036, 9247.815043699224, 9286.442813431217, 9328.300377471716, 9457.243420526342, 17633.0, 17798.37705680295, 17890.463286101436, 18044.819551804576, 18168.63662726738, 7511.286427789351, 7624.923750762532, 7638.770836874903, 7690.192529784404, 7772.961135194288, 4382.408374869352, 4389.934150987738, 4401.2297847877135, 4411.228035093845, 4428.889277768081, 3062.433449811792, 3069.9869043215685, 3078.0458058001645, 3085.5988721466065, 3096.5974423324824, 524.7087866234276, 543.5054100768361, 553.82000849724, 555.5028249716481, 555.7304707217078, 524.8346770767196, 564.25800072904, 581.656822474742, 603.4439978164838, 617.1236843681983, 7726.304632583095, 7820.178881217504, 7826.295633393022, 7915.802104947423, 8046.718364857202, 571.4656795895851, 580.3702982264206, 595.8569943213685, 602.7227475361383, 620.8975519039308, 3609.115766637138, 3819.4461803038403, 3866.516685414323, 3952.5849785772657, 3987.0, 52694.0, 53757.73121134369, 54060.18909716357, 54147.45852541503, 54234.72882635562, 48872.755636222304, 49431.75284123556, 49702.0, 50498.0, 51010.74494627503, 46195.307070393974, 48756.0, 49110.0, 50482.49517504851, 50613.74693126584, 7984.321332686554, 8017.478863873829, 8251.793705157419, 8305.0, 8432.45189062709, 33003.0, 34110.829445852614, 34693.0, 35315.293694126485, 35465.0, 38539.42190867083, 39045.21909561736, 40413.0, 43868.90327741832, 43870.0, 10644.574217031231, 10928.180386471206, 10935.512988664415, 10944.616938407118, 11271.436428178722, 10578.100861426865, 10677.305975111592, 10691.625793097204, 10897.75299425873, 11552.768944621228, 10208.591656333663, 10400.895991039994, 10658.573657053632, 10705.89294107049, 10931.196134825852, 10863.185261105291, 10956.0, 11042.447877606248, 11256.043236325004, 11527.0, 9905.356151850106, 9999.500024998575, 10072.446015468926, 10245.897541024495, 10404.947975260075, 9440.197583205505, 9544.33189676716, 9835.950820245853, 9893.703188904345, 9973.750656233362, 8556.358273129665, 8797.648094076421, 8973.587956344727, 9247.39891907024, 9592.136707696342], "unit": "score", "name": "yui.html", "value": 6012.243772594334}], "name": "dromaeo_css", "value": 6828.568666681087}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 104.0, 113.0, 112.0, 113.0, 123.0, 113.0, 111.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 163.0, 168.0, 135.0, 152.0, 162.0, 127.0, 166.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [163.0, 167.0, 163.0, 166.0, 162.0, 164.0, 168.0, 170.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 165.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 76.0, 74.0, 74.0, 74.0, 73.0, 133.0, 80.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 96.0, 97.0, 97.0, 136.0, 97.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 111.0, 109.0, 111.0, 110.0, 112.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 60.0, 63.0, 63.0, 60.0, 60.0, 61.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 70.0, 71.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 88.0, 98.0, 87.0, 88.0, 88.0, 89.0, 88.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 119.0, 126.0, 121.0, 120.0, 130.0, 123.0, 125.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 157.0, 152.0, 152.0, 155.0, 147.0, 154.0, 150.0, 151.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 69.0, 71.0, 67.0, 67.0, 68.0, 69.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1532.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [197.667523225934], "unit": "score", "name": "DeltaBlue", "value": 334.4909619999999}, {"lowerIsBetter": false, "replicates": [285.30670470756064], "unit": "score", "name": "Encrypt", "value": 932.9644049999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1049.3179433368311], "unit": "score", "name": "RayTrace", "value": 705.2095169999998}, {"lowerIsBetter": false, "replicates": [725.6894049346879], "unit": "score", "name": "Earley", "value": 918.3860139999999}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [25769.23076923077], "unit": "score", "name": "RegExp", "value": 35.3516567164179}, {"lowerIsBetter": false, "replicates": [630.9148264984227], "unit": "score", "name": "Splay", "value": 129.16323500000001}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21054.567846965467}]} 16:15:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21054.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1532.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6828.57"}}} 16:15:30 INFO - Return code: 0 16:15:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:15:30 INFO - # TBPL SUCCESS # 16:15:30 INFO - Running post-action listener: _resource_record_post_action 16:15:30 INFO - Running post-run listener: _resource_record_post_run 16:15:31 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 24576; Write bytes: 561168384; Read time: 72; Write time: 575176 16:15:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242073600; Read time: 0; Write time: 394596 16:15:31 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 24576; Write bytes: 319094784; Read time: 72; Write time: 180580 16:15:31 INFO - Running post-run listener: _upload_blobber_files 16:15:31 INFO - Blob upload gear active. 16:15:31 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:15:31 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 16:15:31 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:15:31 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:15:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:15:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:32 INFO - (blobuploader) - INFO - Done attempting. 16:15:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:15:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:34 INFO - (blobuploader) - INFO - Done attempting. 16:15:34 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:34 INFO - Return code: 0 16:15:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:15:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e2aade067913d91a0c34201d833809ef83d3333d38613bd6c8802de43abaf32761e9fa0e1a46251a605312741e67bcbe9a1040373d6e7d5336700a47d64aeb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b248d8ccdb186624c3c14847a3bc1f1a7a31e74ec141f362a5f8bff2aec5f1a510a9ff29244c2da587ff4d78565bc07920d8f8455b05fd804268084ac31db0"} 16:15:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:15:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:15:34 INFO - Contents: 16:15:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e2aade067913d91a0c34201d833809ef83d3333d38613bd6c8802de43abaf32761e9fa0e1a46251a605312741e67bcbe9a1040373d6e7d5336700a47d64aeb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b248d8ccdb186624c3c14847a3bc1f1a7a31e74ec141f362a5f8bff2aec5f1a510a9ff29244c2da587ff4d78565bc07920d8f8455b05fd804268084ac31db0"} 16:15:34 INFO - Copying logs to upload dir... 16:15:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.662053 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-27 16:15:34.562982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-27 16:15:34.566551) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 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-Inbound/sha512/e2aade067913d91a0c34201d833809ef83d3333d38613bd6c8802de43abaf32761e9fa0e1a46251a605312741e67bcbe9a1040373d6e7d5336700a47d64aeb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b248d8ccdb186624c3c14847a3bc1f1a7a31e74ec141f362a5f8bff2aec5f1a510a9ff29244c2da587ff4d78565bc07920d8f8455b05fd804268084ac31db0"} build_url:https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/wT-D_Zd3STCAlSUF7vkjaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e2aade067913d91a0c34201d833809ef83d3333d38613bd6c8802de43abaf32761e9fa0e1a46251a605312741e67bcbe9a1040373d6e7d5336700a47d64aeb25", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b248d8ccdb186624c3c14847a3bc1f1a7a31e74ec141f362a5f8bff2aec5f1a510a9ff29244c2da587ff4d78565bc07920d8f8455b05fd804268084ac31db0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-27 16:15:34.592124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 16:15:34.592628) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451259497.676609-1888515444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-27 16:15:34.678382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-27 16:15:34.678756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-27 16:15:34.679142) ========= ========= Total master_lag: 0.24 =========