builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1460339233.34 results: success (0) buildid: 20160410163003 builduid: dcc5ae9ec32a487b9d28b1d4a11c5168 revision: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.340058) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.341773) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.342539) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006356 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.379899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.380267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.439088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.439393) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.493025) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.493334) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.493724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.494029) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-10 18:47:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 39.2M=0s 2016-04-10 18:47:13 (39.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.682676) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.682990) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016417 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.733047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:13.733470) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8803d34bd9f8278b62c542e0ec5446148ce08fe7 --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 8803d34bd9f8278b62c542e0ec5446148ce08fe7 --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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-10 18:47:14,070 truncating revision to first 12 chars 2016-04-10 18:47:14,070 Setting DEBUG logging. 2016-04-10 18:47:14,070 attempt 1/10 2016-04-10 18:47:14,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8803d34bd9f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-10 18:47:14,694 unpacking tar archive at: mozilla-inbound-8803d34bd9f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.668774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.669079) ========= echo 8803d34bd9f8278b62c542e0ec5446148ce08fe7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8803d34bd9f8278b62c542e0ec5446148ce08fe7'] 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8803d34bd9f8278b62c542e0ec5446148ce08fe7 program finished with exit code 0 elapsedTime=0.004729 script_repo_revision: '8803d34bd9f8278b62c542e0ec5446148ce08fe7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.719628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.719893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-10 18:47:14.729415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-10 18:47:14.729703) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:15 INFO - MultiFileLogger online at 20160410 18:47:15 in /builds/slave/test-pgo 18:47:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:47:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:47:15 INFO - {'append_to_log': False, 18:47:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:47:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:47:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:47:15 INFO - 'branch': 'Mozilla-Inbound', 18:47:15 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:15 INFO - 'config_files': ('talos/linux_config.py',), 18:47:15 INFO - 'default_actions': ('clobber', 18:47:15 INFO - 'read-buildbot-config', 18:47:15 INFO - 'download-and-extract', 18:47:15 INFO - 'populate-webroot', 18:47:15 INFO - 'create-virtualenv', 18:47:15 INFO - 'install', 18:47:15 INFO - 'run-tests'), 18:47:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:15 INFO - 'download_minidump_stackwalk': True, 18:47:15 INFO - 'download_symbols': 'ondemand', 18:47:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:15 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:15 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:15 INFO - 'installer_path': 'installer.exe', 18:47:15 INFO - 'log_level': 'info', 18:47:15 INFO - 'log_name': 'talos', 18:47:15 INFO - 'log_to_console': True, 18:47:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:15 INFO - 'opt_config_files': (), 18:47:15 INFO - 'pip_index': False, 18:47:15 INFO - 'sps_profile': False, 18:47:15 INFO - 'sps_profile_interval': 0, 18:47:15 INFO - 'suite': 'dromaeojs', 18:47:15 INFO - 'system_bits': '32', 18:47:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:15 INFO - 'title': 'talos-linux64-ix-012', 18:47:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:15 INFO - 'use_talos_json': True, 18:47:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:47:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:15 INFO - 'work_dir': 'build'} 18:47:15 INFO - ##### 18:47:15 INFO - ##### Running clobber step. 18:47:15 INFO - ##### 18:47:15 INFO - Running pre-action listener: _resource_record_pre_action 18:47:15 INFO - Running main action method: clobber 18:47:15 INFO - rmtree: /builds/slave/test-pgo/build 18:47:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:47:15 INFO - Running post-action listener: _resource_record_post_action 18:47:15 INFO - ##### 18:47:15 INFO - ##### Running read-buildbot-config step. 18:47:15 INFO - ##### 18:47:15 INFO - Running pre-action listener: _resource_record_pre_action 18:47:15 INFO - Running main action method: read_buildbot_config 18:47:15 INFO - Using buildbot properties: 18:47:15 INFO - { 18:47:15 INFO - "project": "", 18:47:15 INFO - "product": "firefox", 18:47:15 INFO - "script_repo_revision": "production", 18:47:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:47:15 INFO - "repository": "", 18:47:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:47:15 INFO - "buildid": "20160410163003", 18:47:15 INFO - "pgo_build": "True", 18:47:15 INFO - "basedir": "/builds/slave/test-pgo", 18:47:15 INFO - "buildnumber": 843, 18:47:15 INFO - "slavename": "talos-linux64-ix-012", 18:47:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:47:15 INFO - "platform": "ubuntu64_hw", 18:47:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:47:15 INFO - "branch": "mozilla-inbound", 18:47:15 INFO - "repo_path": "integration/mozilla-inbound", 18:47:15 INFO - "revision": "8803d34bd9f8278b62c542e0ec5446148ce08fe7", 18:47:15 INFO - "stage_platform": "linux64-pgo", 18:47:15 INFO - "builduid": "dcc5ae9ec32a487b9d28b1d4a11c5168", 18:47:15 INFO - "slavebuilddir": "test" 18:47:15 INFO - } 18:47:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:47:15 INFO - Running post-action listener: _resource_record_post_action 18:47:15 INFO - ##### 18:47:15 INFO - ##### Running download-and-extract step. 18:47:15 INFO - ##### 18:47:15 INFO - Running pre-action listener: _resource_record_pre_action 18:47:15 INFO - Running main action method: download_and_extract 18:47:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:15 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:47:19 INFO - Downloaded 1361 bytes. 18:47:19 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:47:19 INFO - Using the following test package requirements: 18:47:19 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:19 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:19 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:47:19 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'jsshell-linux-x86_64.zip'], 18:47:19 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:19 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:19 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:19 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:19 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:19 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:19 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:19 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:22 INFO - Downloaded 23762467 bytes. 18:47:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:23 INFO - Return code: 0 18:47:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:47:23 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')]} 18:47:23 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:47:25 INFO - Downloaded 23762467 bytes. 18:47:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:26 INFO - Return code: 0 18:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:26 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:47:28 INFO - Downloaded 10841046 bytes. 18:47:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:47:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:47:28 INFO - Return code: 0 18:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:28 INFO - https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:47:30 INFO - Downloaded 57786549 bytes. 18:47:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:30 INFO - mkdir: /builds/slave/test-pgo/properties 18:47:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:47:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:47:30 INFO - Contents: 18:47:30 INFO - build_url:https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:47:31 INFO - Running post-action listener: _resource_record_post_action 18:47:31 INFO - Running post-action listener: set_extra_try_arguments 18:47:31 INFO - ##### 18:47:31 INFO - ##### Running populate-webroot step. 18:47:31 INFO - ##### 18:47:31 INFO - Running pre-action listener: _resource_record_pre_action 18:47:31 INFO - Running main action method: populate_webroot 18:47:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:31 INFO - '--tppagecycles', 18:47:31 INFO - '7'], 18:47:31 INFO - 'tests': ['tsvgm']}}, 18:47:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:47:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:47:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:47:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['damp', 'tps']}, 18:47:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'tests': ['damp', 'tps']}, 18:47:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['dromaeo_dom']}, 18:47:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'other-e10s': {'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['a11yr', 18:47:31 INFO - 'ts_paint', 18:47:31 INFO - 'tpaint', 18:47:31 INFO - 'sessionrestore', 18:47:31 INFO - 'sessionrestore_no_auto_restore', 18:47:31 INFO - 'tabpaint']}, 18:47:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['tsvgx', 18:47:31 INFO - 'tsvgr_opacity', 18:47:31 INFO - 'tart', 18:47:31 INFO - 'tscrollx', 18:47:31 INFO - 'cart']}, 18:47:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:47:31 INFO - 'tsvgr_opacity', 18:47:31 INFO - 'tart', 18:47:31 INFO - 'tscrollx', 18:47:31 INFO - 'cart']}, 18:47:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'talos_options': ['--disable-e10s'], 18:47:31 INFO - 'tests': ['tp5o']}, 18:47:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'tests': ['tp5o']}, 18:47:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'talos_options': ['--disable-e10s', 18:47:31 INFO - '--xperf_path', 18:47:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:31 INFO - 'tests': ['tp5n']}, 18:47:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:31 INFO - 'talos_options': ['--xperf_path', 18:47:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:31 INFO - 'tests': ['tp5n']}}, 18:47:31 INFO - 'talos.zip': {'path': '', 18:47:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:31 INFO - Running post-action listener: _resource_record_post_action 18:47:31 INFO - ##### 18:47:31 INFO - ##### Running create-virtualenv step. 18:47:31 INFO - ##### 18:47:31 INFO - Running pre-action listener: _resource_record_pre_action 18:47:31 INFO - Running main action method: create_virtualenv 18:47:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:47:31 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 18:47:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:47:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:31 INFO - Using real prefix '/usr' 18:47:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:47:32 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:34 INFO - Installing pip.................done. 18:47:34 INFO - Return code: 0 18:47:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:47:34 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')]} 18:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:34 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')]} 18:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:47:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:47:34 INFO - Using env: {'DISPLAY': ':0', 18:47:34 INFO - 'HOME': '/home/cltbld', 18:47:34 INFO - 'LANG': 'en_US.UTF-8', 18:47:34 INFO - 'LANGUAGE': 'en_US:en', 18:47:34 INFO - 'LOGNAME': 'cltbld', 18:47:34 INFO - 'MAIL': '/var/mail/cltbld', 18:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:34 INFO - 'MOZ_NO_REMOTE': '1', 18:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:34 INFO - 'NO_EM_RESTART': '1', 18:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:34 INFO - 'SHELL': '/bin/bash', 18:47:34 INFO - 'SHLVL': '1', 18:47:34 INFO - 'TERM': 'linux', 18:47:34 INFO - 'TMOUT': '86400', 18:47:34 INFO - 'USER': 'cltbld', 18:47:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:34 INFO - '_': '/tools/buildbot/bin/python'} 18:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:34 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 18:47:34 INFO - Cleaning up... 18:47:34 INFO - Return code: 0 18:47:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:47:34 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')]} 18:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:34 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')]} 18:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:47:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:47:34 INFO - Using env: {'DISPLAY': ':0', 18:47:34 INFO - 'HOME': '/home/cltbld', 18:47:34 INFO - 'LANG': 'en_US.UTF-8', 18:47:34 INFO - 'LANGUAGE': 'en_US:en', 18:47:34 INFO - 'LOGNAME': 'cltbld', 18:47:34 INFO - 'MAIL': '/var/mail/cltbld', 18:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:34 INFO - 'MOZ_NO_REMOTE': '1', 18:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:34 INFO - 'NO_EM_RESTART': '1', 18:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:34 INFO - 'SHELL': '/bin/bash', 18:47:34 INFO - 'SHLVL': '1', 18:47:34 INFO - 'TERM': 'linux', 18:47:34 INFO - 'TMOUT': '86400', 18:47:34 INFO - 'USER': 'cltbld', 18:47:34 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:34 INFO - '_': '/tools/buildbot/bin/python'} 18:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:34 INFO - Downloading/unpacking psutil>=0.7.1 18:47:34 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 18:47:34 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 18:47:34 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 18:47:34 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 18:47:34 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 18:47:34 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 18:47:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:47:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:36 INFO - Installing collected packages: psutil 18:47:36 INFO - Running setup.py install for psutil 18:47:36 INFO - building 'psutil._psutil_linux' extension 18:47:36 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 18:47:36 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 18:47:36 INFO - building 'psutil._psutil_posix' extension 18:47:36 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 18:47:36 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 18:47:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:47:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:47:36 INFO - Successfully installed psutil 18:47:36 INFO - Cleaning up... 18:47:37 INFO - Return code: 0 18:47:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:47:37 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')]} 18:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:37 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')]} 18:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:47:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:47:37 INFO - Using env: {'DISPLAY': ':0', 18:47:37 INFO - 'HOME': '/home/cltbld', 18:47:37 INFO - 'LANG': 'en_US.UTF-8', 18:47:37 INFO - 'LANGUAGE': 'en_US:en', 18:47:37 INFO - 'LOGNAME': 'cltbld', 18:47:37 INFO - 'MAIL': '/var/mail/cltbld', 18:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:37 INFO - 'MOZ_NO_REMOTE': '1', 18:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:37 INFO - 'NO_EM_RESTART': '1', 18:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:37 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:37 INFO - 'SHELL': '/bin/bash', 18:47:37 INFO - 'SHLVL': '1', 18:47:37 INFO - 'TERM': 'linux', 18:47:37 INFO - 'TMOUT': '86400', 18:47:37 INFO - 'USER': 'cltbld', 18:47:37 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:37 INFO - '_': '/tools/buildbot/bin/python'} 18:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:47:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:47:39 INFO - Installing collected packages: mozsystemmonitor 18:47:39 INFO - Running setup.py install for mozsystemmonitor 18:47:39 INFO - Successfully installed mozsystemmonitor 18:47:39 INFO - Cleaning up... 18:47:39 INFO - Return code: 0 18:47:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:47:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:47:39 INFO - Using env: {'DISPLAY': ':0', 18:47:39 INFO - 'HOME': '/home/cltbld', 18:47:39 INFO - 'LANG': 'en_US.UTF-8', 18:47:39 INFO - 'LANGUAGE': 'en_US:en', 18:47:39 INFO - 'LOGNAME': 'cltbld', 18:47:39 INFO - 'MAIL': '/var/mail/cltbld', 18:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:39 INFO - 'MOZ_NO_REMOTE': '1', 18:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:39 INFO - 'NO_EM_RESTART': '1', 18:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:39 INFO - 'SHELL': '/bin/bash', 18:47:39 INFO - 'SHLVL': '1', 18:47:39 INFO - 'TERM': 'linux', 18:47:39 INFO - 'TMOUT': '86400', 18:47:39 INFO - 'USER': 'cltbld', 18:47:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:39 INFO - '_': '/tools/buildbot/bin/python'} 18:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:47:39 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 18:47:39 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 18:47:39 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 18:47:39 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 18:47:39 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 18:47:39 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 18:47:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:47:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:41 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 18:47:42 INFO - Downloading docopt-0.6.1.tar.gz 18:47:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:42 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:42 INFO - Running setup.py install for blobuploader 18:47:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:47:42 INFO - Running setup.py install for requests 18:47:42 INFO - Running setup.py install for docopt 18:47:42 INFO - Successfully installed blobuploader requests docopt 18:47:42 INFO - Cleaning up... 18:47:42 INFO - Return code: 0 18:47:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:42 INFO - Using env: {'DISPLAY': ':0', 18:47:42 INFO - 'HOME': '/home/cltbld', 18:47:42 INFO - 'LANG': 'en_US.UTF-8', 18:47:42 INFO - 'LANGUAGE': 'en_US:en', 18:47:42 INFO - 'LOGNAME': 'cltbld', 18:47:42 INFO - 'MAIL': '/var/mail/cltbld', 18:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:42 INFO - 'MOZ_NO_REMOTE': '1', 18:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:42 INFO - 'NO_EM_RESTART': '1', 18:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:42 INFO - 'SHELL': '/bin/bash', 18:47:42 INFO - 'SHLVL': '1', 18:47:42 INFO - 'TERM': 'linux', 18:47:42 INFO - 'TMOUT': '86400', 18:47:42 INFO - 'USER': 'cltbld', 18:47:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:42 INFO - '_': '/tools/buildbot/bin/python'} 18:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:42 INFO - Running setup.py (path:/tmp/pip-MewMQG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:43 INFO - Running setup.py (path:/tmp/pip-sNnb7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:43 INFO - Running setup.py (path:/tmp/pip-2t858j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:43 INFO - Running setup.py (path:/tmp/pip-coy0si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:43 INFO - Running setup.py (path:/tmp/pip-xR7t3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:43 INFO - Running setup.py (path:/tmp/pip-Ffga4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:43 INFO - Running setup.py (path:/tmp/pip-Yu9GNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:43 INFO - Running setup.py (path:/tmp/pip-6PoYHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:43 INFO - Running setup.py (path:/tmp/pip-w4fgCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:43 INFO - Running setup.py (path:/tmp/pip-BTPHVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:43 INFO - Running setup.py (path:/tmp/pip-7OGHAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:43 INFO - Running setup.py (path:/tmp/pip-cq6WbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:43 INFO - Running setup.py (path:/tmp/pip-2t4x9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:43 INFO - Running setup.py (path:/tmp/pip-IddQUT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:43 INFO - Running setup.py (path:/tmp/pip-xMjxCJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:44 INFO - Running setup.py (path:/tmp/pip-qtw7JK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:44 INFO - Running setup.py (path:/tmp/pip-Ws2e4k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:44 INFO - Running setup.py install for manifestparser 18:47:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Running setup.py install for mozcrash 18:47:44 INFO - Running setup.py install for mozdebug 18:47:44 INFO - Running setup.py install for mozdevice 18:47:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Running setup.py install for mozfile 18:47:44 INFO - Running setup.py install for mozhttpd 18:47:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Running setup.py install for mozinfo 18:47:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Running setup.py install for mozInstall 18:47:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:47:44 INFO - Running setup.py install for mozleak 18:47:45 INFO - Running setup.py install for mozlog 18:47:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Running setup.py install for moznetwork 18:47:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Running setup.py install for mozprocess 18:47:45 INFO - Running setup.py install for mozprofile 18:47:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Running setup.py install for mozrunner 18:47:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Running setup.py install for mozscreenshot 18:47:45 INFO - Running setup.py install for moztest 18:47:45 INFO - Running setup.py install for mozversion 18:47:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:47:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:45 INFO - Cleaning up... 18:47:45 INFO - Return code: 0 18:47:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:45 INFO - Using env: {'DISPLAY': ':0', 18:47:45 INFO - 'HOME': '/home/cltbld', 18:47:45 INFO - 'LANG': 'en_US.UTF-8', 18:47:45 INFO - 'LANGUAGE': 'en_US:en', 18:47:45 INFO - 'LOGNAME': 'cltbld', 18:47:45 INFO - 'MAIL': '/var/mail/cltbld', 18:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:45 INFO - 'MOZ_NO_REMOTE': '1', 18:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:45 INFO - 'NO_EM_RESTART': '1', 18:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:45 INFO - 'SHELL': '/bin/bash', 18:47:45 INFO - 'SHLVL': '1', 18:47:45 INFO - 'TERM': 'linux', 18:47:45 INFO - 'TMOUT': '86400', 18:47:45 INFO - 'USER': 'cltbld', 18:47:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:45 INFO - '_': '/tools/buildbot/bin/python'} 18:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:46 INFO - Running setup.py (path:/tmp/pip-ZLDrjH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:46 INFO - Running setup.py (path:/tmp/pip-TbLIXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:46 INFO - Running setup.py (path:/tmp/pip-H5BAcQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:46 INFO - Running setup.py (path:/tmp/pip-J7wtML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:46 INFO - Running setup.py (path:/tmp/pip-s3O1vX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:46 INFO - Running setup.py (path:/tmp/pip-OL9iMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:46 INFO - Running setup.py (path:/tmp/pip-O0bCqi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:46 INFO - Running setup.py (path:/tmp/pip-Zrylo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:46 INFO - Running setup.py (path:/tmp/pip-R7MXG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:46 INFO - Running setup.py (path:/tmp/pip-ENWu5F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:46 INFO - Running setup.py (path:/tmp/pip-L9wkWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:46 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)) 18:47:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:46 INFO - Running setup.py (path:/tmp/pip-rJt4hO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:47 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)) 18:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:47 INFO - Running setup.py (path:/tmp/pip-kgymhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:47 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)) 18:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:47 INFO - Running setup.py (path:/tmp/pip-39CsPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:47 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)) 18:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:47 INFO - Running setup.py (path:/tmp/pip-VnzTz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:47 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)) 18:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:47 INFO - Running setup.py (path:/tmp/pip-thjYAa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:47 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)) 18:47:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:47 INFO - Running setup.py (path:/tmp/pip-lUodsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:47 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)) 18:47:47 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:47 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:47 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)) 18:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:47 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 18:47:47 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 18:47:47 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 18:47:47 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 18:47:47 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 18:47:47 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 18:47:49 INFO - Downloading blessings-1.6.tar.gz 18:47:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:49 INFO - Installing collected packages: blessings 18:47:49 INFO - Running setup.py install for blessings 18:47:49 INFO - Successfully installed blessings 18:47:49 INFO - Cleaning up... 18:47:49 INFO - Return code: 0 18:47:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:47:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:49 INFO - Reading from file tmpfile_stdout 18:47:49 INFO - Current package versions: 18:47:49 INFO - argparse == 1.2.1 18:47:49 INFO - blessings == 1.6 18:47:49 INFO - blobuploader == 1.2.4 18:47:49 INFO - docopt == 0.6.1 18:47:49 INFO - manifestparser == 1.1 18:47:49 INFO - mozInstall == 1.12 18:47:49 INFO - mozcrash == 0.17 18:47:49 INFO - mozdebug == 0.1 18:47:49 INFO - mozdevice == 0.48 18:47:49 INFO - mozfile == 1.2 18:47:49 INFO - mozhttpd == 0.7 18:47:49 INFO - mozinfo == 0.9 18:47:49 INFO - mozleak == 0.1 18:47:49 INFO - mozlog == 3.1 18:47:49 INFO - moznetwork == 0.27 18:47:49 INFO - mozprocess == 0.22 18:47:49 INFO - mozprofile == 0.28 18:47:49 INFO - mozrunner == 6.11 18:47:49 INFO - mozscreenshot == 0.1 18:47:49 INFO - mozsystemmonitor == 0.0 18:47:49 INFO - moztest == 0.7 18:47:49 INFO - mozversion == 1.4 18:47:49 INFO - psutil == 3.1.1 18:47:49 INFO - requests == 1.2.3 18:47:49 INFO - wsgiref == 0.1.2 18:47:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:47:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:49 INFO - Using env: {'DISPLAY': ':0', 18:47:49 INFO - 'HOME': '/home/cltbld', 18:47:49 INFO - 'LANG': 'en_US.UTF-8', 18:47:49 INFO - 'LANGUAGE': 'en_US:en', 18:47:49 INFO - 'LOGNAME': 'cltbld', 18:47:49 INFO - 'MAIL': '/var/mail/cltbld', 18:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:49 INFO - 'MOZ_NO_REMOTE': '1', 18:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:49 INFO - 'NO_EM_RESTART': '1', 18:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:49 INFO - 'SHELL': '/bin/bash', 18:47:49 INFO - 'SHLVL': '1', 18:47:49 INFO - 'TERM': 'linux', 18:47:49 INFO - 'TMOUT': '86400', 18:47:49 INFO - 'USER': 'cltbld', 18:47:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:49 INFO - '_': '/tools/buildbot/bin/python'} 18:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 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)) 18:47:49 INFO - Cleaning up... 18:47:49 INFO - Return code: 0 18:47:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:47:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:49 INFO - Using env: {'DISPLAY': ':0', 18:47:49 INFO - 'HOME': '/home/cltbld', 18:47:49 INFO - 'LANG': 'en_US.UTF-8', 18:47:49 INFO - 'LANGUAGE': 'en_US:en', 18:47:49 INFO - 'LOGNAME': 'cltbld', 18:47:49 INFO - 'MAIL': '/var/mail/cltbld', 18:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:49 INFO - 'MOZ_NO_REMOTE': '1', 18:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:49 INFO - 'NO_EM_RESTART': '1', 18:47:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:49 INFO - 'SHELL': '/bin/bash', 18:47:49 INFO - 'SHLVL': '1', 18:47:49 INFO - 'TERM': 'linux', 18:47:49 INFO - 'TMOUT': '86400', 18:47:49 INFO - 'USER': 'cltbld', 18:47:49 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:49 INFO - '_': '/tools/buildbot/bin/python'} 18:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:50 INFO - Downloading/unpacking jsonschema 18:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:52 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:52 INFO - warning: no files found matching '*.txt' 18:47:52 INFO - no previously-included directories found matching 'build' 18:47:52 INFO - no previously-included directories found matching 'dist' 18:47:52 INFO - no previously-included directories found matching '.git*' 18:47:52 INFO - Installing collected packages: jsonschema, functools32 18:47:52 INFO - Running setup.py install for functools32 18:47:52 INFO - warning: no files found matching '*.txt' 18:47:52 INFO - no previously-included directories found matching 'build' 18:47:52 INFO - no previously-included directories found matching 'dist' 18:47:52 INFO - no previously-included directories found matching '.git*' 18:47:52 INFO - Successfully installed jsonschema functools32 18:47:52 INFO - Cleaning up... 18:47:52 INFO - Return code: 0 18:47:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47:52 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')]} 18:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:52 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')]} 18:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3586fcbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25288d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', '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 18:47:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:47:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:47:52 INFO - Using env: {'DISPLAY': ':0', 18:47:52 INFO - 'HOME': '/home/cltbld', 18:47:52 INFO - 'LANG': 'en_US.UTF-8', 18:47:52 INFO - 'LANGUAGE': 'en_US:en', 18:47:52 INFO - 'LOGNAME': 'cltbld', 18:47:52 INFO - 'MAIL': '/var/mail/cltbld', 18:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:52 INFO - 'MOZ_NO_REMOTE': '1', 18:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:52 INFO - 'NO_EM_RESTART': '1', 18:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:52 INFO - 'SHELL': '/bin/bash', 18:47:52 INFO - 'SHLVL': '1', 18:47:52 INFO - 'TERM': 'linux', 18:47:52 INFO - 'TMOUT': '86400', 18:47:52 INFO - 'USER': 'cltbld', 18:47:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:52 INFO - '_': '/tools/buildbot/bin/python'} 18:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:52 INFO - Downloading/unpacking flake8 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:52 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 18:47:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:47:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:47:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47: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 18:47:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:47:55 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 18:47:55 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 18:47:55 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 18:47:55 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 18:47:55 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 18:47:55 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 18:47:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:47:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:55 INFO - no previously-included directories found matching 'docs/_build' 18:47:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:47:55 INFO - Running setup.py install for pep8 18:47:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:55 INFO - no previously-included directories found matching 'docs/_build' 18:47:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:47:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:47:55 INFO - Cleaning up... 18:47:55 INFO - Return code: 0 18:47:55 INFO - Running post-action listener: _resource_record_post_action 18:47:55 INFO - Running post-action listener: _start_resource_monitoring 18:47:55 INFO - Starting resource monitoring. 18:47:55 INFO - ##### 18:47:55 INFO - ##### Running install step. 18:47:55 INFO - ##### 18:47:55 INFO - Running pre-action listener: _resource_record_pre_action 18:47:55 INFO - Running main action method: install 18:47:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:55 INFO - Reading from file tmpfile_stdout 18:47:55 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:47:55 INFO - Reading from file tmpfile_stdout 18:47:55 INFO - Output received: 18:47:55 INFO - Usage: mozinstall [options] installer 18:47:55 INFO - Options: 18:47:55 INFO - -h, --help show this help message and exit 18:47:55 INFO - -d DEST, --destination=DEST 18:47:55 INFO - Directory to install application into. [default: 18:47:55 INFO - "/builds/slave/test-pgo"] 18:47:55 INFO - --app=APP Application being installed. [default: firefox] 18:47:55 INFO - mkdir: /builds/slave/test-pgo/build/application 18:47:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:47:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:48:12 INFO - Reading from file tmpfile_stdout 18:48:12 INFO - Output received: 18:48:12 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:48:12 INFO - Running post-action listener: _resource_record_post_action 18:48:12 INFO - ##### 18:48:12 INFO - ##### Running run-tests step. 18:48:12 INFO - ##### 18:48:12 INFO - Running pre-action listener: _resource_record_pre_action 18:48:12 INFO - Running main action method: run_tests 18:48:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:48:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:48:12 INFO - Python 2.7.3 18:48:12 INFO - Return code: 0 18:48:12 INFO - grabbing minidump binary from tooltool 18:48:12 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')]} 18:48:12 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 0x25b78b0>, '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 0x25b87b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:48:12 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 18:48:12 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 18:48:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:12 INFO - Return code: 0 18:48:12 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:48:12 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:48:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:48:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:48:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:48:13 INFO - Return code: 0 18:48:13 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:48:13 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:48:13 INFO - Using env: {'DISPLAY': ':0', 18:48:13 INFO - 'HOME': '/home/cltbld', 18:48:13 INFO - 'LANG': 'en_US.UTF-8', 18:48:13 INFO - 'LANGUAGE': 'en_US:en', 18:48:13 INFO - 'LOGNAME': 'cltbld', 18:48:13 INFO - 'MAIL': '/var/mail/cltbld', 18:48:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:13 INFO - 'MOZ_NO_REMOTE': '1', 18:48:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:13 INFO - 'NO_EM_RESTART': '1', 18:48:13 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:13 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:13 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:48:13 INFO - 'SHELL': '/bin/bash', 18:48:13 INFO - 'SHLVL': '1', 18:48:13 INFO - 'TERM': 'linux', 18:48:13 INFO - 'TMOUT': '86400', 18:48:13 INFO - 'USER': 'cltbld', 18:48:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513', 18:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:13 INFO - '_': '/tools/buildbot/bin/python'} 18:48:13 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:48:13 INFO - mozversion application_buildid: 20160410163003 18:48:13 INFO - mozversion application_changeset: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 18:48:13 INFO - mozversion application_display_name: Nightly 18:48:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:13 INFO - mozversion application_name: Firefox 18:48:13 INFO - mozversion application_remotingname: firefox 18:48:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:13 INFO - mozversion application_vendor: Mozilla 18:48:13 INFO - mozversion application_version: 48.0a1 18:48:13 INFO - mozversion platform_buildid: 20160410163003 18:48:13 INFO - mozversion platform_changeset: 8803d34bd9f8278b62c542e0ec5446148ce08fe7 18:48:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:13 INFO - mozversion platform_version: 48.0a1 18:48:13 INFO - using testdate: 1460339293 18:48:13 INFO - actual date: 1460339293 18:48:13 INFO - starting webserver on 'localhost:39059' 18:48:13 INFO - SUITE-START | Running 2 tests 18:48:13 INFO - TEST-START | dromaeo_css 18:48:13 INFO - operating with platform_type : linux_ 18:48:13 INFO - Initialising browser for dromaeo_css test... 18:48:13 INFO - TEST-INFO | started process 23741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppQo8Y2/profile http://localhost:39059/getInfo.html) 18:48:17 INFO - PROCESS | 23741 | __metrics Screen width/height:1600/1200 18:48:17 INFO - PROCESS | 23741 | colorDepth:24 18:48:17 INFO - PROCESS | 23741 | Browser inner width/height: 1024/697 18:48:17 INFO - PROCESS | 23741 | __metrics 18:48:18 ERROR - PROCESS | 23741 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:48:19 INFO - TEST-INFO | 23741: exit 0 18:48:19 INFO - Browser initialized. 18:48:19 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:19 INFO - TEST-INFO | started process 23823 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppQo8Y2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:30 INFO - PROCESS | 23823 | RSS: Main: 152178688 18:48:30 INFO - PROCESS | 23823 | 18:49:21 INFO - PROCESS | 23823 | 1460339361766 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] 18:51:29 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39059/tests/dromaeo/cssquery-ext.html) 18:51:30 INFO - PROCESS | 23823 | RSS: Main: 254046208 18:51:30 INFO - PROCESS | 23823 | 18:54:32 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-ext.html (next: http://localhost:39059/tests/dromaeo/cssquery-jquery.html) 18:54:33 INFO - PROCESS | 23823 | RSS: Main: 237031424 18:54:33 INFO - PROCESS | 23823 | 18:57:34 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39059/tests/dromaeo/cssquery-mootools.html) 18:57:35 INFO - PROCESS | 23823 | RSS: Main: 238100480 18:57:35 INFO - PROCESS | 23823 | 19:00:37 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39059/tests/dromaeo/cssquery-prototype.html) 19:00:38 INFO - PROCESS | 23823 | RSS: Main: 213000192 19:00:38 INFO - PROCESS | 23823 | 19:03:40 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39059/tests/dromaeo/cssquery-yui.html) 19:03:41 INFO - PROCESS | 23823 | RSS: Main: 213454848 19:03:41 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | Cycle 1(1): loaded http://localhost:39059/tests/dromaeo/cssquery-yui.html (next: http://localhost:39059/tests/dromaeo/cssquery-dojo.html) 19:06:43 INFO - PROCESS | 23823 | RSS: Main: 271319040 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | __start_tp_report 19:06:43 INFO - PROCESS | 23823 | _x_x_mozilla_page_load 19:06:43 INFO - PROCESS | 23823 | _x_x_mozilla_page_load_details 19:06:43 INFO - PROCESS | 23823 | |i|pagename|runs| 19:06:43 INFO - PROCESS | 23823 | |0;dojo.html;3094.597702298701;3133.592632957718;3158.24202191474;3172.2386627209476;3199.2161920329518;5199.220116982455;5285.101532739434;5313.335833020872;5353.411124776277;5366.141417373216;5269.8155564555245;5321.760520776565;5341.06531357013;5343.412224655285;5344.171653393721;4756.239001759719;4808.110499557593;4833.661643684944;4864.805407783684;4890.657653964224;4723;4831.9275210871865;4853.126437241295;4886.755662216893;4886.828960986366;4731.645126615517;4824.7105173689515;4861.100696371147;4884.658073934808;4930.926036109461;4792.137415265251;4809.206480930642;4809.903801923977;4813.061453016663;4851.8301859435105;4668;4772.308015337757;4777.617790576745;4794.089123066607;4797.928031079537;5253.159494480903;5291.603129765244;5294.391145018334;5301.01931142736;5303.946960530384;5707.857303567403;5714.142878568248;5720.885582288331;5734.483896449339;5737.39757325479;5540.833774986757;5715.257016587859;5758.452946970031;5761.913571296392;5773.220615216934;5369.865753356119;5379.9731001345135;5388.084025715599;5394.595405344615;5421.430749771296;5818.796342128006;5820.767169313265;5824.941750582525;5827.388124246893;5840.211571437886;5512.4211957744665;5600.019996500678;5622.606417550732;5627.409122042209;5673.149027645886;5712.6286791358425;5722.885542289214;5724.971375143097;5725.59920805548;5755.453231942959;5681.545476361881;5684.54523638108;5686;5687.40282270364;5690.715464226772;5479.972600136974;5656.236408084938;5715.857103572361;5716.828495145152;5742.942570574241;4302.462192225972;4304.440422745023;4305.590968857953;4308.67684923632;4341.826326946887;3850.961490385116;3865.014421322545;3873.1091848874917;3892.1048158923604;3905.3556163233316;5282.313299271147;5359.839204823861;5452;5533.557315414757;5541.307336582927;5688.9715551422805;5690.715464226772;5698.686572238566;5703.144528320702;5706.914396284059;5377.569794416438;5378.865528361744;5379.1393377059485;5381.0852155133725;5426.348838139448;4691.085238378551;4786.8085276588545;4817.0365926814775;4871.14754917888;4875.024995001014;5831.708414579254;5861.853453663693;5864.44287792659;5864.67744274069;5865.384134665798;5605.887882242251;5696.943030569724;5700.971495142498;5702.8289151325525;5703.828885133453;5910.113482977587;5951.583389162717;5966.522678185648;5984.13230081627;5993.730282137227;5573.860653483695;5580.665160090408;5587.608867379245;5591.161325801162;5598.188262701967;5556.833295001156;5652.604317697722;5703.857403564778;5709.885802284014;5715.971420142872;5553.916691249554;5565.081761509306;5568.443155684399;5570.972145139248;5616.85957851057;5551.500364967173;5553.8333849984565;5554.555635549227;5555.333359996826;5559.471850174227;5434.130539113723;5456.781728730806;5519.061759500974;5521.033819081565;5573.749181286933;5608.803691870929;5612.158176273591;5614.326280846324;5630;5661.490465858093;5499.285092937893;5505.669659820263;5507.03626865289;5510.448955104457;5526.640768350205 19:06:43 INFO - PROCESS | 23823 | |1;ext.html;585.970701464927;619.5508256514031;631.3686313686313;632.8259728574642;639.5139693832688;29471.852640736794;35826.820865895665;36660;36688.08279793007;36725.44911826325;40095.799521002424;40592.59407405932;40769.59230407702;40813.183736325256;40835.59164408355;7624.961875190616;8519.914800852006;8681.479111253346;8716.520591367473;8719.564021798917;10018.549165287543;10377.325473844214;10420.843687344695;10430.843537346946;10433.739156521071;10166.390016599027;10194.439305838176;10236.283460157792;10258.640947566837;10261.794764104714;10216.846747298796;10287.0741633253;10319.638812641522;10326.122279606205;10341.482925853752;10099.848502272473;10174.542145603391;10223.897761022368;10224.744381390525;10232.79534409315;37433.81283093567;37617.435738463944;37766.24467510635;37773.62226377729;37813;3482.1938914983025;3517.56030496188;3518.225990282134;3560.181158333572;3725.3853114236117;30641.69358306433;30838.22904427385;31080.533791993137;31085.68914310873;31334;4189.706720529564;4191.407614390518;4297.462817147856;4301.591348821857;4331.306990881475;207939;211317;211667;212434;212485;35863;36884.446733299024;36988.260234795154;37008.25983480315;60700.69649651812;35313.64686353104;35459.82270088685;35480.46779298312;35485.822570887496;35521.1119722009;14144.151350918977;14335.139891606537;14336.354864031144;14338.713225735635;14339.426422943174;11698.76602467963;12405.255684658949;12619.810702839464;12691.492340306284;12769.106162568716;8551.786205344792;8560.828783424422;8574.27118694918;8623.353248506262;8643.654253829776;3137.7646676499353;3236.546883436321;3303.4143611066343;3306.570145881068;3365.2764655599162;1012.4380968562518;1050.5902697947806;1094.3105843318658;1161.4773351991637;1263.8041103628952;31116.844415777778;31245.53131703026;31331;31528.842355788074;31678.208044798605;1144.2619510415734;1160.14729174057;1167.095500986742;1232.9704696578278;1248.950041998328;16597.502074937773;17003.91498042502;17051.91474042622;17180.312787488612;17259.482215533553;427827;429760;433446;433577;434628;57298.7135064322;58014.4198558009;58198.41801582015;58290.41709582935;58306.416935830945;1199.682084247675;1392.3108061509618;1397.238505014749;1422.2177802208744;1434.9426022958964;30334.393312133194;31546.211344716565;32255.35489290248;32282.515762263116;32798.34403311873;44220.55779442164;46255.306170406795;46349.536504634525;46357;46447.767761160976;246532;252019;252617;253143;413651;26422.207333780018;27386.452270954072;27427.588586170823;28513;29351.55972660369;41865;42292;42311.576884230766;42513.5748642522;42856.35715464208;35327.823360883034;35439.64560354467;36121.63878361183;36189.27621447609;38028.2394352117;39018.41472377974;39029.6097039026;39076.413853791644;39113.41329879997;39359;38843.22313553769;39764;40032.59967400405;40334.79832600935;40386.596134038286;33296.66703332936;33941.151471213416;34218.48672269868;34455;35073.64926350704;27000.459990800467;27284.45431091407;27314.180574582795;27375.726242738114;27802.721972780822 19:06:43 INFO - PROCESS | 23823 | |2;jquery.html;395.98812035638935;396.20758483033933;402.86906755304534;412.0769476372924;412.31349802578706;17603.119844007797;18292.542686432847;18363;18416;19308.903455482738;18094.728579071325;18461.630767384646;18689;18972.146253418596;18991.715124273112;5514.91727624085;5622.128570071645;5683.602147849652;5686;5705.058665320238;5475.780968761244;5490.121580547113;5492.340919089695;5492.972535137319;5680.204771331996;5565.638233514829;5568.693721845297;5602.495775380215;5640.605157638967;5660.122680984454;5454.481824226692;5557.472040156179;5565.66606003637;5569.610127291091;5598.4961353478175;4795.448523419816;4930.137225985438;5188.5849132069725;5189.974050129763;5190.143626301693;13623.25072121033;13861;13924.651883702989;13924.860751392458;14240.786388204186;2316.476184347949;2438.2685194441597;2814.717633728906;2860.4708128996203;2975.79169458138;10082.89917100827;10523.684289471328;10615.946920265427;11522.251053681568;13518.256495892721;1781.7238328059173;1799.208348326732;1813.9274429022823;1822.9088545572667;1854.2304943448453;72918.27081729168;75599.24400755977;75796;76461.99999999945;77449.61275193589;9883.851742223873;10012;10028.899711002796;10185.319422295386;10227.846582301272;13716.314184290746;13740.793888091686;13872.514461993782;13911.095778774346;13928.164310141221;7608.581528016012;7662.46362754613;7686.519188888928;7728.961355193188;7763.059235191202;7494.962525187449;7578.242175782488;7682.539047657158;7683.577403242875;7688.38492920565;4136.565660605654;4219.852305169305;4229.471316085489;4288.935665965013;4293.8711838644895;1708.7693161423297;1786.8034516203206;1805.0343066459382;1810.6197698483202;1817.790954040276;926.8517037274139;936.5738588942015;972.4019727867452;979.4906648542718;1027.6505987963978;17630.647387052442;18568.907155464138;18892.149853256637;19004.61990760177;19101.140448679842;983.2969426859687;1005.100435110572;1008.6016023670755;1019.7042857571221;1043.2644985285356;10069.848952265722;10296.691099267035;10406.219533534864;10457.11114555256;10477.528511217013;449071;452367;453266;454324;477535;84267;87145.5642721795;88934;89191;90849.54575227082;1000.8248556502583;1011.3325205364424;1015.1726343030407;1020.3724709303873;1031.9319504313;15860.68278634444;16077.517674469784;16099.75850362222;16111.516654500383;16455.835441645908;36555;37173.44239836459;37264;37450.81274593718;37497.62502374942;52215;53374.73312633412;55447.72276138755;55475.44524554864;56016.71991640016;8390.748277551684;8462.19609137131;8636.697715579925;8654.913450865412;8731.956340218258;7257.963710181626;10886.67339979802;11368.635763708407;12645.608983012045;12832.588415274126;10834.241603088023;10941.28881622692;11282.435878205893;11453.713657158305;11517.94241028823;10667.839982400425;10728.302660327367;10738.73153171177;10976.341419514536;11029.669109926715;11396.715082123013;11446.713832154262;11521.711957201138;11615.88384116148;11889.643310700692;8082.515049097073;8226.136255693065;8357.791055223668;8388.790280243044;8466.280366168945;11157.66527004191;11171.944140279247;11251.831222531504;11277.47754053225;11429.085673146295 19:06:43 INFO - PROCESS | 23823 | |3;mootools.html;1405.0235086614794;1545.4359158906998;1551.4259723902155;1757.4551888914436;1859.7582314299132;7776.611169441534;8135.552544610044;8297.087320394752;8315.958420207906;8329.83340333193;8016.118226995026;8174.059983101945;8182.304504117157;8184.91815081849;8188.22211889871;2062.3606681928577;2319.6288593824993;2331.80179684727;2356.210669425736;2416.118116887341;2395.592749232626;2416.7824895759377;2417.443987882788;2418.7944024757917;2422.5760491913934;2298.069281940808;2364.657124716915;2365.1367250953363;2369.5142495788323;2370.608849539824;2010.4069299556593;2244.6408574628063;2321.3732292281156;2321.3964369263945;2327.94180145496;2256.3005468304877;2276.0213108363396;2285.177336158998;2308.134449581407;2370.751071137523;8537.957310213471;8623.913760862437;8627.913720862836;8629;8645.265152462049;5071.797128114871;5248.160294352885;5248.396434410053;5260.210968354739;5276.81531146408;3276.5904261967253;3327.9833600832085;3363.6468170841954;3403.3363494118657;3408.5739282589675;1091.372460835023;1099.5217080569898;1103.5916710816969;1122.7024838417826;1131.7283851875573;11672.824907626393;11707.180497365187;11707.2975621463;11707.648770536813;11720.238184517893;4505.864824055284;4571.337156112345;4714.882127946828;4723.504032076651;4740;9832.901670983341;9833.557489912828;9847;9849.55676994537;9853.852192217122;4756.405449318835;5279.44565820591;5288.889333240063;5298.2052692096495;5319.0957537218765;4743.952560474351;4855.295982082578;4858.198397264412;4864.829730959399;4867.099586576494;3926.6073392660505;4020.83916643331;4047.0489434982755;4091.468109145792;4142.08874047709;1287.3563218390805;1289.4584274604688;1304.230504002624;1316.3878796359738;1323.1069028405789;1177.270092542612;1310.2727985967879;1383.1424516799648;1393.1362555215628;1455.2360010994312;8185.959070204611;8186.0586032605825;8189.50862948225;8209.261166494925;8275.048369437593;469.3499503188041;476.99046019079424;482.8816939849689;484.2204051477119;484.7382413496743;6311.495080393557;6322.589031713016;6363.459105975951;6373.904391434132;6382.489400848014;9878.407295562289;10584.364938103738;10749.89250107489;10753.677389678322;10754.193435492212;10469.68590942273;10623;10637.095846853104;10639.734006649896;10654;7973.681052757941;8031.718889838944;8037.196280372033;8066.838663226703;8144.959275203586;7915.881261781193;8039.316658084128;8269.875951860848;8272.503649781032;8287.212714792086;9531.952340238255;9537.427754334762;9788.804223915624;9803.80392392134;9863.01369863008;9788.216942644714;9917.355371900803;10027.699169024942;10131.13885319756;10292.639757608447;6730.798076057726;6820.693068812015;7593.620318983918;7626.694932202649;7754.6898124074405;8241.25828675422;8269.29710974574;8319.500829950222;8329.666813327642;8332.541710205996;7375.336219740249;7593.1647518774;7621.809454763454;7651.464397492345;7742.845143097219;7431.3683336916965;7562.848743025219;7576.24237576238;7667.079950405764;7670.8082297943;7941.960290198512;7965.442419030613;8051.8792218115605;8055.718049868226;8058.19418058213;7273.3817625500305;7307.086614173229;7432;7444.851102977802;7446.962765186139;7516.24837516244;7535;7550.5469671819865;7568.659410326659;7590.8102297443 19:06:43 INFO - PROCESS | 23823 | |4;prototype.html;339.28580338387695;340.9079548521899;341.623056090545;345.51972757866554;348.9092835862675;5537.1140617501205;5575.721213939302;5618.5786066045;5636.408177141392;5649.096144616862;5527.198556209347;5544;5573.108302671573;5584.441555844423;5586.24585680933;4134.111166099288;4258.872233832974;4260.744355338674;4284.014676624378;4347.565243475651;4267.722598031133;4281.807318670667;4284.850030248942;4285.764282964451;4288.871333859989;4237.6734263603075;4265.208612382807;4265.402843601898;4265.637420819234;4276.700630955835;4157.204892235365;4257.638100761439;4267.338562522814;4288.206681763852;4293.763842988635;3720.274546463441;3749.6812770914503;3753.3244016077097;3757.0982964088694;3762.4761971401626;5338.412774594792;5338.546223571001;5349.09065458869;5372.113601255788;5377.865553361197;4801.663883528119;4969.180085285923;4972.602191824645;4974.452810190876;4998.8250411235795;5812.505936995361;5831.475167234969;5834.883302333929;5868.706564671749;5872.5889187756875;4132.380142978547;4138.772367519785;4173.353130264813;4176.91646167078;4177.624013838769;5981.0729336952845;6090.390960903918;6110.755569777248;6154.476869466101;6168.475679567242;4243.893902652397;4262.85080022204;4276.273033584298;4285.571442855689;4298.3552467130185;4303.33298338758;4313.094250207491;4315.4605674290715;4317.287647538184;4334.176506463762;4787.832425865147;4969.701817890938;4970;4984.277279794482;4985;5887.76448942046;5906.793262235801;5919.911201331984;5926.2888453385;5928.199693041384;1475.6827282134393;1505.9232648656046;1505.9397624095132;1507.1559926441228;1507.3970411835135;974.91713204377;1009.9242556808122;1010.8332125199407;1022.4887556221889;1029.8249297619423;5678.233438485834;5688.943110568925;5689.943100569024;5704.258446402024;5711.286089238845;6044.24446944132;6085.513158947274;6101.877962440815;6102.267727872595;6125.816225513242;5538.446155384429;5691.9146212806845;5714.828555143353;5749.195112684228;5757.942420575824;3270.296886169485;3273.0998975281987;3273.8035717857006;3278.09852290622;3281.868725251011;6151.231096112986;6298.811035668846;6308.842278943063;6319.241690997018;6336.366363363627;5901.557383196192;6173.59871608353;6176.382361763787;6205.937940620626;6225.906611400833;6089.208402907682;6303.590266632654;6323.114763933053;6325.430711236011;6338.968305158444;5804.1293805929445;5887.352391236875;6138.969305153446;6156.722947467285;6168.845778855564;6030.517558595214;6064.4541991221;6072.605280656743;6099.268087829489;6120.785772497941;6225.750969961332;6276.278228003838;6296.653684047421;6321.4801416987075;6351.2696039956;4299.247631664383;4305.461817272841;4306.97846510778;4316.9352459713755;4324.329728892027;6133.723982420713;6168.753249869955;6178.783742569169;6183.134361189347;6185.907211391923;5826.76692932278;5996.820095397145;5998.640081594944;6000.789972350947;6007.3992600739575;5912.586118971631;5946.524278057832;5980.3421623622235;5983.162357270073;6007.128966299774;5844.532437405082;5849.034909239927;5885;5899.144624029406;5933.525317974638;5875;5979.222701048836;5987;5987.6108052976415;6013.30846952606;5879.5002424792665;5882.499987500939;5907.3797251288;5913;5939.613925095028 19:06:43 INFO - PROCESS | 23823 | |5;yui.html;784.0669603172227;821.1378053044302;825.9132791056938;844.9281811046061;866.9783255418614;14410.999999999987;14745.778813317782;14855.331510082058;14909.552713418601;14986.175760333204;14056.086354386984;14183.078099923523;14187.929060354683;14189.148651080943;14206.644833879132;681.4037716997627;795.6141271483326;838.5597561280316;841.5371545649899;842.6418772021866;830.1242189490085;832.9791755206107;834;834.8038211020405;835.6364981233153;709.0463326825411;867.3104881619128;868.5700578213794;870.9564521773917;871.2072014466836;722.8807246804297;726.6076318787848;826.1655727715021;856.1267507142679;858.3776761847611;621.6301300726105;622.947049500793;623.0778447897137;623.7785586116909;624.0140577886928;14415.495457659037;14472.131672099602;14474.059186152866;14482.34829432678;14485.493007744679;13924.37340319678;13946.860531394657;13964.231967241798;14145.504907328193;14239.572812815632;10699.946500267526;10989.06592939601;11001.449927503672;11019.944900275448;11139.610113645984;3831.3295173344554;3862.246861861938;3889.4749208856724;3957.08986933007;3964.464797252363;53849.1922621161;54440.455595443935;54507.45492545103;54564.454355456335;55098;11061.889381106246;11348.262362946381;11408.258463199865;11535.884641153649;11556.826647600292;19121.52196195106;19914;20104.798952010584;20260.797392026187;20288.087036083412;8396.790080248044;8442.704505342406;8465.534395608178;8494.787630309293;8513.574321284035;4594.264917613166;4613.700109492872;4696.131215725033;4701.106789709944;4770.928436073462;3535.398982173037;3645.54430696163;3649.708023358125;3651.8721844735305;3655.3968595181495;644.6615526848442;651.726274964516;656.3174298729268;656.7373050779631;661.1933441201726;646.0793369448517;708.7590219325455;739.1425945902727;750.8723517002122;761.7905076104116;8446.788830279293;8465.195806398382;8922.375433719708;8980.640774369083;9145.3598248122;712.2236761929522;716.6846587501483;727.2146082231178;729.9635018249066;748.9325960663566;4197.244495990751;4211.494620645542;4275.5724427557;4312.568743125662;4423.51341352451;60156;60522;61285.69357153275;61355;61560.076598851054;54160.18759718607;54984.725076374365;55048.72475637596;55479;56099.71950140223;48729;49281.50718492841;49431.75284123556;49754;49954.250686239735;8248.54632995191;8273.33813294947;8283.544405057779;8483.321334293365;8514.191151840565;33109.503357450136;33128.33743325168;33241.33517329688;33349.83325083359;33648.49527257142;40994.1801163981;44644.33033504435;44895.55104448914;45209.77395113003;45251.77374113108;10774.191935605018;10830.891691082988;11018.559257629606;11181.105511559219;11240.775184496428;12280.140390172603;12509.624711258677;12583.811242831182;12597.181183223061;12613.36933153357;11829.349385783864;12065.396730163282;12074.637760867188;12093.818592721293;12443.688907777378;11683.299002059903;11828.17202795796;11857.644270671894;11872.406379680808;11878.168528202943;11407.429628518375;11489.482973266056;11701.044308220737;11765.647030589096;12336;9362.906370936204;9568.282378821477;9599.904000959901;9634.421934683942;9712.660056897974;9306.813863722553;9385.15533601979;9440.48077355752;9504.952475237857;9576.473293968898 19:06:43 INFO - PROCESS | 23823 | __end_tp_report 19:06:43 INFO - PROCESS | 23823 | __start_cc_report 19:06:43 INFO - PROCESS | 23823 | _x_x_mozilla_cycle_collect,878 19:06:43 INFO - PROCESS | 23823 | __end_cc_report 19:06:43 INFO - PROCESS | 23823 | __startTimestamp1460340403636__endTimestamp 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | ------- Summary: start ------- 19:06:43 INFO - PROCESS | 23823 | Number of tests: 6 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#0] dojo.html Cycles:165 Average:5288.85 Median:5521.03 stddev:602.32 (10.9%) stddev-sans-first:579.04 19:06:43 INFO - PROCESS | 23823 | Values: 3094.6 3133.6 3158.2 3172.2 3199.2 5199.2 5285.1 5313.3 5353.4 5366.1 5269.8 5321.8 5341.1 5343.4 5344.2 4756.2 4808.1 4833.7 4864.8 4890.7 4723.0 4831.9 4853.1 4886.8 4886.8 4731.6 4824.7 4861.1 4884.7 4930.9 4792.1 4809.2 4809.9 4813.1 4851.8 4668.0 4772.3 4777.6 4794.1 4797.9 5253.2 5291.6 5294.4 5301.0 5303.9 5707.9 5714.1 5720.9 5734.5 5737.4 5540.8 5715.3 5758.5 5761.9 5773.2 5369.9 5380.0 5388.1 5394.6 5421.4 5818.8 5820.8 5824.9 5827.4 5840.2 5512.4 5600.0 5622.6 5627.4 5673.1 5712.6 5722.9 5725.0 5725.6 5755.5 5681.5 5684.5 5686.0 5687.4 5690.7 5480.0 5656.2 5715.9 5716.8 5742.9 4302.5 4304.4 4305.6 4308.7 4341.8 3851.0 3865.0 3873.1 3892.1 3905.4 5282.3 5359.8 5452.0 5533.6 5541.3 5689.0 5690.7 5698.7 5703.1 5706.9 5377.6 5378.9 5379.1 5381.1 5426.3 4691.1 4786.8 4817.0 4871.1 4875.0 5831.7 5861.9 5864.4 5864.7 5865.4 5605.9 5696.9 5701.0 5702.8 5703.8 5910.1 5951.6 5966.5 5984.1 5993.7 5573.9 5580.7 5587.6 5591.2 5598.2 5556.8 5652.6 5703.9 5709.9 5716.0 5553.9 5565.1 5568.4 5571.0 5616.9 5551.5 5553.8 5554.6 5555.3 5559.5 5434.1 5456.8 5519.1 5521.0 5573.7 5608.8 5612.2 5614.3 5630.0 5661.5 5499.3 5505.7 5507.0 5510.4 5526.6 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#1] ext.html Cycles:180 Average:46646.79 Median:18653.21 stddev:85779.28 (459.9%) stddev-sans-first:85950.20 19:06:43 INFO - PROCESS | 23823 | Values: 586.0 619.6 631.4 632.8 639.5 29471.9 35826.8 36660.0 36688.1 36725.4 40095.8 40592.6 40769.6 40813.2 40835.6 7625.0 8519.9 8681.5 8716.5 8719.6 10018.5 10377.3 10420.8 10430.8 10433.7 10166.4 10194.4 10236.3 10258.6 10261.8 10216.8 10287.1 10319.6 10326.1 10341.5 10099.8 10174.5 10223.9 10224.7 10232.8 37433.8 37617.4 37766.2 37773.6 37813.0 3482.2 3517.6 3518.2 3560.2 3725.4 30641.7 30838.2 31080.5 31085.7 31334.0 4189.7 4191.4 4297.5 4301.6 4331.3 207939.0 211317.0 211667.0 212434.0 212485.0 35863.0 36884.4 36988.3 37008.3 60700.7 35313.6 35459.8 35480.5 35485.8 35521.1 14144.2 14335.1 14336.4 14338.7 14339.4 11698.8 12405.3 12619.8 12691.5 12769.1 8551.8 8560.8 8574.3 8623.4 8643.7 3137.8 3236.5 3303.4 3306.6 3365.3 1012.4 1050.6 1094.3 1161.5 1263.8 31116.8 31245.5 31331.0 31528.8 31678.2 1144.3 1160.1 1167.1 1233.0 1249.0 16597.5 17003.9 17051.9 17180.3 17259.5 427827.0 429760.0 433446.0 433577.0 434628.0 57298.7 58014.4 58198.4 58290.4 58306.4 1199.7 1392.3 1397.2 1422.2 1434.9 30334.4 31546.2 32255.4 32282.5 32798.3 44220.6 46255.3 46349.5 46357.0 46447.8 246532.0 252019.0 252617.0 253143.0 413651.0 26422.2 27386.5 27427.6 28513.0 29351.6 41865.0 42292.0 42311.6 42513.6 42856.4 35327.8 35439.6 36121.6 36189.3 38028.2 39018.4 39029.6 39076.4 39113.4 39359.0 38843.2 39764.0 40032.6 40334.8 40386.6 33296.7 33941.2 34218.5 34455.0 35073.6 27000.5 27284.5 27314.2 27375.7 27802.7 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#2] jquery.html Cycles:180 Average:27036.04 Median:2837.59 stddev:75461.02 (2659.3%) stddev-sans-first:75646.20 19:06:43 INFO - PROCESS | 23823 | Values: 396.0 396.2 402.9 412.1 412.3 17603.1 18292.5 18363.0 18416.0 19308.9 18094.7 18461.6 18689.0 18972.1 18991.7 5514.9 5622.1 5683.6 5686.0 5705.1 5475.8 5490.1 5492.3 5493.0 5680.2 5565.6 5568.7 5602.5 5640.6 5660.1 5454.5 5557.5 5565.7 5569.6 5598.5 4795.4 4930.1 5188.6 5190.0 5190.1 13623.3 13861.0 13924.7 13924.9 14240.8 2316.5 2438.3 2814.7 2860.5 2975.8 10082.9 10523.7 10615.9 11522.3 13518.3 1781.7 1799.2 1813.9 1822.9 1854.2 72918.3 75599.2 75796.0 76462.0 77449.6 9883.9 10012.0 10028.9 10185.3 10227.8 13716.3 13740.8 13872.5 13911.1 13928.2 7608.6 7662.5 7686.5 7729.0 7763.1 7495.0 7578.2 7682.5 7683.6 7688.4 4136.6 4219.9 4229.5 4288.9 4293.9 1708.8 1786.8 1805.0 1810.6 1817.8 926.9 936.6 972.4 979.5 1027.7 17630.6 18568.9 18892.1 19004.6 19101.1 983.3 1005.1 1008.6 1019.7 1043.3 10069.8 10296.7 10406.2 10457.1 10477.5 449071.0 452367.0 453266.0 454324.0 477535.0 84267.0 87145.6 88934.0 89191.0 90849.5 1000.8 1011.3 1015.2 1020.4 1031.9 15860.7 16077.5 16099.8 16111.5 16455.8 36555.0 37173.4 37264.0 37450.8 37497.6 52215.0 53374.7 55447.7 55475.4 56016.7 8390.7 8462.2 8636.7 8654.9 8732.0 7258.0 10886.7 11368.6 12645.6 12832.6 10834.2 10941.3 11282.4 11453.7 11517.9 10667.8 10728.3 10738.7 10976.3 11029.7 11396.7 11446.7 11521.7 11615.9 11889.6 8082.5 8226.1 8357.8 8388.8 8466.3 11157.7 11171.9 11251.8 11277.5 11429.1 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#3] mootools.html Cycles:180 Average:6017.59 Median:5254.30 stddev:3216.30 (61.2%) stddev-sans-first:3206.64 19:06:43 INFO - PROCESS | 23823 | Values: 1405.0 1545.4 1551.4 1757.5 1859.8 7776.6 8135.6 8297.1 8316.0 8329.8 8016.1 8174.1 8182.3 8184.9 8188.2 2062.4 2319.6 2331.8 2356.2 2416.1 2395.6 2416.8 2417.4 2418.8 2422.6 2298.1 2364.7 2365.1 2369.5 2370.6 2010.4 2244.6 2321.4 2321.4 2327.9 2256.3 2276.0 2285.2 2308.1 2370.8 8538.0 8623.9 8627.9 8629.0 8645.3 5071.8 5248.2 5248.4 5260.2 5276.8 3276.6 3328.0 3363.6 3403.3 3408.6 1091.4 1099.5 1103.6 1122.7 1131.7 11672.8 11707.2 11707.3 11707.6 11720.2 4505.9 4571.3 4714.9 4723.5 4740.0 9832.9 9833.6 9847.0 9849.6 9853.9 4756.4 5279.4 5288.9 5298.2 5319.1 4744.0 4855.3 4858.2 4864.8 4867.1 3926.6 4020.8 4047.0 4091.5 4142.1 1287.4 1289.5 1304.2 1316.4 1323.1 1177.3 1310.3 1383.1 1393.1 1455.2 8186.0 8186.1 8189.5 8209.3 8275.0 469.3 477.0 482.9 484.2 484.7 6311.5 6322.6 6363.5 6373.9 6382.5 9878.4 10584.4 10749.9 10753.7 10754.2 10469.7 10623.0 10637.1 10639.7 10654.0 7973.7 8031.7 8037.2 8066.8 8145.0 7915.9 8039.3 8269.9 8272.5 8287.2 9532.0 9537.4 9788.8 9803.8 9863.0 9788.2 9917.4 10027.7 10131.1 10292.6 6730.8 6820.7 7593.6 7626.7 7754.7 8241.3 8269.3 8319.5 8329.7 8332.5 7375.3 7593.2 7621.8 7651.5 7742.8 7431.4 7562.8 7576.2 7667.1 7670.8 7942.0 7965.4 8051.9 8055.7 8058.2 7273.4 7307.1 7432.0 7444.9 7447.0 7516.2 7535.0 7550.5 7568.7 7590.8 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#4] prototype.html Cycles:180 Average:4963.54 Median:5683.59 stddev:1483.19 (26.1%) stddev-sans-first:1446.17 19:06:43 INFO - PROCESS | 23823 | Values: 339.3 340.9 341.6 345.5 348.9 5537.1 5575.7 5618.6 5636.4 5649.1 5527.2 5544.0 5573.1 5584.4 5586.2 4134.1 4258.9 4260.7 4284.0 4347.6 4267.7 4281.8 4284.9 4285.8 4288.9 4237.7 4265.2 4265.4 4265.6 4276.7 4157.2 4257.6 4267.3 4288.2 4293.8 3720.3 3749.7 3753.3 3757.1 3762.5 5338.4 5338.5 5349.1 5372.1 5377.9 4801.7 4969.2 4972.6 4974.5 4998.8 5812.5 5831.5 5834.9 5868.7 5872.6 4132.4 4138.8 4173.4 4176.9 4177.6 5981.1 6090.4 6110.8 6154.5 6168.5 4243.9 4262.9 4276.3 4285.6 4298.4 4303.3 4313.1 4315.5 4317.3 4334.2 4787.8 4969.7 4970.0 4984.3 4985.0 5887.8 5906.8 5919.9 5926.3 5928.2 1475.7 1505.9 1505.9 1507.2 1507.4 974.9 1009.9 1010.8 1022.5 1029.8 5678.2 5688.9 5689.9 5704.3 5711.3 6044.2 6085.5 6101.9 6102.3 6125.8 5538.4 5691.9 5714.8 5749.2 5757.9 3270.3 3273.1 3273.8 3278.1 3281.9 6151.2 6298.8 6308.8 6319.2 6336.4 5901.6 6173.6 6176.4 6205.9 6225.9 6089.2 6303.6 6323.1 6325.4 6339.0 5804.1 5887.4 6139.0 6156.7 6168.8 6030.5 6064.5 6072.6 6099.3 6120.8 6225.8 6276.3 6296.7 6321.5 6351.3 4299.2 4305.5 4307.0 4316.9 4324.3 6133.7 6168.8 6178.8 6183.1 6185.9 5826.8 5996.8 5998.6 6000.8 6007.4 5912.6 5946.5 5980.3 5983.2 6007.1 5844.5 5849.0 5885.0 5899.1 5933.5 5875.0 5979.2 5987.0 5987.6 6013.3 5879.5 5882.5 5907.4 5913.0 5939.6 19:06:43 INFO - PROCESS | 23823 | 19:06:43 INFO - PROCESS | 23823 | [#5] yui.html Cycles:180 Average:14567.47 Median:49005.25 stddev:16919.23 (34.5%) stddev-sans-first:16935.03 19:06:43 INFO - PROCESS | 23823 | Values: 784.1 821.1 825.9 844.9 867.0 14411.0 14745.8 14855.3 14909.6 14986.2 14056.1 14183.1 14187.9 14189.1 14206.6 681.4 795.6 838.6 841.5 842.6 830.1 833.0 834.0 834.8 835.6 709.0 867.3 868.6 871.0 871.2 722.9 726.6 826.2 856.1 858.4 621.6 622.9 623.1 623.8 624.0 14415.5 14472.1 14474.1 14482.3 14485.5 13924.4 13946.9 13964.2 14145.5 14239.6 10699.9 10989.1 11001.4 11019.9 11139.6 3831.3 3862.2 3889.5 3957.1 3964.5 53849.2 54440.5 54507.5 54564.5 55098.0 11061.9 11348.3 11408.3 11535.9 11556.8 19121.5 19914.0 20104.8 20260.8 20288.1 8396.8 8442.7 8465.5 8494.8 8513.6 4594.3 4613.7 4696.1 4701.1 4770.9 3535.4 3645.5 3649.7 3651.9 3655.4 644.7 651.7 656.3 656.7 661.2 646.1 708.8 739.1 750.9 761.8 8446.8 8465.2 8922.4 8980.6 9145.4 712.2 716.7 727.2 730.0 748.9 4197.2 4211.5 4275.6 4312.6 4423.5 60156.0 60522.0 61285.7 61355.0 61560.1 54160.2 54984.7 55048.7 55479.0 56099.7 48729.0 49281.5 49431.8 49754.0 49954.3 8248.5 8273.3 8283.5 8483.3 8514.2 33109.5 33128.3 33241.3 33349.8 33648.5 40994.2 44644.3 44895.6 45209.8 45251.8 10774.2 10830.9 11018.6 11181.1 11240.8 12280.1 12509.6 12583.8 12597.2 12613.4 11829.3 12065.4 12074.6 12093.8 12443.7 11683.3 11828.2 11857.6 11872.4 11878.2 11407.4 11489.5 11701.0 11765.6 12336.0 9362.9 9568.3 9599.9 9634.4 9712.7 9306.8 9385.2 9440.5 9505.0 9576.5 19:06:43 INFO - PROCESS | 23823 | -------- Summary: end -------- 19:06:43 INFO - PROCESS | 23823 | 19:06:44 INFO - TEST-INFO | 23823: exit 0 19:06:44 INFO - TEST-OK | dromaeo_css | took 1110730ms 19:06:44 INFO - TEST-START | kraken 19:06:44 INFO - operating with platform_type : linux_ 19:06:44 INFO - Initialising browser for kraken test... 19:06:44 INFO - TEST-INFO | started process 23999 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYbgImd/profile http://localhost:39059/getInfo.html) 19:06:48 INFO - PROCESS | 23999 | __metrics Screen width/height:1600/1200 19:06:48 INFO - PROCESS | 23999 | colorDepth:24 19:06:48 INFO - PROCESS | 23999 | Browser inner width/height: 1024/697 19:06:48 INFO - PROCESS | 23999 | __metrics 19:06:48 ERROR - PROCESS | 23999 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:06:49 INFO - TEST-INFO | 23999: exit 0 19:06:49 INFO - Browser initialized. 19:06:49 INFO - Running cycle 1/1 for kraken test... 19:06:49 INFO - TEST-INFO | started process 24083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYbgImd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:01 INFO - PROCESS | 24083 | RSS: Main: 153264128 19:07:01 INFO - PROCESS | 24083 | 19:07:03 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39059/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:04 INFO - PROCESS | 24083 | RSS: Main: 208121856 19:07:04 INFO - PROCESS | 24083 | 19:07:07 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39059/tests/kraken/driver.html?testName=audio-dft) 19:07:07 INFO - PROCESS | 24083 | RSS: Main: 194342912 19:07:07 INFO - PROCESS | 24083 | 19:07:11 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39059/tests/kraken/driver.html?testName=audio-fft) 19:07:11 INFO - PROCESS | 24083 | RSS: Main: 264372224 19:07:11 INFO - PROCESS | 24083 | 19:07:13 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39059/tests/kraken/driver.html?testName=audio-oscillator) 19:07:14 INFO - PROCESS | 24083 | RSS: Main: 173481984 19:07:14 INFO - PROCESS | 24083 | 19:07:16 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:17 INFO - PROCESS | 24083 | RSS: Main: 177901568 19:07:17 INFO - PROCESS | 24083 | 19:07:20 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39059/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:20 INFO - PROCESS | 24083 | RSS: Main: 213704704 19:07:20 INFO - PROCESS | 24083 | 19:07:24 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39059/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:24 INFO - PROCESS | 24083 | RSS: Main: 214405120 19:07:24 INFO - PROCESS | 24083 | 19:07:27 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39059/tests/kraken/driver.html?testName=json-parse-financial) 19:07:28 INFO - PROCESS | 24083 | RSS: Main: 214634496 19:07:28 INFO - PROCESS | 24083 | 19:07:29 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:30 INFO - PROCESS | 24083 | RSS: Main: 201904128 19:07:30 INFO - PROCESS | 24083 | 19:07:31 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:32 INFO - PROCESS | 24083 | RSS: Main: 203780096 19:07:32 INFO - PROCESS | 24083 | 19:07:34 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:35 INFO - PROCESS | 24083 | RSS: Main: 219213824 19:07:35 INFO - PROCESS | 24083 | 19:07:37 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:38 INFO - PROCESS | 24083 | RSS: Main: 222306304 19:07:38 INFO - PROCESS | 24083 | 19:07:41 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:41 INFO - PROCESS | 24083 | RSS: Main: 217939968 19:07:41 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | Cycle 1(1): loaded http://localhost:39059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39059/tests/kraken/driver.html?testName=ai-astar) 19:07:43 INFO - PROCESS | 24083 | RSS: Main: 281219072 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | __start_tp_report 19:07:43 INFO - PROCESS | 24083 | _x_x_mozilla_page_load 19:07:43 INFO - PROCESS | 24083 | _x_x_mozilla_page_load_details 19:07:43 INFO - PROCESS | 24083 | |i|pagename|runs| 19:07:43 INFO - PROCESS | 24083 | |0;ai-astar;111;111;107;109;111;112;101;111;111;112 19:07:43 INFO - PROCESS | 24083 | |1;audio-beat-detection;153;128;150;182;134;157;153;128;180;127 19:07:43 INFO - PROCESS | 24083 | |2;audio-dft;163;160;162;160;160;161;161;162;161;161 19:07:43 INFO - PROCESS | 24083 | |3;audio-fft;76;72;93;109;73;73;78;119;102;73 19:07:43 INFO - PROCESS | 24083 | |4;audio-oscillator;93;92;154;93;92;92;154;93;93;150 19:07:43 INFO - PROCESS | 24083 | |5;imaging-gaussian-blur;116;116;117;117;117;116;116;117;117;117 19:07:43 INFO - PROCESS | 24083 | |6;imaging-darkroom;145;145;146;145;146;146;146;146;147;146 19:07:43 INFO - PROCESS | 24083 | |7;imaging-desaturate;97;95;95;95;96;96;95;95;96;95 19:07:43 INFO - PROCESS | 24083 | |8;json-parse-financial;57;57;57;56;57;57;60;71;55;55 19:07:43 INFO - PROCESS | 24083 | |9;json-stringify-tinderbox;63;63;62;62;62;62;68;62;63;62 19:07:43 INFO - PROCESS | 24083 | |10;stanford-crypto-aes;80;80;79;79;80;88;80;86;83;82 19:07:43 INFO - PROCESS | 24083 | |11;stanford-crypto-ccm;129;131;131;130;137;129;127;126;159;127 19:07:43 INFO - PROCESS | 24083 | |12;stanford-crypto-pbkdf2;170;166;163;164;165;167;166;164;164;168 19:07:43 INFO - PROCESS | 24083 | |13;stanford-crypto-sha256-iterative;67;70;71;69;67;67;68;68;69;67 19:07:43 INFO - PROCESS | 24083 | __end_tp_report 19:07:43 INFO - PROCESS | 24083 | __start_cc_report 19:07:43 INFO - PROCESS | 24083 | _x_x_mozilla_cycle_collect,1626 19:07:43 INFO - PROCESS | 24083 | __end_cc_report 19:07:43 INFO - PROCESS | 24083 | __startTimestamp1460340463751__endTimestamp 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | ------- Summary: start ------- 19:07:43 INFO - PROCESS | 24083 | Number of tests: 14 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:3.54 19:07:43 INFO - PROCESS | 24083 | Values: 111.0 111.0 107.0 109.0 111.0 112.0 101.0 111.0 111.0 112.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:153.00 stddev:20.38 (13.3%) stddev-sans-first:21.57 19:07:43 INFO - PROCESS | 24083 | Values: 153.0 128.0 150.0 182.0 134.0 157.0 153.0 128.0 180.0 127.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.78 19:07:43 INFO - PROCESS | 24083 | Values: 163.0 160.0 162.0 160.0 160.0 161.0 161.0 162.0 161.0 161.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#3] audio-fft Cycles:10 Average:86.80 Median:73.00 stddev:17.59 (24.1%) stddev-sans-first:18.21 19:07:43 INFO - PROCESS | 24083 | Values: 76.0 72.0 93.0 109.0 73.0 73.0 78.0 119.0 102.0 73.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.50 stddev:29.05 (31.4%) stddev-sans-first:30.11 19:07:43 INFO - PROCESS | 24083 | Values: 93.0 92.0 154.0 93.0 92.0 92.0 154.0 93.0 93.0 150.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:07:43 INFO - PROCESS | 24083 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 19:07:43 INFO - PROCESS | 24083 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 147.0 146.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 19:07:43 INFO - PROCESS | 24083 | Values: 97.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:4.71 (8.3%) stddev-sans-first:4.97 19:07:43 INFO - PROCESS | 24083 | Values: 57.0 57.0 57.0 56.0 57.0 57.0 60.0 71.0 55.0 55.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.50 stddev:1.85 (3.0%) stddev-sans-first:1.96 19:07:43 INFO - PROCESS | 24083 | Values: 63.0 63.0 62.0 62.0 62.0 62.0 68.0 62.0 63.0 62.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:3.09 (3.8%) stddev-sans-first:3.22 19:07:43 INFO - PROCESS | 24083 | Values: 80.0 80.0 79.0 79.0 80.0 88.0 80.0 86.0 83.0 82.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.50 stddev:9.78 (7.5%) stddev-sans-first:10.28 19:07:43 INFO - PROCESS | 24083 | Values: 129.0 131.0 131.0 130.0 137.0 129.0 127.0 126.0 159.0 127.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:2.16 (1.3%) stddev-sans-first:1.64 19:07:43 INFO - PROCESS | 24083 | Values: 170.0 166.0 163.0 164.0 165.0 167.0 166.0 164.0 164.0 168.0 19:07:43 INFO - PROCESS | 24083 | 19:07:43 INFO - PROCESS | 24083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.42 (2.1%) stddev-sans-first:1.42 19:07:43 INFO - PROCESS | 24083 | Values: 67.0 70.0 71.0 69.0 67.0 67.0 68.0 68.0 69.0 67.0 19:07:43 INFO - PROCESS | 24083 | -------- Summary: end -------- 19:07:43 INFO - PROCESS | 24083 | 19:07:44 INFO - TEST-INFO | 24083: exit 0 19:07:44 INFO - TEST-OK | kraken | took 60380ms 19:07:44 INFO - SUITE-END | took 1171s 19:07:44 INFO - Completed test suite (00:19:31) 19:07:44 INFO - javascript benchmark 19:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.597702298701, 3133.592632957718, 3158.24202191474, 3172.2386627209476, 3199.2161920329518, 5199.220116982455, 5285.101532739434, 5313.335833020872, 5353.411124776277, 5366.141417373216, 5269.8155564555245, 5321.760520776565, 5341.06531357013, 5343.412224655285, 5344.171653393721, 4756.239001759719, 4808.110499557593, 4833.661643684944, 4864.805407783684, 4890.657653964224, 4723.0, 4831.9275210871865, 4853.126437241295, 4886.755662216893, 4886.828960986366, 4731.645126615517, 4824.7105173689515, 4861.100696371147, 4884.658073934808, 4930.926036109461, 4792.137415265251, 4809.206480930642, 4809.903801923977, 4813.061453016663, 4851.8301859435105, 4668.0, 4772.308015337757, 4777.617790576745, 4794.089123066607, 4797.928031079537, 5253.159494480903, 5291.603129765244, 5294.391145018334, 5301.01931142736, 5303.946960530384, 5707.857303567403, 5714.142878568248, 5720.885582288331, 5734.483896449339, 5737.39757325479, 5540.833774986757, 5715.257016587859, 5758.452946970031, 5761.913571296392, 5773.220615216934, 5369.865753356119, 5379.9731001345135, 5388.084025715599, 5394.595405344615, 5421.430749771296, 5818.796342128006, 5820.767169313265, 5824.941750582525, 5827.388124246893, 5840.211571437886, 5512.4211957744665, 5600.019996500678, 5622.606417550732, 5627.409122042209, 5673.149027645886, 5712.6286791358425, 5722.885542289214, 5724.971375143097, 5725.59920805548, 5755.453231942959, 5681.545476361881, 5684.54523638108, 5686.0, 5687.40282270364, 5690.715464226772, 5479.972600136974, 5656.236408084938, 5715.857103572361, 5716.828495145152, 5742.942570574241, 4302.462192225972, 4304.440422745023, 4305.590968857953, 4308.67684923632, 4341.826326946887, 3850.961490385116, 3865.014421322545, 3873.1091848874917, 3892.1048158923604, 3905.3556163233316, 5282.313299271147, 5359.839204823861, 5452.0, 5533.557315414757, 5541.307336582927, 5688.9715551422805, 5690.715464226772, 5698.686572238566, 5703.144528320702, 5706.914396284059, 5377.569794416438, 5378.865528361744, 5379.1393377059485, 5381.0852155133725, 5426.348838139448, 4691.085238378551, 4786.8085276588545, 4817.0365926814775, 4871.14754917888, 4875.024995001014, 5831.708414579254, 5861.853453663693, 5864.44287792659, 5864.67744274069, 5865.384134665798, 5605.887882242251, 5696.943030569724, 5700.971495142498, 5702.8289151325525, 5703.828885133453, 5910.113482977587, 5951.583389162717, 5966.522678185648, 5984.13230081627, 5993.730282137227, 5573.860653483695, 5580.665160090408, 5587.608867379245, 5591.161325801162, 5598.188262701967, 5556.833295001156, 5652.604317697722, 5703.857403564778, 5709.885802284014, 5715.971420142872, 5553.916691249554, 5565.081761509306, 5568.443155684399, 5570.972145139248, 5616.85957851057, 5551.500364967173, 5553.8333849984565, 5554.555635549227, 5555.333359996826, 5559.471850174227, 5434.130539113723, 5456.781728730806, 5519.061759500974, 5521.033819081565, 5573.749181286933, 5608.803691870929, 5612.158176273591, 5614.326280846324, 5630.0, 5661.490465858093, 5499.285092937893, 5505.669659820263, 5507.03626865289, 5510.448955104457, 5526.640768350205], "value": 5248.532761843697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.970701464927, 619.5508256514031, 631.3686313686313, 632.8259728574642, 639.5139693832688, 29471.852640736794, 35826.820865895665, 36660.0, 36688.08279793007, 36725.44911826325, 40095.799521002424, 40592.59407405932, 40769.59230407702, 40813.183736325256, 40835.59164408355, 7624.961875190616, 8519.914800852006, 8681.479111253346, 8716.520591367473, 8719.564021798917, 10018.549165287543, 10377.325473844214, 10420.843687344695, 10430.843537346946, 10433.739156521071, 10166.390016599027, 10194.439305838176, 10236.283460157792, 10258.640947566837, 10261.794764104714, 10216.846747298796, 10287.0741633253, 10319.638812641522, 10326.122279606205, 10341.482925853752, 10099.848502272473, 10174.542145603391, 10223.897761022368, 10224.744381390525, 10232.79534409315, 37433.81283093567, 37617.435738463944, 37766.24467510635, 37773.62226377729, 37813.0, 3482.1938914983025, 3517.56030496188, 3518.225990282134, 3560.181158333572, 3725.3853114236117, 30641.69358306433, 30838.22904427385, 31080.533791993137, 31085.68914310873, 31334.0, 4189.706720529564, 4191.407614390518, 4297.462817147856, 4301.591348821857, 4331.306990881475, 207939.0, 211317.0, 211667.0, 212434.0, 212485.0, 35863.0, 36884.446733299024, 36988.260234795154, 37008.25983480315, 60700.69649651812, 35313.64686353104, 35459.82270088685, 35480.46779298312, 35485.822570887496, 35521.1119722009, 14144.151350918977, 14335.139891606537, 14336.354864031144, 14338.713225735635, 14339.426422943174, 11698.76602467963, 12405.255684658949, 12619.810702839464, 12691.492340306284, 12769.106162568716, 8551.786205344792, 8560.828783424422, 8574.27118694918, 8623.353248506262, 8643.654253829776, 3137.7646676499353, 3236.546883436321, 3303.4143611066343, 3306.570145881068, 3365.2764655599162, 1012.4380968562518, 1050.5902697947806, 1094.3105843318658, 1161.4773351991637, 1263.8041103628952, 31116.844415777778, 31245.53131703026, 31331.0, 31528.842355788074, 31678.208044798605, 1144.2619510415734, 1160.14729174057, 1167.095500986742, 1232.9704696578278, 1248.950041998328, 16597.502074937773, 17003.91498042502, 17051.91474042622, 17180.312787488612, 17259.482215533553, 427827.0, 429760.0, 433446.0, 433577.0, 434628.0, 57298.7135064322, 58014.4198558009, 58198.41801582015, 58290.41709582935, 58306.416935830945, 1199.682084247675, 1392.3108061509618, 1397.238505014749, 1422.2177802208744, 1434.9426022958964, 30334.393312133194, 31546.211344716565, 32255.35489290248, 32282.515762263116, 32798.34403311873, 44220.55779442164, 46255.306170406795, 46349.536504634525, 46357.0, 46447.767761160976, 246532.0, 252019.0, 252617.0, 253143.0, 413651.0, 26422.207333780018, 27386.452270954072, 27427.588586170823, 28513.0, 29351.55972660369, 41865.0, 42292.0, 42311.576884230766, 42513.5748642522, 42856.35715464208, 35327.823360883034, 35439.64560354467, 36121.63878361183, 36189.27621447609, 38028.2394352117, 39018.41472377974, 39029.6097039026, 39076.413853791644, 39113.41329879997, 39359.0, 38843.22313553769, 39764.0, 40032.59967400405, 40334.79832600935, 40386.596134038286, 33296.66703332936, 33941.151471213416, 34218.48672269868, 34455.0, 35073.64926350704, 27000.459990800467, 27284.45431091407, 27314.180574582795, 27375.726242738114, 27802.721972780822], "value": 17965.092089755726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.98812035638935, 396.20758483033933, 402.86906755304534, 412.0769476372924, 412.31349802578706, 17603.119844007797, 18292.542686432847, 18363.0, 18416.0, 19308.903455482738, 18094.728579071325, 18461.630767384646, 18689.0, 18972.146253418596, 18991.715124273112, 5514.91727624085, 5622.128570071645, 5683.602147849652, 5686.0, 5705.058665320238, 5475.780968761244, 5490.121580547113, 5492.340919089695, 5492.972535137319, 5680.204771331996, 5565.638233514829, 5568.693721845297, 5602.495775380215, 5640.605157638967, 5660.122680984454, 5454.481824226692, 5557.472040156179, 5565.66606003637, 5569.610127291091, 5598.4961353478175, 4795.448523419816, 4930.137225985438, 5188.5849132069725, 5189.974050129763, 5190.143626301693, 13623.25072121033, 13861.0, 13924.651883702989, 13924.860751392458, 14240.786388204186, 2316.476184347949, 2438.2685194441597, 2814.717633728906, 2860.4708128996203, 2975.79169458138, 10082.89917100827, 10523.684289471328, 10615.946920265427, 11522.251053681568, 13518.256495892721, 1781.7238328059173, 1799.208348326732, 1813.9274429022823, 1822.9088545572667, 1854.2304943448453, 72918.27081729168, 75599.24400755977, 75796.0, 76461.99999999945, 77449.61275193589, 9883.851742223873, 10012.0, 10028.899711002796, 10185.319422295386, 10227.846582301272, 13716.314184290746, 13740.793888091686, 13872.514461993782, 13911.095778774346, 13928.164310141221, 7608.581528016012, 7662.46362754613, 7686.519188888928, 7728.961355193188, 7763.059235191202, 7494.962525187449, 7578.242175782488, 7682.539047657158, 7683.577403242875, 7688.38492920565, 4136.565660605654, 4219.852305169305, 4229.471316085489, 4288.935665965013, 4293.8711838644895, 1708.7693161423297, 1786.8034516203206, 1805.0343066459382, 1810.6197698483202, 1817.790954040276, 926.8517037274139, 936.5738588942015, 972.4019727867452, 979.4906648542718, 1027.6505987963978, 17630.647387052442, 18568.907155464138, 18892.149853256637, 19004.61990760177, 19101.140448679842, 983.2969426859687, 1005.100435110572, 1008.6016023670755, 1019.7042857571221, 1043.2644985285356, 10069.848952265722, 10296.691099267035, 10406.219533534864, 10457.11114555256, 10477.528511217013, 449071.0, 452367.0, 453266.0, 454324.0, 477535.0, 84267.0, 87145.5642721795, 88934.0, 89191.0, 90849.54575227082, 1000.8248556502583, 1011.3325205364424, 1015.1726343030407, 1020.3724709303873, 1031.9319504313, 15860.68278634444, 16077.517674469784, 16099.75850362222, 16111.516654500383, 16455.835441645908, 36555.0, 37173.44239836459, 37264.0, 37450.81274593718, 37497.62502374942, 52215.0, 53374.73312633412, 55447.72276138755, 55475.44524554864, 56016.71991640016, 8390.748277551684, 8462.19609137131, 8636.697715579925, 8654.913450865412, 8731.956340218258, 7257.963710181626, 10886.67339979802, 11368.635763708407, 12645.608983012045, 12832.588415274126, 10834.241603088023, 10941.28881622692, 11282.435878205893, 11453.713657158305, 11517.94241028823, 10667.839982400425, 10728.302660327367, 10738.73153171177, 10976.341419514536, 11029.669109926715, 11396.715082123013, 11446.713832154262, 11521.711957201138, 11615.88384116148, 11889.643310700692, 8082.515049097073, 8226.136255693065, 8357.791055223668, 8388.790280243044, 8466.280366168945, 11157.66527004191, 11171.944140279247, 11251.831222531504, 11277.47754053225, 11429.085673146295], "value": 8732.73465169301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.0235086614794, 1545.4359158906998, 1551.4259723902155, 1757.4551888914436, 1859.7582314299132, 7776.611169441534, 8135.552544610044, 8297.087320394752, 8315.958420207906, 8329.83340333193, 8016.118226995026, 8174.059983101945, 8182.304504117157, 8184.91815081849, 8188.22211889871, 2062.3606681928577, 2319.6288593824993, 2331.80179684727, 2356.210669425736, 2416.118116887341, 2395.592749232626, 2416.7824895759377, 2417.443987882788, 2418.7944024757917, 2422.5760491913934, 2298.069281940808, 2364.657124716915, 2365.1367250953363, 2369.5142495788323, 2370.608849539824, 2010.4069299556593, 2244.6408574628063, 2321.3732292281156, 2321.3964369263945, 2327.94180145496, 2256.3005468304877, 2276.0213108363396, 2285.177336158998, 2308.134449581407, 2370.751071137523, 8537.957310213471, 8623.913760862437, 8627.913720862836, 8629.0, 8645.265152462049, 5071.797128114871, 5248.160294352885, 5248.396434410053, 5260.210968354739, 5276.81531146408, 3276.5904261967253, 3327.9833600832085, 3363.6468170841954, 3403.3363494118657, 3408.5739282589675, 1091.372460835023, 1099.5217080569898, 1103.5916710816969, 1122.7024838417826, 1131.7283851875573, 11672.824907626393, 11707.180497365187, 11707.2975621463, 11707.648770536813, 11720.238184517893, 4505.864824055284, 4571.337156112345, 4714.882127946828, 4723.504032076651, 4740.0, 9832.901670983341, 9833.557489912828, 9847.0, 9849.55676994537, 9853.852192217122, 4756.405449318835, 5279.44565820591, 5288.889333240063, 5298.2052692096495, 5319.0957537218765, 4743.952560474351, 4855.295982082578, 4858.198397264412, 4864.829730959399, 4867.099586576494, 3926.6073392660505, 4020.83916643331, 4047.0489434982755, 4091.468109145792, 4142.08874047709, 1287.3563218390805, 1289.4584274604688, 1304.230504002624, 1316.3878796359738, 1323.1069028405789, 1177.270092542612, 1310.2727985967879, 1383.1424516799648, 1393.1362555215628, 1455.2360010994312, 8185.959070204611, 8186.0586032605825, 8189.50862948225, 8209.261166494925, 8275.048369437593, 469.3499503188041, 476.99046019079424, 482.8816939849689, 484.2204051477119, 484.7382413496743, 6311.495080393557, 6322.589031713016, 6363.459105975951, 6373.904391434132, 6382.489400848014, 9878.407295562289, 10584.364938103738, 10749.89250107489, 10753.677389678322, 10754.193435492212, 10469.68590942273, 10623.0, 10637.095846853104, 10639.734006649896, 10654.0, 7973.681052757941, 8031.718889838944, 8037.196280372033, 8066.838663226703, 8144.959275203586, 7915.881261781193, 8039.316658084128, 8269.875951860848, 8272.503649781032, 8287.212714792086, 9531.952340238255, 9537.427754334762, 9788.804223915624, 9803.80392392134, 9863.01369863008, 9788.216942644714, 9917.355371900803, 10027.699169024942, 10131.13885319756, 10292.639757608447, 6730.798076057726, 6820.693068812015, 7593.620318983918, 7626.694932202649, 7754.6898124074405, 8241.25828675422, 8269.29710974574, 8319.500829950222, 8329.666813327642, 8332.541710205996, 7375.336219740249, 7593.1647518774, 7621.809454763454, 7651.464397492345, 7742.845143097219, 7431.3683336916965, 7562.848743025219, 7576.24237576238, 7667.079950405764, 7670.8082297943, 7941.960290198512, 7965.442419030613, 8051.8792218115605, 8055.718049868226, 8058.19418058213, 7273.3817625500305, 7307.086614173229, 7432.0, 7444.851102977802, 7446.962765186139, 7516.24837516244, 7535.0, 7550.5469671819865, 7568.659410326659, 7590.8102297443], "value": 4796.311749307203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.28580338387695, 340.9079548521899, 341.623056090545, 345.51972757866554, 348.9092835862675, 5537.1140617501205, 5575.721213939302, 5618.5786066045, 5636.408177141392, 5649.096144616862, 5527.198556209347, 5544.0, 5573.108302671573, 5584.441555844423, 5586.24585680933, 4134.111166099288, 4258.872233832974, 4260.744355338674, 4284.014676624378, 4347.565243475651, 4267.722598031133, 4281.807318670667, 4284.850030248942, 4285.764282964451, 4288.871333859989, 4237.6734263603075, 4265.208612382807, 4265.402843601898, 4265.637420819234, 4276.700630955835, 4157.204892235365, 4257.638100761439, 4267.338562522814, 4288.206681763852, 4293.763842988635, 3720.274546463441, 3749.6812770914503, 3753.3244016077097, 3757.0982964088694, 3762.4761971401626, 5338.412774594792, 5338.546223571001, 5349.09065458869, 5372.113601255788, 5377.865553361197, 4801.663883528119, 4969.180085285923, 4972.602191824645, 4974.452810190876, 4998.8250411235795, 5812.505936995361, 5831.475167234969, 5834.883302333929, 5868.706564671749, 5872.5889187756875, 4132.380142978547, 4138.772367519785, 4173.353130264813, 4176.91646167078, 4177.624013838769, 5981.0729336952845, 6090.390960903918, 6110.755569777248, 6154.476869466101, 6168.475679567242, 4243.893902652397, 4262.85080022204, 4276.273033584298, 4285.571442855689, 4298.3552467130185, 4303.33298338758, 4313.094250207491, 4315.4605674290715, 4317.287647538184, 4334.176506463762, 4787.832425865147, 4969.701817890938, 4970.0, 4984.277279794482, 4985.0, 5887.76448942046, 5906.793262235801, 5919.911201331984, 5926.2888453385, 5928.199693041384, 1475.6827282134393, 1505.9232648656046, 1505.9397624095132, 1507.1559926441228, 1507.3970411835135, 974.91713204377, 1009.9242556808122, 1010.8332125199407, 1022.4887556221889, 1029.8249297619423, 5678.233438485834, 5688.943110568925, 5689.943100569024, 5704.258446402024, 5711.286089238845, 6044.24446944132, 6085.513158947274, 6101.877962440815, 6102.267727872595, 6125.816225513242, 5538.446155384429, 5691.9146212806845, 5714.828555143353, 5749.195112684228, 5757.942420575824, 3270.296886169485, 3273.0998975281987, 3273.8035717857006, 3278.09852290622, 3281.868725251011, 6151.231096112986, 6298.811035668846, 6308.842278943063, 6319.241690997018, 6336.366363363627, 5901.557383196192, 6173.59871608353, 6176.382361763787, 6205.937940620626, 6225.906611400833, 6089.208402907682, 6303.590266632654, 6323.114763933053, 6325.430711236011, 6338.968305158444, 5804.1293805929445, 5887.352391236875, 6138.969305153446, 6156.722947467285, 6168.845778855564, 6030.517558595214, 6064.4541991221, 6072.605280656743, 6099.268087829489, 6120.785772497941, 6225.750969961332, 6276.278228003838, 6296.653684047421, 6321.4801416987075, 6351.2696039956, 4299.247631664383, 4305.461817272841, 4306.97846510778, 4316.9352459713755, 4324.329728892027, 6133.723982420713, 6168.753249869955, 6178.783742569169, 6183.134361189347, 6185.907211391923, 5826.76692932278, 5996.820095397145, 5998.640081594944, 6000.789972350947, 6007.3992600739575, 5912.586118971631, 5946.524278057832, 5980.3421623622235, 5983.162357270073, 6007.128966299774, 5844.532437405082, 5849.034909239927, 5885.0, 5899.144624029406, 5933.525317974638, 5875.0, 5979.222701048836, 5987.0, 5987.6108052976415, 6013.30846952606, 5879.5002424792665, 5882.499987500939, 5907.3797251288, 5913.0, 5939.613925095028], "value": 4489.641638373151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.0669603172227, 821.1378053044302, 825.9132791056938, 844.9281811046061, 866.9783255418614, 14410.999999999987, 14745.778813317782, 14855.331510082058, 14909.552713418601, 14986.175760333204, 14056.086354386984, 14183.078099923523, 14187.929060354683, 14189.148651080943, 14206.644833879132, 681.4037716997627, 795.6141271483326, 838.5597561280316, 841.5371545649899, 842.6418772021866, 830.1242189490085, 832.9791755206107, 834.0, 834.8038211020405, 835.6364981233153, 709.0463326825411, 867.3104881619128, 868.5700578213794, 870.9564521773917, 871.2072014466836, 722.8807246804297, 726.6076318787848, 826.1655727715021, 856.1267507142679, 858.3776761847611, 621.6301300726105, 622.947049500793, 623.0778447897137, 623.7785586116909, 624.0140577886928, 14415.495457659037, 14472.131672099602, 14474.059186152866, 14482.34829432678, 14485.493007744679, 13924.37340319678, 13946.860531394657, 13964.231967241798, 14145.504907328193, 14239.572812815632, 10699.946500267526, 10989.06592939601, 11001.449927503672, 11019.944900275448, 11139.610113645984, 3831.3295173344554, 3862.246861861938, 3889.4749208856724, 3957.08986933007, 3964.464797252363, 53849.1922621161, 54440.455595443935, 54507.45492545103, 54564.454355456335, 55098.0, 11061.889381106246, 11348.262362946381, 11408.258463199865, 11535.884641153649, 11556.826647600292, 19121.52196195106, 19914.0, 20104.798952010584, 20260.797392026187, 20288.087036083412, 8396.790080248044, 8442.704505342406, 8465.534395608178, 8494.787630309293, 8513.574321284035, 4594.264917613166, 4613.700109492872, 4696.131215725033, 4701.106789709944, 4770.928436073462, 3535.398982173037, 3645.54430696163, 3649.708023358125, 3651.8721844735305, 3655.3968595181495, 644.6615526848442, 651.726274964516, 656.3174298729268, 656.7373050779631, 661.1933441201726, 646.0793369448517, 708.7590219325455, 739.1425945902727, 750.8723517002122, 761.7905076104116, 8446.788830279293, 8465.195806398382, 8922.375433719708, 8980.640774369083, 9145.3598248122, 712.2236761929522, 716.6846587501483, 727.2146082231178, 729.9635018249066, 748.9325960663566, 4197.244495990751, 4211.494620645542, 4275.5724427557, 4312.568743125662, 4423.51341352451, 60156.0, 60522.0, 61285.69357153275, 61355.0, 61560.076598851054, 54160.18759718607, 54984.725076374365, 55048.72475637596, 55479.0, 56099.71950140223, 48729.0, 49281.50718492841, 49431.75284123556, 49754.0, 49954.250686239735, 8248.54632995191, 8273.33813294947, 8283.544405057779, 8483.321334293365, 8514.191151840565, 33109.503357450136, 33128.33743325168, 33241.33517329688, 33349.83325083359, 33648.49527257142, 40994.1801163981, 44644.33033504435, 44895.55104448914, 45209.77395113003, 45251.77374113108, 10774.191935605018, 10830.891691082988, 11018.559257629606, 11181.105511559219, 11240.775184496428, 12280.140390172603, 12509.624711258677, 12583.811242831182, 12597.181183223061, 12613.36933153357, 11829.349385783864, 12065.396730163282, 12074.637760867188, 12093.818592721293, 12443.688907777378, 11683.299002059903, 11828.17202795796, 11857.644270671894, 11872.406379680808, 11878.168528202943, 11407.429628518375, 11489.482973266056, 11701.044308220737, 11765.647030589096, 12336.0, 9362.906370936204, 9568.282378821477, 9599.904000959901, 9634.421934683942, 9712.660056897974, 9306.813863722553, 9385.15533601979, 9440.48077355752, 9504.952475237857, 9576.473293968898], "value": 6648.45379890099, "unit": "score"}], "name": "dromaeo_css", "value": 7002.434905595413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 107.0, 109.0, 111.0, 112.0, 101.0, 111.0, 111.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 150.0, 182.0, 134.0, 157.0, 153.0, 128.0, 180.0, 127.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 93.0, 109.0, 73.0, 73.0, 78.0, 119.0, 102.0, 73.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 154.0, 93.0, 92.0, 92.0, 154.0, 93.0, 93.0, 150.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 60.0, 71.0, 55.0, 55.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 68.0, 62.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 79.0, 80.0, 88.0, 80.0, 86.0, 83.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 131.0, 130.0, 137.0, 129.0, 127.0, 126.0, 159.0, 127.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 163.0, 164.0, 165.0, 167.0, 166.0, 164.0, 164.0, 168.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 71.0, 69.0, 67.0, 67.0, 68.0, 68.0, 69.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1544.6000000000001, "alertThreshold": 2.0}]} 19:07:44 INFO - Return code: 0 19:07:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:45 ERROR - # TBPL SUCCESS # 19:07:45 INFO - Running post-action listener: _resource_record_post_action 19:07:45 INFO - Running post-run listener: _resource_record_post_run 19:07:46 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538603520; Read time: 24; Write time: 354312 19:07:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 243638272; Read time: 0; Write time: 210708 19:07:46 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294965248; Read time: 24; Write time: 143604 19:07:46 INFO - Running post-run listener: _upload_blobber_files 19:07:46 INFO - Blob upload gear active. 19:07:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:07:46 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 19:07:46 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'] 19:07:46 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 19:07:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:07:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:47 INFO - (blobuploader) - INFO - Done attempting. 19:07:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:07:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:48 INFO - (blobuploader) - INFO - Done attempting. 19:07:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:48 INFO - Return code: 0 19:07:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:07:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92463d3c4c7342a5124492557985e055a16d01478275c845ffee4d5b5f899824bc1f70b183c18acbd4388431d8bc2b88f65a8c3906973e2d6f8f1622dde6e1f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/621864307f9c9145b6fca87255b3c3073864b53a53dbef9f879a98115c3a8d3d26c7c4320638ce03a80bb503097bd71fdca67e18b41ecd14a4c766f05d7eb69a"} 19:07:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:07:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:07:48 INFO - Contents: 19:07:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92463d3c4c7342a5124492557985e055a16d01478275c845ffee4d5b5f899824bc1f70b183c18acbd4388431d8bc2b88f65a8c3906973e2d6f8f1622dde6e1f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/621864307f9c9145b6fca87255b3c3073864b53a53dbef9f879a98115c3a8d3d26c7c4320638ce03a80bb503097bd71fdca67e18b41ecd14a4c766f05d7eb69a"} 19:07:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:07:48 INFO - Copying logs to upload dir... 19:07:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:07:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.177811 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-10 19:07:47.922936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 19:07:47.926716) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92463d3c4c7342a5124492557985e055a16d01478275c845ffee4d5b5f899824bc1f70b183c18acbd4388431d8bc2b88f65a8c3906973e2d6f8f1622dde6e1f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/621864307f9c9145b6fca87255b3c3073864b53a53dbef9f879a98115c3a8d3d26c7c4320638ce03a80bb503097bd71fdca67e18b41ecd14a4c766f05d7eb69a"} build_url:https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/apnMa-hkRJOKn-ET2pjg4w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92463d3c4c7342a5124492557985e055a16d01478275c845ffee4d5b5f899824bc1f70b183c18acbd4388431d8bc2b88f65a8c3906973e2d6f8f1622dde6e1f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/621864307f9c9145b6fca87255b3c3073864b53a53dbef9f879a98115c3a8d3d26c7c4320638ce03a80bb503097bd71fdca67e18b41ecd14a4c766f05d7eb69a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-10 19:07:47.951152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 19:07:47.951478) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1460338793.333201-731761513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-10 19:07:48.035071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 19:07:48.035404) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-10 19:07:48.035692) ========= ========= Total master_lag: 0.30 =========