builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1456898360.0 results: success (0) buildid: 20160301193336 builduid: 5b0358802bde4fab8e4ace8519e3be93 revision: 3bd640d45525f634e2f24049fbfe051683581c88 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.004750) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.005135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.005418) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006314 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.033358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.033640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.060859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.061145) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019112 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.107476) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.107792) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.108169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.108456) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 21:59:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-03-01 21:59:20 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.262083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.262368) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.063952 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.337461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.337814) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3bd640d45525f634e2f24049fbfe051683581c88 --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 3bd640d45525f634e2f24049fbfe051683581c88 --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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 21:59:20,472 truncating revision to first 12 chars 2016-03-01 21:59:20,472 Setting DEBUG logging. 2016-03-01 21:59:20,472 attempt 1/10 2016-03-01 21:59:20,472 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3bd640d45525?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 21:59:20,738 unpacking tar archive at: mozilla-inbound-3bd640d45525/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.914568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.914885) ========= echo 3bd640d45525f634e2f24049fbfe051683581c88 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bd640d45525f634e2f24049fbfe051683581c88'] 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bd640d45525f634e2f24049fbfe051683581c88 program finished with exit code 0 elapsedTime=0.003766 script_repo_revision: '3bd640d45525f634e2f24049fbfe051683581c88' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.963374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.963726) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 21:59:20.973320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-01 21:59:20.973590) ========= /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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:21 INFO - MultiFileLogger online at 20160301 21:59:21 in /builds/slave/test-pgo 21:59:21 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 21:59:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:59:21 INFO - {'append_to_log': False, 21:59:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:59:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:59:21 INFO - 'branch': 'Mozilla-Inbound', 21:59:21 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:21 INFO - 'config_files': ('talos/linux_config.py',), 21:59:21 INFO - 'default_actions': ('clobber', 21:59:21 INFO - 'read-buildbot-config', 21:59:21 INFO - 'download-and-extract', 21:59:21 INFO - 'populate-webroot', 21:59:21 INFO - 'create-virtualenv', 21:59:21 INFO - 'install', 21:59:21 INFO - 'run-tests'), 21:59:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:21 INFO - 'download_minidump_stackwalk': True, 21:59:21 INFO - 'download_symbols': 'ondemand', 21:59:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:21 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:21 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:21 INFO - 'installer_path': 'installer.exe', 21:59:21 INFO - 'log_level': 'info', 21:59:21 INFO - 'log_name': 'talos', 21:59:21 INFO - 'log_to_console': True, 21:59:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:21 INFO - 'opt_config_files': (), 21:59:21 INFO - 'pip_index': False, 21:59:21 INFO - 'sps_profile': False, 21:59:21 INFO - 'sps_profile_interval': 0, 21:59:21 INFO - 'suite': 'dromaeojs', 21:59:21 INFO - 'system_bits': '32', 21:59:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:21 INFO - 'title': 'talos-linux64-ix-020', 21:59:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:21 INFO - 'use_talos_json': True, 21:59:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:59:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:21 INFO - 'work_dir': 'build'} 21:59:21 INFO - ##### 21:59:21 INFO - ##### Running clobber step. 21:59:21 INFO - ##### 21:59:21 INFO - Running pre-action listener: _resource_record_pre_action 21:59:21 INFO - Running main action method: clobber 21:59:21 INFO - rmtree: /builds/slave/test-pgo/build 21:59:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:59:26 INFO - Running post-action listener: _resource_record_post_action 21:59:26 INFO - ##### 21:59:26 INFO - ##### Running read-buildbot-config step. 21:59:26 INFO - ##### 21:59:26 INFO - Running pre-action listener: _resource_record_pre_action 21:59:26 INFO - Running main action method: read_buildbot_config 21:59:26 INFO - Using buildbot properties: 21:59:26 INFO - { 21:59:26 INFO - "project": "", 21:59:26 INFO - "product": "firefox", 21:59:26 INFO - "script_repo_revision": "production", 21:59:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:59:26 INFO - "repository": "", 21:59:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:59:26 INFO - "buildid": "20160301193336", 21:59:26 INFO - "pgo_build": "True", 21:59:26 INFO - "basedir": "/builds/slave/test-pgo", 21:59:26 INFO - "buildnumber": 1557, 21:59:26 INFO - "slavename": "talos-linux64-ix-020", 21:59:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:26 INFO - "platform": "ubuntu64_hw", 21:59:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:26 INFO - "branch": "mozilla-inbound", 21:59:26 INFO - "repo_path": "integration/mozilla-inbound", 21:59:26 INFO - "revision": "3bd640d45525f634e2f24049fbfe051683581c88", 21:59:26 INFO - "stage_platform": "linux64-pgo", 21:59:26 INFO - "builduid": "5b0358802bde4fab8e4ace8519e3be93", 21:59:26 INFO - "slavebuilddir": "test" 21:59:26 INFO - } 21:59:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:59:26 INFO - Running post-action listener: _resource_record_post_action 21:59:26 INFO - ##### 21:59:26 INFO - ##### Running download-and-extract step. 21:59:26 INFO - ##### 21:59:26 INFO - Running pre-action listener: _resource_record_pre_action 21:59:26 INFO - Running main action method: download_and_extract 21:59:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:59: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')]} 21:59:26 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:59:27 INFO - Downloaded 1448 bytes. 21:59:27 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 21:59:27 INFO - Using the following test package requirements: 21:59:27 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'jsshell-linux-x86_64.zip'], 21:59:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:27 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:27 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:29 INFO - Downloaded 23394559 bytes. 21:59:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:30 INFO - Return code: 0 21:59:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:30 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:59:32 INFO - Downloaded 23394559 bytes. 21:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:34 INFO - Return code: 0 21:59: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')]} 21:59:34 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:59:35 INFO - Downloaded 10808456 bytes. 21:59:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:59:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:59:35 INFO - Return code: 0 21:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:35 INFO - https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:59:36 INFO - Downloaded 56148381 bytes. 21:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:36 INFO - mkdir: /builds/slave/test-pgo/properties 21:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:59:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:59:36 INFO - Contents: 21:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - Running post-action listener: _resource_record_post_action 21:59:37 INFO - Running post-action listener: set_extra_try_arguments 21:59:37 INFO - ##### 21:59:37 INFO - ##### Running populate-webroot step. 21:59:37 INFO - ##### 21:59:37 INFO - Running pre-action listener: _resource_record_pre_action 21:59:37 INFO - Running main action method: populate_webroot 21:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:37 INFO - '--tppagecycles', 21:59:37 INFO - '7'], 21:59:37 INFO - 'tests': ['tsvgm']}}, 21:59:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:59:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:59:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'tests': ['damp', 'tps']}, 21:59:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['damp', 'tps']}, 21:59:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:37 INFO - 'other': {'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'other_l64': {'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'other_nol64': {'tests': ['a11yr', 21:59:37 INFO - 'ts_paint', 21:59:37 INFO - 'tpaint', 21:59:37 INFO - 'sessionrestore', 21:59:37 INFO - 'sessionrestore_no_auto_restore']}, 21:59:37 INFO - 'svgr': {'tests': ['tsvgx', 21:59:37 INFO - 'tsvgr_opacity', 21:59:37 INFO - 'tart', 21:59:37 INFO - 'tscrollx', 21:59:37 INFO - 'cart']}, 21:59:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['tsvgx', 21:59:37 INFO - 'tsvgr_opacity', 21:59:37 INFO - 'tart', 21:59:37 INFO - 'tscrollx', 21:59:37 INFO - 'cart']}, 21:59:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'tests': ['tp5o']}, 21:59:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'talos_options': ['--e10s'], 21:59:37 INFO - 'tests': ['tp5o']}, 21:59:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'talos_options': ['--xperf_path', 21:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:37 INFO - 'tests': ['tp5n']}, 21:59:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:37 INFO - 'talos_options': ['--e10s', 21:59:37 INFO - '--xperf_path', 21:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:37 INFO - 'tests': ['tp5n']}}, 21:59:37 INFO - 'talos.zip': {'path': '', 21:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:37 INFO - Running post-action listener: _resource_record_post_action 21:59:37 INFO - ##### 21:59:37 INFO - ##### Running create-virtualenv step. 21:59:37 INFO - ##### 21:59:37 INFO - Running pre-action listener: _resource_record_pre_action 21:59:37 INFO - Running main action method: create_virtualenv 21:59:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:59:37 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 21:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:37 INFO - Using real prefix '/usr' 21:59:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:40 INFO - Installing pip.................done. 21:59:40 INFO - Return code: 0 21:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:59:40 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')]} 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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')]} 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:40 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 21:59:40 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 21:59:40 INFO - Using env: {'DISPLAY': ':0', 21:59:40 INFO - 'HOME': '/home/cltbld', 21:59:40 INFO - 'LANG': 'en_US.UTF-8', 21:59:40 INFO - 'LANGUAGE': 'en_US:en', 21:59:40 INFO - 'LOGNAME': 'cltbld', 21:59:40 INFO - 'MAIL': '/var/mail/cltbld', 21:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:40 INFO - 'MOZ_NO_REMOTE': '1', 21:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:40 INFO - 'NO_EM_RESTART': '1', 21:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:40 INFO - 'SHELL': '/bin/bash', 21:59:40 INFO - 'SHLVL': '1', 21:59:40 INFO - 'TERM': 'linux', 21:59:40 INFO - 'TMOUT': '86400', 21:59:40 INFO - 'USER': 'cltbld', 21:59:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:40 INFO - '_': '/tools/buildbot/bin/python'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 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 21:59:40 INFO - Cleaning up... 21:59:40 INFO - Return code: 0 21:59:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:59:40 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')]} 21:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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')]} 21:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:40 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:40 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 21:59:40 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 21:59:40 INFO - Using env: {'DISPLAY': ':0', 21:59:40 INFO - 'HOME': '/home/cltbld', 21:59:40 INFO - 'LANG': 'en_US.UTF-8', 21:59:40 INFO - 'LANGUAGE': 'en_US:en', 21:59:40 INFO - 'LOGNAME': 'cltbld', 21:59:40 INFO - 'MAIL': '/var/mail/cltbld', 21:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:40 INFO - 'MOZ_NO_REMOTE': '1', 21:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:40 INFO - 'NO_EM_RESTART': '1', 21:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:40 INFO - 'SHELL': '/bin/bash', 21:59:40 INFO - 'SHLVL': '1', 21:59:40 INFO - 'TERM': 'linux', 21:59:40 INFO - 'TMOUT': '86400', 21:59:40 INFO - 'USER': 'cltbld', 21:59:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:40 INFO - '_': '/tools/buildbot/bin/python'} 21:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:40 INFO - Downloading/unpacking psutil>=0.7.1 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:40 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 21:59:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:42 INFO - Installing collected packages: psutil 21:59:42 INFO - Running setup.py install for psutil 21:59:42 INFO - building 'psutil._psutil_linux' extension 21:59:42 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 21:59:42 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 21:59:42 INFO - building 'psutil._psutil_posix' extension 21:59:42 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 21:59:42 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 21:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:42 INFO - Successfully installed psutil 21:59:42 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:59:43 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')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:43 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 21:59:43 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 21:59:43 INFO - Using env: {'DISPLAY': ':0', 21:59:43 INFO - 'HOME': '/home/cltbld', 21:59:43 INFO - 'LANG': 'en_US.UTF-8', 21:59:43 INFO - 'LANGUAGE': 'en_US:en', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MAIL': '/var/mail/cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SHLVL': '1', 21:59:43 INFO - 'TERM': 'linux', 21:59:43 INFO - 'TMOUT': '86400', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - '_': '/tools/buildbot/bin/python'} 21:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:59:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:59:45 INFO - Installing collected packages: mozsystemmonitor 21:59:45 INFO - Running setup.py install for mozsystemmonitor 21:59:45 INFO - Successfully installed mozsystemmonitor 21:59:45 INFO - Cleaning up... 21:59:45 INFO - Return code: 0 21:59:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:59: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')]} 21:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:45 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:45 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 21:59:45 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 21:59:45 INFO - Using env: {'DISPLAY': ':0', 21:59:45 INFO - 'HOME': '/home/cltbld', 21:59:45 INFO - 'LANG': 'en_US.UTF-8', 21:59:45 INFO - 'LANGUAGE': 'en_US:en', 21:59:45 INFO - 'LOGNAME': 'cltbld', 21:59:45 INFO - 'MAIL': '/var/mail/cltbld', 21:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:45 INFO - 'MOZ_NO_REMOTE': '1', 21:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:45 INFO - 'NO_EM_RESTART': '1', 21:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:45 INFO - 'SHELL': '/bin/bash', 21:59:45 INFO - 'SHLVL': '1', 21:59:45 INFO - 'TERM': 'linux', 21:59:45 INFO - 'TMOUT': '86400', 21:59:45 INFO - 'USER': 'cltbld', 21:59:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:45 INFO - '_': '/tools/buildbot/bin/python'} 21:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:48 INFO - Downloading docopt-0.6.1.tar.gz 21:59:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:48 INFO - Running setup.py install for blobuploader 21:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:59:48 INFO - Running setup.py install for requests 21:59:52 INFO - Running setup.py install for docopt 21:59:52 INFO - Successfully installed blobuploader requests docopt 21:59:52 INFO - Cleaning up... 21:59:53 INFO - Return code: 0 21:59:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:53 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:53 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 21:59:53 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 21:59:53 INFO - Using env: {'DISPLAY': ':0', 21:59:53 INFO - 'HOME': '/home/cltbld', 21:59:53 INFO - 'LANG': 'en_US.UTF-8', 21:59:53 INFO - 'LANGUAGE': 'en_US:en', 21:59:53 INFO - 'LOGNAME': 'cltbld', 21:59:53 INFO - 'MAIL': '/var/mail/cltbld', 21:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:53 INFO - 'MOZ_NO_REMOTE': '1', 21:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:53 INFO - 'NO_EM_RESTART': '1', 21:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:53 INFO - 'SHELL': '/bin/bash', 21:59:53 INFO - 'SHLVL': '1', 21:59:53 INFO - 'TERM': 'linux', 21:59:53 INFO - 'TMOUT': '86400', 21:59:53 INFO - 'USER': 'cltbld', 21:59:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:53 INFO - '_': '/tools/buildbot/bin/python'} 21:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:53 INFO - Running setup.py (path:/tmp/pip-dZ_aEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:53 INFO - Running setup.py (path:/tmp/pip-N8Evpe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:53 INFO - Running setup.py (path:/tmp/pip-jlv2g9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:53 INFO - Running setup.py (path:/tmp/pip-8TU1_H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:53 INFO - Running setup.py (path:/tmp/pip-npwEJQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:53 INFO - Running setup.py (path:/tmp/pip-piLMqb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:53 INFO - Running setup.py (path:/tmp/pip-nO0WLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:53 INFO - Running setup.py (path:/tmp/pip-KipXup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:53 INFO - Running setup.py (path:/tmp/pip-Wg0Bq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:54 INFO - Running setup.py (path:/tmp/pip-emGsSX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:54 INFO - Running setup.py (path:/tmp/pip-MLG46t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:54 INFO - Running setup.py (path:/tmp/pip-mrObNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:54 INFO - Running setup.py (path:/tmp/pip-b0CFSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:54 INFO - Running setup.py (path:/tmp/pip-CXHFqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:54 INFO - Running setup.py (path:/tmp/pip-a88N3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:54 INFO - Running setup.py (path:/tmp/pip-3jVVKb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:54 INFO - Running setup.py (path:/tmp/pip-sXomn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:54 INFO - Running setup.py install for manifestparser 21:59:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:59:54 INFO - Running setup.py install for mozcrash 21:59:54 INFO - Running setup.py install for mozdebug 21:59:54 INFO - Running setup.py install for mozdevice 21:59:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozfile 21:59:55 INFO - Running setup.py install for mozhttpd 21:59:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozinfo 21:59:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozInstall 21:59:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozleak 21:59:55 INFO - Running setup.py install for mozlog 21:59:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for moznetwork 21:59:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozprocess 21:59:55 INFO - Running setup.py install for mozprofile 21:59:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:59:55 INFO - Running setup.py install for mozrunner 21:59:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Running setup.py install for mozscreenshot 21:59:56 INFO - Running setup.py install for moztest 21:59:56 INFO - Running setup.py install for mozversion 21:59:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:59:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:56 INFO - Cleaning up... 21:59:56 INFO - Return code: 0 21:59:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:56 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', '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 21:59:56 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 21:59:56 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 21:59:56 INFO - Using env: {'DISPLAY': ':0', 21:59:56 INFO - 'HOME': '/home/cltbld', 21:59:56 INFO - 'LANG': 'en_US.UTF-8', 21:59:56 INFO - 'LANGUAGE': 'en_US:en', 21:59:56 INFO - 'LOGNAME': 'cltbld', 21:59:56 INFO - 'MAIL': '/var/mail/cltbld', 21:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:56 INFO - 'MOZ_NO_REMOTE': '1', 21:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:56 INFO - 'NO_EM_RESTART': '1', 21:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:59:56 INFO - 'SHELL': '/bin/bash', 21:59:56 INFO - 'SHLVL': '1', 21:59:56 INFO - 'TERM': 'linux', 21:59:56 INFO - 'TMOUT': '86400', 21:59:56 INFO - 'USER': 'cltbld', 21:59:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 21:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:56 INFO - '_': '/tools/buildbot/bin/python'} 21:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:56 INFO - Running setup.py (path:/tmp/pip-ghOtm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:56 INFO - Running setup.py (path:/tmp/pip-0XOklf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:56 INFO - Running setup.py (path:/tmp/pip-hHFA4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:56 INFO - Running setup.py (path:/tmp/pip-rnjs6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:59:56 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)) 21:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:56 INFO - Running setup.py (path:/tmp/pip-D7pkHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:57 INFO - Running setup.py (path:/tmp/pip-AsK5BE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:57 INFO - Running setup.py (path:/tmp/pip-L2jmL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:57 INFO - Running setup.py (path:/tmp/pip-CQZhV5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:57 INFO - Running setup.py (path:/tmp/pip-XxhAIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:57 INFO - Running setup.py (path:/tmp/pip-Rd1Utv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:57 INFO - Running setup.py (path:/tmp/pip-bGU20p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:57 INFO - Running setup.py (path:/tmp/pip-PywCTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:57 INFO - Running setup.py (path:/tmp/pip-9ymS04-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:57 INFO - Running setup.py (path:/tmp/pip-WPN5P7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:57 INFO - Running setup.py (path:/tmp/pip-z4vJFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:57 INFO - Running setup.py (path:/tmp/pip-DGNVR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:59:57 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)) 21:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:57 INFO - Running setup.py (path:/tmp/pip-l54RSJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:59:57 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)) 21:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:57 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)) 21:59:57 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)) 21:59:57 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)) 21:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:59 INFO - Downloading blessings-1.6.tar.gz 21:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:59 INFO - Installing collected packages: blessings 21:59:59 INFO - Running setup.py install for blessings 21:59:59 INFO - Successfully installed blessings 21:59:59 INFO - Cleaning up... 21:59:59 INFO - Return code: 0 21:59:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:00 INFO - Reading from file tmpfile_stdout 22:00:00 INFO - Current package versions: 22:00:00 INFO - argparse == 1.2.1 22:00:00 INFO - blessings == 1.6 22:00:00 INFO - blobuploader == 1.2.4 22:00:00 INFO - docopt == 0.6.1 22:00:00 INFO - manifestparser == 1.1 22:00:00 INFO - mozInstall == 1.12 22:00:00 INFO - mozcrash == 0.16 22:00:00 INFO - mozdebug == 0.1 22:00:00 INFO - mozdevice == 0.48 22:00:00 INFO - mozfile == 1.2 22:00:00 INFO - mozhttpd == 0.7 22:00:00 INFO - mozinfo == 0.9 22:00:00 INFO - mozleak == 0.1 22:00:00 INFO - mozlog == 3.1 22:00:00 INFO - moznetwork == 0.27 22:00:00 INFO - mozprocess == 0.22 22:00:00 INFO - mozprofile == 0.28 22:00:00 INFO - mozrunner == 6.11 22:00:00 INFO - mozscreenshot == 0.1 22:00:00 INFO - mozsystemmonitor == 0.0 22:00:00 INFO - moztest == 0.7 22:00:00 INFO - mozversion == 1.4 22:00:00 INFO - psutil == 3.1.1 22:00:00 INFO - requests == 1.2.3 22:00:00 INFO - wsgiref == 0.1.2 22:00:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:00 INFO - Using env: {'DISPLAY': ':0', 22:00:00 INFO - 'HOME': '/home/cltbld', 22:00:00 INFO - 'LANG': 'en_US.UTF-8', 22:00:00 INFO - 'LANGUAGE': 'en_US:en', 22:00:00 INFO - 'LOGNAME': 'cltbld', 22:00:00 INFO - 'MAIL': '/var/mail/cltbld', 22:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:00 INFO - 'MOZ_NO_REMOTE': '1', 22:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:00 INFO - 'NO_EM_RESTART': '1', 22:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:00 INFO - 'SHELL': '/bin/bash', 22:00:00 INFO - 'SHLVL': '1', 22:00:00 INFO - 'TERM': 'linux', 22:00:00 INFO - 'TMOUT': '86400', 22:00:00 INFO - 'USER': 'cltbld', 22:00:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 22:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:00 INFO - '_': '/tools/buildbot/bin/python'} 22:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:00:00 INFO - Cleaning up... 22:00:00 INFO - Return code: 0 22:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:00 INFO - Using env: {'DISPLAY': ':0', 22:00:00 INFO - 'HOME': '/home/cltbld', 22:00:00 INFO - 'LANG': 'en_US.UTF-8', 22:00:00 INFO - 'LANGUAGE': 'en_US:en', 22:00:00 INFO - 'LOGNAME': 'cltbld', 22:00:00 INFO - 'MAIL': '/var/mail/cltbld', 22:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:00 INFO - 'MOZ_NO_REMOTE': '1', 22:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:00 INFO - 'NO_EM_RESTART': '1', 22:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:00 INFO - 'SHELL': '/bin/bash', 22:00:00 INFO - 'SHLVL': '1', 22:00:00 INFO - 'TERM': 'linux', 22:00:00 INFO - 'TMOUT': '86400', 22:00:00 INFO - 'USER': 'cltbld', 22:00:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 22:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:00 INFO - '_': '/tools/buildbot/bin/python'} 22:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:00 INFO - Downloading/unpacking jsonschema 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:02 INFO - Downloading/unpacking functools32 (from jsonschema) 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:02 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:02 INFO - warning: no files found matching '*.txt' 22:00:02 INFO - no previously-included directories found matching 'build' 22:00:02 INFO - no previously-included directories found matching 'dist' 22:00:02 INFO - no previously-included directories found matching '.git*' 22:00:02 INFO - Installing collected packages: jsonschema, functools32 22:00:02 INFO - Running setup.py install for functools32 22:00:02 INFO - warning: no files found matching '*.txt' 22:00:02 INFO - no previously-included directories found matching 'build' 22:00:02 INFO - no previously-included directories found matching 'dist' 22:00:02 INFO - no previously-included directories found matching '.git*' 22:00:02 INFO - Successfully installed jsonschema functools32 22:00:02 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7f2f25325f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d28670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:00:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:00:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:03 INFO - Downloading/unpacking flake8 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:05 INFO - no previously-included directories found matching 'docs/_build' 22:00:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:05 INFO - Running setup.py install for pep8 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:05 INFO - no previously-included directories found matching 'docs/_build' 22:00:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:00:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:05 INFO - Cleaning up... 22:00:05 INFO - Return code: 0 22:00:05 INFO - Running post-action listener: _resource_record_post_action 22:00:05 INFO - Running post-action listener: _start_resource_monitoring 22:00:05 INFO - Starting resource monitoring. 22:00:05 INFO - ##### 22:00:05 INFO - ##### Running install step. 22:00:05 INFO - ##### 22:00:05 INFO - Running pre-action listener: _resource_record_pre_action 22:00:05 INFO - Running main action method: install 22:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Output received: 22:00:06 INFO - Usage: mozinstall [options] installer 22:00:06 INFO - Options: 22:00:06 INFO - -h, --help show this help message and exit 22:00:06 INFO - -d DEST, --destination=DEST 22:00:06 INFO - Directory to install application into. [default: 22:00:06 INFO - "/builds/slave/test-pgo"] 22:00:06 INFO - --app=APP Application being installed. [default: firefox] 22:00:06 INFO - mkdir: /builds/slave/test-pgo/build/application 22:00:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:00:22 INFO - Reading from file tmpfile_stdout 22:00:22 INFO - Output received: 22:00:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:00:22 INFO - Running post-action listener: _resource_record_post_action 22:00:22 INFO - ##### 22:00:22 INFO - ##### Running run-tests step. 22:00:22 INFO - ##### 22:00:22 INFO - Running pre-action listener: _resource_record_pre_action 22:00:22 INFO - Running main action method: run_tests 22:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:00:22 INFO - Python 2.7.3 22:00:22 INFO - Return code: 0 22:00:22 INFO - grabbing minidump binary from tooltool 22:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:22 INFO - 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 0x1db78c0>, '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 0x1db87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1db8c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:00:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:00:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:22 INFO - Return code: 0 22:00:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:00:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:00:23 INFO - Return code: 0 22:00:23 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:00:23 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:00:23 INFO - Using env: {'DISPLAY': ':0', 22:00:23 INFO - 'HOME': '/home/cltbld', 22:00:23 INFO - 'LANG': 'en_US.UTF-8', 22:00:23 INFO - 'LANGUAGE': 'en_US:en', 22:00:23 INFO - 'LOGNAME': 'cltbld', 22:00:23 INFO - 'MAIL': '/var/mail/cltbld', 22:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:23 INFO - 'MOZ_NO_REMOTE': '1', 22:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:23 INFO - 'NO_EM_RESTART': '1', 22:00:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:00:23 INFO - 'SHELL': '/bin/bash', 22:00:23 INFO - 'SHLVL': '1', 22:00:23 INFO - 'TERM': 'linux', 22:00:23 INFO - 'TMOUT': '86400', 22:00:23 INFO - 'USER': 'cltbld', 22:00:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278', 22:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:23 INFO - '_': '/tools/buildbot/bin/python'} 22:00:23 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/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:00:23 INFO - mozversion application_buildid: 20160301193336 22:00:23 INFO - mozversion application_changeset: 3bd640d45525f634e2f24049fbfe051683581c88 22:00:23 INFO - mozversion application_display_name: Nightly 22:00:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:23 INFO - mozversion application_name: Firefox 22:00:23 INFO - mozversion application_remotingname: firefox 22:00:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:23 INFO - mozversion application_vendor: Mozilla 22:00:23 INFO - mozversion application_version: 47.0a1 22:00:23 INFO - mozversion platform_buildid: 20160301193336 22:00:23 INFO - mozversion platform_changeset: 3bd640d45525f634e2f24049fbfe051683581c88 22:00:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:00:23 INFO - mozversion platform_version: 47.0a1 22:00:23 INFO - using testdate: 1456898423 22:00:23 INFO - actual date: 1456898423 22:00:23 INFO - starting webserver on 'localhost:37702' 22:00:23 INFO - SUITE-START | Running 2 tests 22:00:23 INFO - TEST-START | dromaeo_css 22:00:23 INFO - operating with platform_type : linux_ 22:00:23 INFO - Initialising browser for dromaeo_css test... 22:00:23 INFO - TEST-INFO | started process 3867 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDKjEMf/profile http://localhost:37702/getInfo.html) 22:00:29 INFO - PROCESS | 3867 | __metrics Screen width/height:1600/1200 22:00:29 INFO - PROCESS | 3867 | colorDepth:24 22:00:29 INFO - PROCESS | 3867 | Browser inner width/height: 1024/697 22:00:29 INFO - PROCESS | 3867 | __metrics 22:00:30 INFO - PROCESS | 3867 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:31 INFO - TEST-INFO | 3867: exit 0 22:00:31 INFO - Browser initialized. 22:00:31 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:31 INFO - TEST-INFO | started process 3961 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDKjEMf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:43 INFO - PROCESS | 3961 | RSS: Main: 152825856 22:00:43 INFO - PROCESS | 3961 | 22:01:35 INFO - PROCESS | 3961 | 1456898495186 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:03:43 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37702/tests/dromaeo/cssquery-ext.html) 22:03:44 INFO - PROCESS | 3961 | RSS: Main: 257904640 22:03:44 INFO - PROCESS | 3961 | 22:06:46 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-ext.html (next: http://localhost:37702/tests/dromaeo/cssquery-jquery.html) 22:06:46 INFO - PROCESS | 3961 | RSS: Main: 237006848 22:06:46 INFO - PROCESS | 3961 | 22:09:48 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37702/tests/dromaeo/cssquery-mootools.html) 22:09:49 INFO - PROCESS | 3961 | RSS: Main: 236380160 22:09:49 INFO - PROCESS | 3961 | 22:12:51 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37702/tests/dromaeo/cssquery-prototype.html) 22:12:51 INFO - PROCESS | 3961 | RSS: Main: 217907200 22:12:51 INFO - PROCESS | 3961 | 22:15:54 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37702/tests/dromaeo/cssquery-yui.html) 22:15:54 INFO - PROCESS | 3961 | RSS: Main: 219992064 22:15:54 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:37702/tests/dromaeo/cssquery-yui.html (next: http://localhost:37702/tests/dromaeo/cssquery-dojo.html) 22:18:57 INFO - PROCESS | 3961 | RSS: Main: 297443328 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | __start_tp_report 22:18:57 INFO - PROCESS | 3961 | _x_x_mozilla_page_load 22:18:57 INFO - PROCESS | 3961 | _x_x_mozilla_page_load_details 22:18:57 INFO - PROCESS | 3961 | |i|pagename|runs| 22:18:57 INFO - PROCESS | 3961 | |0;dojo.html;3115.9844200779;3123.578316927217;3160.004598551456;3166.097662166283;3193.664665210153;4993.700377977324;5009.073321435528;5029.572486338661;5034.74826258687;5103.438621751604;5047.495250474951;5064.594832413407;5064.797408103672;5074.568661663754;5085.5423011928915;4575.588197062264;4614.607758340553;4665.9066818663605;4702.741349225808;4713.670043096985;4644.210484217674;4660.6504512161555;4669.719816811003;4717;4763;4507.301368287905;4555.681102322838;4599.931001034987;4605.148047611203;4645.581897629196;4611.930821037688;4615.538446155391;4628.051249493879;4628.190066738341;4651.418572678415;4495.14592227479;4603.286490593963;4618.053299073682;4640.396748422683;4642.721436713774;4977.626677999165;4994.675346102528;5003.324551185579;5003.949960500385;5029.874253143664;5434.076207044812;5497.752601132958;5498.367687715924;5498.367687715924;5541;5371.221172929903;5496.80761173357;5514.889702205974;5525.972370138164;5552.833414997556;5153.2270159476;5170.948290517084;5175;5199.220116982445;5220.9738951305;5613.635113717595;5617.494425501724;5618.353889302701;5619.634723742944;5621.409751976065;5262.052830490472;5332.466753324637;5357.7589008494715;5396.811111611153;5416.783328666888;5444.646098003617;5498.945010549924;5506.669599824023;5507.118860982304;5511.58663100269;5465.836024919259;5487.945120548823;5489.725513724298;5494.725263736797;5542.5565954723525;5262.236975638511;5466.9179962300595;5500.889982200333;5536.114221724505;5562.499375056264;4239.215745087169;4247.936280955788;4250.638695710837;4251.149770046003;4285.635720963753;3764.265968136242;3831.8467261309793;3839.5584507781964;3860.2472517858746;3903.726739128291;5064.620153488503;5083.694978301313;5085.847424577269;5130.179171332644;5132.974335128375;5458;5458.344998600193;5492.972535137379;5507.118860982224;5553.6390134641115;4988.052270068675;4998.600111991032;5127.3847138343635;5129.9996500682755;5136.049830781318;4616.976915115403;4623.791929363187;4641.489436162019;4645.581897629162;4684.063187362541;5663.1505274208375;5700.714964251771;5702.629329093678;5709.9714501427225;5719.027765279912;5341.759620816995;5373.113436283126;5450.672959622435;5452.863678408072;5481.808136715196;5667.773289068391;5696.231008813923;5697.658140511582;5699.8860022800145;5704.572157088318;5402.189671549142;5417;5421.349438067299;5425.321834770653;5426.728663566885;5332.813351532678;5428.755705993319;5460.754266058117;5518.696471694096;5526.91709624364;5254.369475662945;5257.132573125392;5289.788408463618;5290.074237008585;5290.788368465218;5278.788848446019;5282.8943421132135;5287.233351164136;5300.681959082467;5345.305110335631;5142.1258386073705;5167.844964651066;5199.168133098686;5209.0363282792805;5270.314859068297;5263.157894736823;5264.605154613343;5266.683998960075;5270.973645131749;5351.491608297206;5089.465606111305;5173.611979101507;5179.611529135405;5187.19598462239;5201.453847346125 22:18:57 INFO - PROCESS | 3961 | |1;ext.html;501.24562533387245;503.9949600503995;510.61193492945375;516.2901011109724;558.2435799491686;28570.285742856413;37269.62730372696;37827.432588511125;37832.62167378325;37919.24161516768;39458.21083578327;39962.40056399149;40467.79766101165;40627.796861015726;40717.185656286856;7435.888461673079;8453.408261421719;8663.913360866374;10001.399916005063;10166.59333626654;10122.645707400243;10263.486825658725;10266.845997310009;10270.691879243597;10275.486225688686;10210.693679189599;10361.326513776618;10364.015418535228;10364.740881477948;10369.17046636271;10192.74518137045;10256.128229100535;10275.075243228071;10281.537330820094;10292.639757608522;9868.111869931668;10124.392536447764;10130.392176469362;10468.790624187473;10470.581176752998;40335.596644033474;40795;40824;40841.387379189335;40864.79567602143;3252.788568743048;3334.8332583370734;3734.2344819311975;3950.071733142709;4133.648639865615;30418.239544011354;30440.8477957611;30759.63701852331;30833.845830770704;31405.842970785;3719.9442008369897;3729.459228411892;3763.7553559018575;3779.811009449544;3838.692904567628;277332;279056;281063;281268;281795;40487.392689109685;56603.71698141483;57597.13604295939;57646.13530797041;57702.134467983014;39031;39428.60571394307;39518.23372363907;39558;39625.40561891574;13398.196108233537;13829.446822127204;14065.43738250479;14103.153810771386;14120.293985300694;10495.26533142688;10582.470876456146;10586.153107751361;11218.439078046065;11465.426728663533;13874.653133671538;13944;13963.58109256724;13995.95030372726;14062.789058164135;5576.33084029919;5621.578381621313;5626.212330273765;5626.915596266059;5701.4298570142655;891.7369376034086;905.7192270396198;940.2055263302499;1009.5685213551194;1022.3814592171777;28156.296092597848;28484.287892802433;28630.14109576716;28634.14097577076;28929.566056509168;1034.984475232872;1041.1774697988656;1086.43505377205;1126.566271985275;1140.4639819284923;14874.405023799143;14888.627784305263;15015.474458394123;15323.923380383027;15340.92329538345;326384;329753;329868;334147;334850;51223;51708;51728.48271517312;51772;51945;1223.932683702405;1246.2522486508024;1313.1989486413281;1361.2445092973296;1370.1299674706434;27905.023324183556;28816.567751484163;29383.853080734458;29396.853015734785;29521.26196845096;43517.3472397908;43891.78054109709;44064.339034915145;44077.11845763131;44105.55894441014;174642.12678936523;222274;226164;227200;227553.10692377723;31176.688233118286;31397.529037064007;31415.371692566478;31439.84280078585;31531.36937261196;38641.227175456894;39792.403113952736;40370.79814600908;40564.18871622492;40677.796611016754;33399.33201336008;36348;37276.813615932835;37376.813115934245;37728.2454350906;36364.63635363719;36550.26899462049;36635.81682091572;36845.26309473849;36975.26049479049;37958.810205948794;38097.23805523819;38488.80755596204;38801.223975520894;39122.608773911896;30735.538966915068;32946.34107317888;33245.16887077843;33279;33394.4990825133;25812.870935645202;26046.348841278363;26320.73679263183;26653.466930661667;26827.597586035834 22:18:57 INFO - PROCESS | 3961 | |2;jquery.html;343.6941122401063;350.6633631713556;352.2831038835969;355.12461781708083;357.1482015393286;16718.498445046655;17449.214785334658;17655.646887062252;18237;18270.81729182708;15900.76148857768;16092.436764713237;17154.056526891018;17164.742528862076;17167.141642917835;4663.813447462097;4801.759912004403;4967.279744437054;5407.134858422653;5412.485813847678;5464.3442786865635;5471.671699698011;5488.423715509874;5492.038893193675;5521.5306698930435;5398.352197736277;5484.396716361217;5629.071203251479;5987.880242395149;5999.190109335249;5768.509676677488;5856.824295271127;5875;5881.176635271066;5898.616589921641;5094.516020978038;5278.5249327560705;5310.256564081032;5315.654482458666;5347.1177255752755;12866;12933.54732584355;12988.220706757626;13054.34728263583;15653.452129175424;2172.2505735521377;2193.8683678979314;2241.6637504374476;2266.354089084603;2323.488832456857;9363.719088427359;9403.482808445533;9817.165540929029;9899.406035637812;11283.605073822459;1845.0221382667207;1857.5634725839418;1873.0728289496785;1884.8869067855835;1891.0450222637617;49154.50845491535;63521.36478635247;64651;65070.67464662694;67612.32387676109;9907.207423406111;9907.950460247652;10106.848397274047;10245;10332.328398654063;12096.939515302543;12621.873781262253;12635.620931372074;12847.164934279243;13059.281739504419;7311.086114235721;7345.93024703957;7494.887576686354;7572.81067973294;7638.197989211164;7182.712691492282;7184.389326907271;7225.65572051884;7254.5647261164495;7347.5591464511235;4378.627816635558;4391.055922976575;4391.407160033355;4440.111977604492;4463.263561512379;1761.2866788950496;1777.5644966982914;1783.3758184635274;1814.7368631548352;1820.2264037784153;897.3808072430003;911.7538264668502;941.1811723800338;993.557866749304;1008.2287050406445;16005.359785608445;16207.513774586781;16558.83441165597;16755.497335079966;16838.326466941184;890.7416849113685;923.4136323434667;946.9621215151454;967.274544091931;988.7231575158967;9355.578998945064;9472;9624.470654114091;9698.078682525149;9701.8047089758;344208;344873;345712;443986;447692;51569.74215128901;68904;70066.299337007;71366.64316678487;71367.6431617849;1006.6476733143488;1022.5960745505483;1037.1080870451406;1041.037040737315;1049.2340591368343;15563;15631.531054068397;15676.451324203597;15793.236183667583;15851.682966340839;24578.754212458363;32054.99999999907;32957;33812.66187338095;35627;40269;41422;42244;42941.78529107334;43296.13407731765;7897.68409263623;7942.483738556975;8063.919360806317;8076.232757887991;8124.512529248264;11881;12008.579699710817;12429.75140497203;12432.067594930235;12600.432980516081;9798.608055677978;10478.738031549272;10860.945695271788;10862.728431789268;11280.7743845121;10644.361338319726;10745.570177192825;10826.242163048826;10914.672559823219;10935.015848573667;10768.838467422838;10897.67306980792;11018;11078.335299882034;11392;7461.253874612496;7617.923820761943;7660.69357225727;7785.493942893694;7924.247196516321;9214.953925230331;10743.570257189625;10789.784204316027;11031.944840275748;11194.216404851582 22:18:57 INFO - PROCESS | 3961 | |3;mootools.html;1284.3899147904751;1414.5402744108164;1428.671405576717;1572.2688949638416;1744.2935611077519;7068.540544864587;7193.56838589685;7193.784186474401;7200.675969581368;7201.675924583393;7091.078159839214;7182.209956904736;7256.528325658842;7278;7283.162436319825;1891.7824450188198;2132.712083868681;2137.0703743871386;2169.533550286688;2186.049068655132;2144.849860509757;2152.967705484419;2153.3432303147533;2156.0513374115417;2156.1590979518;2098.6327392706294;2165.133946421436;2172.5546263016045;2178.281167214823;2179.727534058243;1946.1436967734294;1958.7061940708866;1964.72493850861;1967.9409617711492;1980.8811471311767;2159.3953692965993;2165.65026945764;2171.543975765091;2193.7477190123022;2198.274569392113;7214.458915581353;7283.380912622433;7318.81702957425;7324.963375183143;7363.005994190769;4359.803808828578;4466.4640243171025;4466.709663871838;4471.39636149119;4475.776211189427;2814.0854222377607;2854.942901141986;2875.353045564752;2897.5219088850313;2936.236578489587;920.3143657974784;920.4339331311195;921.8893732752045;925.4586067150725;959.4195511715382;9815.803683926353;9952.353097048668;9973.75065623358;9975.25185611082;9987.450690212036;4007.0583412897945;4019.8392064317686;4045.8179381927885;4110.897227569335;4120.546739858613;8538.87191692125;8651.091635378321;8848.247898928534;8867.201951824367;8873.600687969058;4025.134596061861;4575.816967321336;4585.358049873021;4590.98998220391;4596.632269418438;3686.8340924658455;4005.319095753671;4065.390191471303;4111.218868414991;4124.030852749602;3474.8436320365645;3526.9118272043406;3531.1172206948263;3553.982230088833;3589.2283159120393;1106.8339749037548;1114.0530549033258;1117.0449265877558;1117.2905205194759;1128.5937062657438;1240.4356018011783;1262.1354372255034;1262.9242245465302;1263.5514392390753;1275.687456573127;7057.752978645723;7141.143062832493;7150.642467876585;7153.284671532909;7158.141023077264;488.5700583486509;496.02283501501984;496.84101087651607;498.5014985014985;499.3757802746567;5568.610197286151;5590.888182236414;5596.916046259309;5605.467480589337;5645.887082258332;8490.745277641681;8564.657413703382;8588.785280367916;8659.740207793777;8703.47779133254;8606;8632.654693812177;8633.740987770252;8639.611217495101;8642.913570864212;6771.356721111487;6898.586084834826;6908.861822763517;7019.3682568569075;7023.543469674455;6676.432503237279;6742.9662851685425;6759.053732477555;6762.222344430454;6795.116634837439;7648.196939321291;7735.7679269622;7890.802729931797;7937.682492700227;7975.441719079608;7840.490368126054;8124.8781268279845;8134.796630084295;8215.548144851851;8219.95890020546;5819.747161129149;5821.277945454582;6190.783322583688;6558.967205164135;6667.133272674521;6545.607263564201;6566.9014964776525;6589.0775291460195;6590.934090659032;7116.181639111568;6432.614043157426;6475.838104047437;6481.708323125565;6562.671866406565;6577.736890524326;6336;6402.775902843378;6406.359364063556;6484.28672845996;6508.349165083454;6739.629320387426;6789.083473731181;6789.830254243683;6857.5199736018;6912.170539535086;6249;6284.214473190851;6292;6295.244570651551;6303.9684801575695;6009.879802404015;6077.4226448487325;6080.148779171008;6083.482903953213;6084.7566097357385 22:18:57 INFO - PROCESS | 3961 | |4;prototype.html;304.7287913756757;323.20814005686066;323.80409852039514;326.56077575660726;330.8312760492148;5919.319278282998;5922.437368449996;5936.1689363489095;5978.611390259641;5992.280926288846;5868.677222752747;5904.114382842576;5908.02517584598;5911.556633252512;5913.793017244398;4307.396964424967;4438.7780610969485;4515.954840451603;4567.885802854922;4574.451065872092;4570.33730109134;4573.63410927125;4598.655100867431;4602.102589994953;4606.493285738566;4528.18492671319;4530.75080870552;4540.432445944257;4542.500324964251;4544.1593305238475;4284.443022407083;4399.18615056214;4513.0296986147805;4524.072565124175;4537.228671125917;3976.383660532622;3977.463042489285;3982.721209515335;3987.80060996949;3987.8404863805413;5609.130584759328;5637.182608521783;5638.267025286727;5638.379778224392;5640.407757185519;5284.128118860383;5288;5294.100002999499;5294.68231906083;5302.44324345942;6276.403741644536;6281.403266689657;6282.560220784547;6288.276848162474;6288.748450061992;4324.308110702304;4412.823487060514;4423.026934074531;4429.269170586849;4433.024734558392;6462.935370646281;6489.059086432488;6500.349965003509;6503;6506.609603423763;4511.120331535385;4515.367848501212;4532.501424843264;4533.320001999727;4541.296099104644;4587.4036375271;4589.242774942164;4593.379893714306;4596.862094137181;4600.723956562617;5272.420033796279;5274.393444753826;5281.9207711884355;5287.286216360819;5287.391949925808;6152.815415537541;6325.5255855811;6335.271443783931;6338.556301058881;6346.4605508532295;1600.3518574977154;1606.2129556517223;1617.191404297851;1620.1899050474763;1622.9026258424296;999.480270259461;1013.5996281468779;1018.6485662446444;1047.4396198034015;1056.0864851903048;5770.16332631766;5837.824865254049;5840.29916410025;5848.444397782204;5863.882722345615;6406.551541392151;6422.967885160638;6427.967860160763;6436.935630643634;6441.388068133613;5906.202662640489;5910.822675319747;5911.142884281755;5911.261092363455;5912.615679980873;3444.896653100411;3473.027552285364;3476.2526056897887;3477.3393055319916;3483.7213022958103;6561.507886908501;6670.332966703291;6692;6730.461563074942;6752.08846805675;6562.967185164043;6580.605163690098;6580.63806490638;6586.27550969393;6594.8351291218105;6704.430123439464;6708.731650734014;6712.463002959751;6715.529912906148;6732.932670673231;6427.196600424947;6430.453411460078;6432.067350234096;6433.292337842927;6433.678316084083;6217.347178546368;6325.683715814283;6350.618962862243;6355.269144048493;6369.01280301554;6715.764948226789;6746.628935408599;6750.1562304711915;6750.45996320303;6751.56114852533;4517.344984977094;4519.299508576176;4521.276595744796;4524.705894116872;4526.954730452653;6442.194725659293;6446.161998940295;6450.193725784277;6451;6452.483801295791;6178.907316390168;6207.441330280297;6247.062940558771;6248.562600617913;6250.656213908097;6085.208922840179;6223.595466294676;6236.812895613139;6237.345078766664;6252.624842509464;6112.877742445037;6136.386361363828;6144.78493252734;6146.784862529968;6148.815535533941;6257.937420625735;6268.623882567061;6269.7178626962805;6271.592346497463;6282.748690052346;5989.221401217814;6042.244719410074;6130.693465326805;6143.662098584621;6147.631142131308 22:18:57 INFO - PROCESS | 3961 | |5;yui.html;721.6355740351123;782.9725959591416;786.7482405630201;786.8701664225404;825.9421840471166;13823.37794799234;14048.08687435316;14064.367103480343;14095.929520352396;14104.15375077496;14445.63885902853;14516.129032258072;14613.634659133528;14624.341904614292;14882.776758348606;775.3564541430627;785.5286827903269;785.7407055671644;786.1588100732218;786.4455558831039;640.0910706796337;770.8496843115595;785.3677789379548;786.5084322298563;786.7561056072636;837.1168417319725;839.0518713853337;842.1620487614832;843.1694780641063;843.5908584336592;823.6293667849492;831.0484495252932;831.4969443486664;831.5218749219223;832.8126171611369;496.97018178909383;603.0772917436329;611.6819253987901;612.2713970375239;612.4120843989775;14138.787918181235;14196.85803141976;14199.077059991068;14206.218657973808;14234.14595124296;12715.936420317932;12982.221066736027;13034.869651303461;13107.082504224709;13235.536756213583;10965;10974.670759877217;11027.889721102847;11135.944320278346;11264;3498.8690924963266;3508.6329011104326;3542.3092496963104;3594.946075808865;3654.086478380405;51322.486775132515;51988.48011519874;52221.47778522204;52333.215001775;52370.738146309406;9774.462404567817;10084.798304033879;10179.7455063624;10215.846762298572;10375.533101010473;17975.910120449575;17996.190171442315;18016.9099154506;18038.36865709694;18052.909735451238;7809.882851757228;7914.881276780853;7992.800179995546;8018.077921039038;8064.193580642006;4008.599140086026;4040.313146765057;4071.6131967463043;4156.064885400821;4199.97900010498;2822.788290878192;2824.4633519631207;2874.453853767777;2881.639795025622;2893.956590651142;541.1639017717557;555.1201345866847;555.824915151734;559.1110134885552;572.0246978900964;519.6336582709181;552.2489414396417;571.4970825673381;579.183351474419;596.8895754285471;7637.694492220249;7788.260115289038;7934.722284720007;8037.638306276232;8076.83846323082;495.58370968386726;599.7660912244228;624.9281332646713;631.8767840271103;676.7766637009873;3569.203160439639;3603.261331427051;3681.5398075240596;3684.8526058957877;3792.7534710243744;55896.44103558994;56028;56934;56985.14522282169;57142.42857571371;47552.01407704352;47904.5209547907;48496.27255591169;49134;49955.25067123996;43082;43986.34020489695;44048;44974;45464;7797;7958.960205198937;8000.759977200693;8124.22819832115;8291.461055031403;33603.66396336005;34566;34818.47772283469;35010.124746881535;35085.64914350926;42560.14879702327;43104;43133.3529997044;43539.78230108829;43621;11303.943480282545;11411.144164187885;11582.189246752647;11659.76680466369;11695.239809412362;12412.689682758004;12462.750744984869;12813.487460501476;12835.807462888251;13311.66720831987;10581.677290338708;10766.354018758899;10835.295705779099;10837.783244335227;11264.831027534758;10996.395198264172;11045.889541104487;11476.942615286871;11485.081193504333;11947.761044778881;11373.090152787923;11518.649476514589;11712.297262164297;12135.393230338625;12156.513739450676;9505.477198754135;9577.569009394454;9701.272404569827;9931.205503559553;9968.102870741668;8223.136570659995;8433.915660843313;8567.700130495403;8753;9063.728088157366 22:18:57 INFO - PROCESS | 3961 | __end_tp_report 22:18:57 INFO - PROCESS | 3961 | __start_cc_report 22:18:57 INFO - PROCESS | 3961 | _x_x_mozilla_cycle_collect,783 22:18:57 INFO - PROCESS | 3961 | __end_cc_report 22:18:57 INFO - PROCESS | 3961 | __startTimestamp1456899537939__endTimestamp 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | ------- Summary: start ------- 22:18:57 INFO - PROCESS | 3961 | Number of tests: 6 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#0] dojo.html Cycles:165 Average:5070.35 Median:5209.04 stddev:548.43 (10.5%) stddev-sans-first:528.25 22:18:57 INFO - PROCESS | 3961 | Values: 3116.0 3123.6 3160.0 3166.1 3193.7 4993.7 5009.1 5029.6 5034.7 5103.4 5047.5 5064.6 5064.8 5074.6 5085.5 4575.6 4614.6 4665.9 4702.7 4713.7 4644.2 4660.7 4669.7 4717.0 4763.0 4507.3 4555.7 4599.9 4605.1 4645.6 4611.9 4615.5 4628.1 4628.2 4651.4 4495.1 4603.3 4618.1 4640.4 4642.7 4977.6 4994.7 5003.3 5003.9 5029.9 5434.1 5497.8 5498.4 5498.4 5541.0 5371.2 5496.8 5514.9 5526.0 5552.8 5153.2 5170.9 5175.0 5199.2 5221.0 5613.6 5617.5 5618.4 5619.6 5621.4 5262.1 5332.5 5357.8 5396.8 5416.8 5444.6 5498.9 5506.7 5507.1 5511.6 5465.8 5487.9 5489.7 5494.7 5542.6 5262.2 5466.9 5500.9 5536.1 5562.5 4239.2 4247.9 4250.6 4251.1 4285.6 3764.3 3831.8 3839.6 3860.2 3903.7 5064.6 5083.7 5085.8 5130.2 5133.0 5458.0 5458.3 5493.0 5507.1 5553.6 4988.1 4998.6 5127.4 5130.0 5136.0 4617.0 4623.8 4641.5 4645.6 4684.1 5663.2 5700.7 5702.6 5710.0 5719.0 5341.8 5373.1 5450.7 5452.9 5481.8 5667.8 5696.2 5697.7 5699.9 5704.6 5402.2 5417.0 5421.3 5425.3 5426.7 5332.8 5428.8 5460.8 5518.7 5526.9 5254.4 5257.1 5289.8 5290.1 5290.8 5278.8 5282.9 5287.2 5300.7 5345.3 5142.1 5167.8 5199.2 5209.0 5270.3 5263.2 5264.6 5266.7 5271.0 5351.5 5089.5 5173.6 5179.6 5187.2 5201.5 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#1] ext.html Cycles:180 Average:43992.45 Median:164818.39 stddev:73111.65 (44.4%) stddev-sans-first:73243.83 22:18:57 INFO - PROCESS | 3961 | Values: 501.2 504.0 510.6 516.3 558.2 28570.3 37269.6 37827.4 37832.6 37919.2 39458.2 39962.4 40467.8 40627.8 40717.2 7435.9 8453.4 8663.9 10001.4 10166.6 10122.6 10263.5 10266.8 10270.7 10275.5 10210.7 10361.3 10364.0 10364.7 10369.2 10192.7 10256.1 10275.1 10281.5 10292.6 9868.1 10124.4 10130.4 10468.8 10470.6 40335.6 40795.0 40824.0 40841.4 40864.8 3252.8 3334.8 3734.2 3950.1 4133.6 30418.2 30440.8 30759.6 30833.8 31405.8 3719.9 3729.5 3763.8 3779.8 3838.7 277332.0 279056.0 281063.0 281268.0 281795.0 40487.4 56603.7 57597.1 57646.1 57702.1 39031.0 39428.6 39518.2 39558.0 39625.4 13398.2 13829.4 14065.4 14103.2 14120.3 10495.3 10582.5 10586.2 11218.4 11465.4 13874.7 13944.0 13963.6 13996.0 14062.8 5576.3 5621.6 5626.2 5626.9 5701.4 891.7 905.7 940.2 1009.6 1022.4 28156.3 28484.3 28630.1 28634.1 28929.6 1035.0 1041.2 1086.4 1126.6 1140.5 14874.4 14888.6 15015.5 15323.9 15340.9 326384.0 329753.0 329868.0 334147.0 334850.0 51223.0 51708.0 51728.5 51772.0 51945.0 1223.9 1246.3 1313.2 1361.2 1370.1 27905.0 28816.6 29383.9 29396.9 29521.3 43517.3 43891.8 44064.3 44077.1 44105.6 174642.1 222274.0 226164.0 227200.0 227553.1 31176.7 31397.5 31415.4 31439.8 31531.4 38641.2 39792.4 40370.8 40564.2 40677.8 33399.3 36348.0 37276.8 37376.8 37728.2 36364.6 36550.3 36635.8 36845.3 36975.3 37958.8 38097.2 38488.8 38801.2 39122.6 30735.5 32946.3 33245.2 33279.0 33394.5 25812.9 26046.3 26320.7 26653.5 26827.6 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#2] jquery.html Cycles:180 Average:23245.76 Median:20313.07 stddev:63730.49 (313.7%) stddev-sans-first:63886.07 22:18:57 INFO - PROCESS | 3961 | Values: 343.7 350.7 352.3 355.1 357.1 16718.5 17449.2 17655.6 18237.0 18270.8 15900.8 16092.4 17154.1 17164.7 17167.1 4663.8 4801.8 4967.3 5407.1 5412.5 5464.3 5471.7 5488.4 5492.0 5521.5 5398.4 5484.4 5629.1 5987.9 5999.2 5768.5 5856.8 5875.0 5881.2 5898.6 5094.5 5278.5 5310.3 5315.7 5347.1 12866.0 12933.5 12988.2 13054.3 15653.5 2172.3 2193.9 2241.7 2266.4 2323.5 9363.7 9403.5 9817.2 9899.4 11283.6 1845.0 1857.6 1873.1 1884.9 1891.0 49154.5 63521.4 64651.0 65070.7 67612.3 9907.2 9908.0 10106.8 10245.0 10332.3 12096.9 12621.9 12635.6 12847.2 13059.3 7311.1 7345.9 7494.9 7572.8 7638.2 7182.7 7184.4 7225.7 7254.6 7347.6 4378.6 4391.1 4391.4 4440.1 4463.3 1761.3 1777.6 1783.4 1814.7 1820.2 897.4 911.8 941.2 993.6 1008.2 16005.4 16207.5 16558.8 16755.5 16838.3 890.7 923.4 947.0 967.3 988.7 9355.6 9472.0 9624.5 9698.1 9701.8 344208.0 344873.0 345712.0 443986.0 447692.0 51569.7 68904.0 70066.3 71366.6 71367.6 1006.6 1022.6 1037.1 1041.0 1049.2 15563.0 15631.5 15676.5 15793.2 15851.7 24578.8 32055.0 32957.0 33812.7 35627.0 40269.0 41422.0 42244.0 42941.8 43296.1 7897.7 7942.5 8063.9 8076.2 8124.5 11881.0 12008.6 12429.8 12432.1 12600.4 9798.6 10478.7 10860.9 10862.7 11280.8 10644.4 10745.6 10826.2 10914.7 10935.0 10768.8 10897.7 11018.0 11078.3 11392.0 7461.3 7617.9 7660.7 7785.5 7924.2 9215.0 10743.6 10789.8 11031.9 11194.2 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#3] mootools.html Cycles:180 Average:5116.89 Median:6293.62 stddev:2656.79 (42.2%) stddev-sans-first:2648.62 22:18:57 INFO - PROCESS | 3961 | Values: 1284.4 1414.5 1428.7 1572.3 1744.3 7068.5 7193.6 7193.8 7200.7 7201.7 7091.1 7182.2 7256.5 7278.0 7283.2 1891.8 2132.7 2137.1 2169.5 2186.0 2144.8 2153.0 2153.3 2156.1 2156.2 2098.6 2165.1 2172.6 2178.3 2179.7 1946.1 1958.7 1964.7 1967.9 1980.9 2159.4 2165.7 2171.5 2193.7 2198.3 7214.5 7283.4 7318.8 7325.0 7363.0 4359.8 4466.5 4466.7 4471.4 4475.8 2814.1 2854.9 2875.4 2897.5 2936.2 920.3 920.4 921.9 925.5 959.4 9815.8 9952.4 9973.8 9975.3 9987.5 4007.1 4019.8 4045.8 4110.9 4120.5 8538.9 8651.1 8848.2 8867.2 8873.6 4025.1 4575.8 4585.4 4591.0 4596.6 3686.8 4005.3 4065.4 4111.2 4124.0 3474.8 3526.9 3531.1 3554.0 3589.2 1106.8 1114.1 1117.0 1117.3 1128.6 1240.4 1262.1 1262.9 1263.6 1275.7 7057.8 7141.1 7150.6 7153.3 7158.1 488.6 496.0 496.8 498.5 499.4 5568.6 5590.9 5596.9 5605.5 5645.9 8490.7 8564.7 8588.8 8659.7 8703.5 8606.0 8632.7 8633.7 8639.6 8642.9 6771.4 6898.6 6908.9 7019.4 7023.5 6676.4 6743.0 6759.1 6762.2 6795.1 7648.2 7735.8 7890.8 7937.7 7975.4 7840.5 8124.9 8134.8 8215.5 8220.0 5819.7 5821.3 6190.8 6559.0 6667.1 6545.6 6566.9 6589.1 6590.9 7116.2 6432.6 6475.8 6481.7 6562.7 6577.7 6336.0 6402.8 6406.4 6484.3 6508.3 6739.6 6789.1 6789.8 6857.5 6912.2 6249.0 6284.2 6292.0 6295.2 6304.0 6009.9 6077.4 6080.1 6083.5 6084.8 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#4] prototype.html Cycles:180 Average:5241.12 Median:5911.41 stddev:1568.32 (26.5%) stddev-sans-first:1528.32 22:18:57 INFO - PROCESS | 3961 | Values: 304.7 323.2 323.8 326.6 330.8 5919.3 5922.4 5936.2 5978.6 5992.3 5868.7 5904.1 5908.0 5911.6 5913.8 4307.4 4438.8 4516.0 4567.9 4574.5 4570.3 4573.6 4598.7 4602.1 4606.5 4528.2 4530.8 4540.4 4542.5 4544.2 4284.4 4399.2 4513.0 4524.1 4537.2 3976.4 3977.5 3982.7 3987.8 3987.8 5609.1 5637.2 5638.3 5638.4 5640.4 5284.1 5288.0 5294.1 5294.7 5302.4 6276.4 6281.4 6282.6 6288.3 6288.7 4324.3 4412.8 4423.0 4429.3 4433.0 6462.9 6489.1 6500.3 6503.0 6506.6 4511.1 4515.4 4532.5 4533.3 4541.3 4587.4 4589.2 4593.4 4596.9 4600.7 5272.4 5274.4 5281.9 5287.3 5287.4 6152.8 6325.5 6335.3 6338.6 6346.5 1600.4 1606.2 1617.2 1620.2 1622.9 999.5 1013.6 1018.6 1047.4 1056.1 5770.2 5837.8 5840.3 5848.4 5863.9 6406.6 6423.0 6428.0 6436.9 6441.4 5906.2 5910.8 5911.1 5911.3 5912.6 3444.9 3473.0 3476.3 3477.3 3483.7 6561.5 6670.3 6692.0 6730.5 6752.1 6563.0 6580.6 6580.6 6586.3 6594.8 6704.4 6708.7 6712.5 6715.5 6732.9 6427.2 6430.5 6432.1 6433.3 6433.7 6217.3 6325.7 6350.6 6355.3 6369.0 6715.8 6746.6 6750.2 6750.5 6751.6 4517.3 4519.3 4521.3 4524.7 4527.0 6442.2 6446.2 6450.2 6451.0 6452.5 6178.9 6207.4 6247.1 6248.6 6250.7 6085.2 6223.6 6236.8 6237.3 6252.6 6112.9 6136.4 6144.8 6146.8 6148.8 6257.9 6268.6 6269.7 6271.6 6282.7 5989.2 6042.2 6130.7 6143.7 6147.6 22:18:57 INFO - PROCESS | 3961 | 22:18:57 INFO - PROCESS | 3961 | [#5] yui.html Cycles:180 Average:13763.47 Median:44017.17 stddev:15779.34 (35.8%) stddev-sans-first:15793.21 22:18:57 INFO - PROCESS | 3961 | Values: 721.6 783.0 786.7 786.9 825.9 13823.4 14048.1 14064.4 14095.9 14104.2 14445.6 14516.1 14613.6 14624.3 14882.8 775.4 785.5 785.7 786.2 786.4 640.1 770.8 785.4 786.5 786.8 837.1 839.1 842.2 843.2 843.6 823.6 831.0 831.5 831.5 832.8 497.0 603.1 611.7 612.3 612.4 14138.8 14196.9 14199.1 14206.2 14234.1 12715.9 12982.2 13034.9 13107.1 13235.5 10965.0 10974.7 11027.9 11135.9 11264.0 3498.9 3508.6 3542.3 3594.9 3654.1 51322.5 51988.5 52221.5 52333.2 52370.7 9774.5 10084.8 10179.7 10215.8 10375.5 17975.9 17996.2 18016.9 18038.4 18052.9 7809.9 7914.9 7992.8 8018.1 8064.2 4008.6 4040.3 4071.6 4156.1 4200.0 2822.8 2824.5 2874.5 2881.6 2894.0 541.2 555.1 555.8 559.1 572.0 519.6 552.2 571.5 579.2 596.9 7637.7 7788.3 7934.7 8037.6 8076.8 495.6 599.8 624.9 631.9 676.8 3569.2 3603.3 3681.5 3684.9 3792.8 55896.4 56028.0 56934.0 56985.1 57142.4 47552.0 47904.5 48496.3 49134.0 49955.3 43082.0 43986.3 44048.0 44974.0 45464.0 7797.0 7959.0 8000.8 8124.2 8291.5 33603.7 34566.0 34818.5 35010.1 35085.6 42560.1 43104.0 43133.4 43539.8 43621.0 11303.9 11411.1 11582.2 11659.8 11695.2 12412.7 12462.8 12813.5 12835.8 13311.7 10581.7 10766.4 10835.3 10837.8 11264.8 10996.4 11045.9 11476.9 11485.1 11947.8 11373.1 11518.6 11712.3 12135.4 12156.5 9505.5 9577.6 9701.3 9931.2 9968.1 8223.1 8433.9 8567.7 8753.0 9063.7 22:18:57 INFO - PROCESS | 3961 | -------- Summary: end -------- 22:18:57 INFO - PROCESS | 3961 | 22:18:58 INFO - TEST-INFO | 3961: exit 0 22:18:58 INFO - TEST-OK | dromaeo_css | took 1115128ms 22:18:58 INFO - TEST-START | kraken 22:18:58 INFO - operating with platform_type : linux_ 22:18:58 INFO - Initialising browser for kraken test... 22:18:58 INFO - TEST-INFO | started process 4146 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOCSzuN/profile http://localhost:37702/getInfo.html) 22:19:03 INFO - PROCESS | 4146 | __metrics Screen width/height:1600/1200 22:19:03 INFO - PROCESS | 4146 | colorDepth:24 22:19:03 INFO - PROCESS | 4146 | Browser inner width/height: 1024/697 22:19:03 INFO - PROCESS | 4146 | __metrics 22:19:04 INFO - PROCESS | 4146 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:05 INFO - TEST-INFO | 4146: exit 0 22:19:05 INFO - Browser initialized. 22:19:05 INFO - Running cycle 1/1 for kraken test... 22:19:05 INFO - TEST-INFO | started process 4230 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOCSzuN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:16 INFO - PROCESS | 4230 | RSS: Main: 153010176 22:19:16 INFO - PROCESS | 4230 | 22:19:19 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37702/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:20 INFO - PROCESS | 4230 | RSS: Main: 197259264 22:19:20 INFO - PROCESS | 4230 | 22:19:22 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37702/tests/kraken/driver.html?testName=audio-dft) 22:19:23 INFO - PROCESS | 4230 | RSS: Main: 186613760 22:19:23 INFO - PROCESS | 4230 | 22:19:26 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37702/tests/kraken/driver.html?testName=audio-fft) 22:19:26 INFO - PROCESS | 4230 | RSS: Main: 171311104 22:19:26 INFO - PROCESS | 4230 | 22:19:28 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37702/tests/kraken/driver.html?testName=audio-oscillator) 22:19:29 INFO - PROCESS | 4230 | RSS: Main: 171515904 22:19:29 INFO - PROCESS | 4230 | 22:19:31 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:32 INFO - PROCESS | 4230 | RSS: Main: 174870528 22:19:32 INFO - PROCESS | 4230 | 22:19:35 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37702/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:35 INFO - PROCESS | 4230 | RSS: Main: 175026176 22:19:35 INFO - PROCESS | 4230 | 22:19:39 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37702/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:39 INFO - PROCESS | 4230 | RSS: Main: 176680960 22:19:39 INFO - PROCESS | 4230 | 22:19:42 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37702/tests/kraken/driver.html?testName=json-parse-financial) 22:19:43 INFO - PROCESS | 4230 | RSS: Main: 176119808 22:19:43 INFO - PROCESS | 4230 | 22:19:44 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:45 INFO - PROCESS | 4230 | RSS: Main: 185774080 22:19:45 INFO - PROCESS | 4230 | 22:19:47 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:47 INFO - PROCESS | 4230 | RSS: Main: 181813248 22:19:47 INFO - PROCESS | 4230 | 22:19:49 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:50 INFO - PROCESS | 4230 | RSS: Main: 194191360 22:19:50 INFO - PROCESS | 4230 | 22:19:52 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:53 INFO - PROCESS | 4230 | RSS: Main: 198475776 22:19:53 INFO - PROCESS | 4230 | 22:19:55 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:56 INFO - PROCESS | 4230 | RSS: Main: 200110080 22:19:56 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | Cycle 1(1): loaded http://localhost:37702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37702/tests/kraken/driver.html?testName=ai-astar) 22:19:58 INFO - PROCESS | 4230 | RSS: Main: 259657728 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | __start_tp_report 22:19:58 INFO - PROCESS | 4230 | _x_x_mozilla_page_load 22:19:58 INFO - PROCESS | 4230 | _x_x_mozilla_page_load_details 22:19:58 INFO - PROCESS | 4230 | |i|pagename|runs| 22:19:58 INFO - PROCESS | 4230 | |0;ai-astar;112;113;108;112;111;112;101;112;111;112 22:19:58 INFO - PROCESS | 4230 | |1;audio-beat-detection;155;126;150;177;129;151;152;132;170;132 22:19:58 INFO - PROCESS | 4230 | |2;audio-dft;163;161;162;164;161;163;162;166;161;160 22:19:58 INFO - PROCESS | 4230 | |3;audio-fft;76;75;95;92;75;72;76;127;98;74 22:19:58 INFO - PROCESS | 4230 | |4;audio-oscillator;93;93;148;93;94;94;144;94;93;143 22:19:58 INFO - PROCESS | 4230 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;116;118;116 22:19:58 INFO - PROCESS | 4230 | |6;imaging-darkroom;145;146;146;146;145;145;144;145;145;145 22:19:58 INFO - PROCESS | 4230 | |7;imaging-desaturate;96;97;96;97;97;96;96;95;95;96 22:19:58 INFO - PROCESS | 4230 | |8;json-parse-financial;57;57;55;57;57;57;57;66;56;55 22:19:58 INFO - PROCESS | 4230 | |9;json-stringify-tinderbox;69;69;69;68;69;68;68;68;68;68 22:19:58 INFO - PROCESS | 4230 | |10;stanford-crypto-aes;81;81;90;81;82;82;93;82;82;84 22:19:58 INFO - PROCESS | 4230 | |11;stanford-crypto-ccm;114;118;116;114;126;116;114;118;120;116 22:19:58 INFO - PROCESS | 4230 | |12;stanford-crypto-pbkdf2;153;143;150;151;151;144;150;156;156;149 22:19:58 INFO - PROCESS | 4230 | |13;stanford-crypto-sha256-iterative;70;69;72;69;69;69;69;72;71;70 22:19:58 INFO - PROCESS | 4230 | __end_tp_report 22:19:58 INFO - PROCESS | 4230 | __start_cc_report 22:19:58 INFO - PROCESS | 4230 | _x_x_mozilla_cycle_collect,1066 22:19:58 INFO - PROCESS | 4230 | __end_cc_report 22:19:58 INFO - PROCESS | 4230 | __startTimestamp1456899598554__endTimestamp 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | ------- Summary: start ------- 22:19:58 INFO - PROCESS | 4230 | Number of tests: 14 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.57 (3.2%) stddev-sans-first:3.73 22:19:58 INFO - PROCESS | 4230 | Values: 112.0 113.0 108.0 112.0 111.0 112.0 101.0 112.0 111.0 112.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:151.50 stddev:17.50 (11.6%) stddev-sans-first:18.34 22:19:58 INFO - PROCESS | 4230 | Values: 155.0 126.0 150.0 177.0 129.0 151.0 152.0 132.0 170.0 132.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.77 (1.1%) stddev-sans-first:1.86 22:19:58 INFO - PROCESS | 4230 | Values: 163.0 161.0 162.0 164.0 161.0 163.0 162.0 166.0 161.0 160.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#3] audio-fft Cycles:10 Average:86.00 Median:76.00 stddev:17.40 (22.9%) stddev-sans-first:18.07 22:19:58 INFO - PROCESS | 4230 | Values: 76.0 75.0 95.0 92.0 75.0 72.0 76.0 127.0 98.0 74.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:24.95 (26.8%) stddev-sans-first:25.79 22:19:58 INFO - PROCESS | 4230 | Values: 93.0 93.0 148.0 93.0 94.0 94.0 144.0 94.0 93.0 143.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 22:19:58 INFO - PROCESS | 4230 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 116.0 118.0 116.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 22:19:58 INFO - PROCESS | 4230 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 144.0 145.0 145.0 145.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:19:58 INFO - PROCESS | 4230 | Values: 96.0 97.0 96.0 97.0 97.0 96.0 96.0 95.0 95.0 96.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:3.13 (5.5%) stddev-sans-first:3.32 22:19:58 INFO - PROCESS | 4230 | Values: 57.0 57.0 55.0 57.0 57.0 57.0 57.0 66.0 56.0 55.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:19:58 INFO - PROCESS | 4230 | Values: 69.0 69.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:82.00 stddev:4.21 (5.1%) stddev-sans-first:4.34 22:19:58 INFO - PROCESS | 4230 | Values: 81.0 81.0 90.0 81.0 82.0 82.0 93.0 82.0 82.0 84.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:117.00 stddev:3.68 (3.1%) stddev-sans-first:3.71 22:19:58 INFO - PROCESS | 4230 | Values: 114.0 118.0 116.0 114.0 126.0 116.0 114.0 118.0 120.0 116.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:151.00 stddev:4.32 (2.9%) stddev-sans-first:4.47 22:19:58 INFO - PROCESS | 4230 | Values: 153.0 143.0 150.0 151.0 151.0 144.0 150.0 156.0 156.0 149.0 22:19:58 INFO - PROCESS | 4230 | 22:19:58 INFO - PROCESS | 4230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 22:19:58 INFO - PROCESS | 4230 | Values: 70.0 69.0 72.0 69.0 69.0 69.0 69.0 72.0 71.0 70.0 22:19:58 INFO - PROCESS | 4230 | -------- Summary: end -------- 22:19:58 INFO - PROCESS | 4230 | 22:19:59 INFO - TEST-INFO | 4230: exit 0 22:19:59 INFO - TEST-OK | kraken | took 60756ms 22:19:59 INFO - SUITE-END | took 1175s 22:19:59 INFO - Completed test suite (00:19:36) 22:19:59 INFO - Working with test: dromaeo_css 22:19:59 INFO - Generating results file: dromaeo_css 22:19:59 INFO - Working with test: kraken 22:19:59 INFO - Generating results file: kraken 22:19:59 INFO - javascript benchmark 22:19:59 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:19:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:19:59 INFO - process_Request line: dromaeo_css 6697.34 graph.html#tests=[[72,63,35]] 22:19:59 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:19:59 INFO - process_Request line: kraken 1520.60 graph.html#tests=[[232,63,35]] 22:19:59 INFO - RETURN: dromaeo_css: 6697.34 22:19:59 INFO - RETURN: kraken: 1520.60 22:19:59 INFO - javascript benchmark 22:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3115.9844200779, 3123.578316927217, 3160.004598551456, 3166.097662166283, 3193.664665210153, 4993.700377977324, 5009.073321435528, 5029.572486338661, 5034.74826258687, 5103.438621751604, 5047.495250474951, 5064.594832413407, 5064.797408103672, 5074.568661663754, 5085.5423011928915, 4575.588197062264, 4614.607758340553, 4665.9066818663605, 4702.741349225808, 4713.670043096985, 4644.210484217674, 4660.6504512161555, 4669.719816811003, 4717.0, 4763.0, 4507.301368287905, 4555.681102322838, 4599.931001034987, 4605.148047611203, 4645.581897629196, 4611.930821037688, 4615.538446155391, 4628.051249493879, 4628.190066738341, 4651.418572678415, 4495.14592227479, 4603.286490593963, 4618.053299073682, 4640.396748422683, 4642.721436713774, 4977.626677999165, 4994.675346102528, 5003.324551185579, 5003.949960500385, 5029.874253143664, 5434.076207044812, 5497.752601132958, 5498.367687715924, 5498.367687715924, 5541.0, 5371.221172929903, 5496.80761173357, 5514.889702205974, 5525.972370138164, 5552.833414997556, 5153.2270159476, 5170.948290517084, 5175.0, 5199.220116982445, 5220.9738951305, 5613.635113717595, 5617.494425501724, 5618.353889302701, 5619.634723742944, 5621.409751976065, 5262.052830490472, 5332.466753324637, 5357.7589008494715, 5396.811111611153, 5416.783328666888, 5444.646098003617, 5498.945010549924, 5506.669599824023, 5507.118860982304, 5511.58663100269, 5465.836024919259, 5487.945120548823, 5489.725513724298, 5494.725263736797, 5542.5565954723525, 5262.236975638511, 5466.9179962300595, 5500.889982200333, 5536.114221724505, 5562.499375056264, 4239.215745087169, 4247.936280955788, 4250.638695710837, 4251.149770046003, 4285.635720963753, 3764.265968136242, 3831.8467261309793, 3839.5584507781964, 3860.2472517858746, 3903.726739128291, 5064.620153488503, 5083.694978301313, 5085.847424577269, 5130.179171332644, 5132.974335128375, 5458.0, 5458.344998600193, 5492.972535137379, 5507.118860982224, 5553.6390134641115, 4988.052270068675, 4998.600111991032, 5127.3847138343635, 5129.9996500682755, 5136.049830781318, 4616.976915115403, 4623.791929363187, 4641.489436162019, 4645.581897629162, 4684.063187362541, 5663.1505274208375, 5700.714964251771, 5702.629329093678, 5709.9714501427225, 5719.027765279912, 5341.759620816995, 5373.113436283126, 5450.672959622435, 5452.863678408072, 5481.808136715196, 5667.773289068391, 5696.231008813923, 5697.658140511582, 5699.8860022800145, 5704.572157088318, 5402.189671549142, 5417.0, 5421.349438067299, 5425.321834770653, 5426.728663566885, 5332.813351532678, 5428.755705993319, 5460.754266058117, 5518.696471694096, 5526.91709624364, 5254.369475662945, 5257.132573125392, 5289.788408463618, 5290.074237008585, 5290.788368465218, 5278.788848446019, 5282.8943421132135, 5287.233351164136, 5300.681959082467, 5345.305110335631, 5142.1258386073705, 5167.844964651066, 5199.168133098686, 5209.0363282792805, 5270.314859068297, 5263.157894736823, 5264.605154613343, 5266.683998960075, 5270.973645131749, 5351.491608297206, 5089.465606111305, 5173.611979101507, 5179.611529135405, 5187.19598462239, 5201.453847346125], "unit": "score", "name": "dojo.html", "value": 5036.365707335734}, {"lowerIsBetter": false, "replicates": [501.24562533387245, 503.9949600503995, 510.61193492945375, 516.2901011109724, 558.2435799491686, 28570.285742856413, 37269.62730372696, 37827.432588511125, 37832.62167378325, 37919.24161516768, 39458.21083578327, 39962.40056399149, 40467.79766101165, 40627.796861015726, 40717.185656286856, 7435.888461673079, 8453.408261421719, 8663.913360866374, 10001.399916005063, 10166.59333626654, 10122.645707400243, 10263.486825658725, 10266.845997310009, 10270.691879243597, 10275.486225688686, 10210.693679189599, 10361.326513776618, 10364.015418535228, 10364.740881477948, 10369.17046636271, 10192.74518137045, 10256.128229100535, 10275.075243228071, 10281.537330820094, 10292.639757608522, 9868.111869931668, 10124.392536447764, 10130.392176469362, 10468.790624187473, 10470.581176752998, 40335.596644033474, 40795.0, 40824.0, 40841.387379189335, 40864.79567602143, 3252.788568743048, 3334.8332583370734, 3734.2344819311975, 3950.071733142709, 4133.648639865615, 30418.239544011354, 30440.8477957611, 30759.63701852331, 30833.845830770704, 31405.842970785, 3719.9442008369897, 3729.459228411892, 3763.7553559018575, 3779.811009449544, 3838.692904567628, 277332.0, 279056.0, 281063.0, 281268.0, 281795.0, 40487.392689109685, 56603.71698141483, 57597.13604295939, 57646.13530797041, 57702.134467983014, 39031.0, 39428.60571394307, 39518.23372363907, 39558.0, 39625.40561891574, 13398.196108233537, 13829.446822127204, 14065.43738250479, 14103.153810771386, 14120.293985300694, 10495.26533142688, 10582.470876456146, 10586.153107751361, 11218.439078046065, 11465.426728663533, 13874.653133671538, 13944.0, 13963.58109256724, 13995.95030372726, 14062.789058164135, 5576.33084029919, 5621.578381621313, 5626.212330273765, 5626.915596266059, 5701.4298570142655, 891.7369376034086, 905.7192270396198, 940.2055263302499, 1009.5685213551194, 1022.3814592171777, 28156.296092597848, 28484.287892802433, 28630.14109576716, 28634.14097577076, 28929.566056509168, 1034.984475232872, 1041.1774697988656, 1086.43505377205, 1126.566271985275, 1140.4639819284923, 14874.405023799143, 14888.627784305263, 15015.474458394123, 15323.923380383027, 15340.92329538345, 326384.0, 329753.0, 329868.0, 334147.0, 334850.0, 51223.0, 51708.0, 51728.48271517312, 51772.0, 51945.0, 1223.932683702405, 1246.2522486508024, 1313.1989486413281, 1361.2445092973296, 1370.1299674706434, 27905.023324183556, 28816.567751484163, 29383.853080734458, 29396.853015734785, 29521.26196845096, 43517.3472397908, 43891.78054109709, 44064.339034915145, 44077.11845763131, 44105.55894441014, 174642.12678936523, 222274.0, 226164.0, 227200.0, 227553.10692377723, 31176.688233118286, 31397.529037064007, 31415.371692566478, 31439.84280078585, 31531.36937261196, 38641.227175456894, 39792.403113952736, 40370.79814600908, 40564.18871622492, 40677.796611016754, 33399.33201336008, 36348.0, 37276.813615932835, 37376.813115934245, 37728.2454350906, 36364.63635363719, 36550.26899462049, 36635.81682091572, 36845.26309473849, 36975.26049479049, 37958.810205948794, 38097.23805523819, 38488.80755596204, 38801.223975520894, 39122.608773911896, 30735.538966915068, 32946.34107317888, 33245.16887077843, 33279.0, 33394.4990825133, 25812.870935645202, 26046.348841278363, 26320.73679263183, 26653.466930661667, 26827.597586035834], "unit": "score", "name": "ext.html", "value": 17948.681999319902}, {"lowerIsBetter": false, "replicates": [343.6941122401063, 350.6633631713556, 352.2831038835969, 355.12461781708083, 357.1482015393286, 16718.498445046655, 17449.214785334658, 17655.646887062252, 18237.0, 18270.81729182708, 15900.76148857768, 16092.436764713237, 17154.056526891018, 17164.742528862076, 17167.141642917835, 4663.813447462097, 4801.759912004403, 4967.279744437054, 5407.134858422653, 5412.485813847678, 5464.3442786865635, 5471.671699698011, 5488.423715509874, 5492.038893193675, 5521.5306698930435, 5398.352197736277, 5484.396716361217, 5629.071203251479, 5987.880242395149, 5999.190109335249, 5768.509676677488, 5856.824295271127, 5875.0, 5881.176635271066, 5898.616589921641, 5094.516020978038, 5278.5249327560705, 5310.256564081032, 5315.654482458666, 5347.1177255752755, 12866.0, 12933.54732584355, 12988.220706757626, 13054.34728263583, 15653.452129175424, 2172.2505735521377, 2193.8683678979314, 2241.6637504374476, 2266.354089084603, 2323.488832456857, 9363.719088427359, 9403.482808445533, 9817.165540929029, 9899.406035637812, 11283.605073822459, 1845.0221382667207, 1857.5634725839418, 1873.0728289496785, 1884.8869067855835, 1891.0450222637617, 49154.50845491535, 63521.36478635247, 64651.0, 65070.67464662694, 67612.32387676109, 9907.207423406111, 9907.950460247652, 10106.848397274047, 10245.0, 10332.328398654063, 12096.939515302543, 12621.873781262253, 12635.620931372074, 12847.164934279243, 13059.281739504419, 7311.086114235721, 7345.93024703957, 7494.887576686354, 7572.81067973294, 7638.197989211164, 7182.712691492282, 7184.389326907271, 7225.65572051884, 7254.5647261164495, 7347.5591464511235, 4378.627816635558, 4391.055922976575, 4391.407160033355, 4440.111977604492, 4463.263561512379, 1761.2866788950496, 1777.5644966982914, 1783.3758184635274, 1814.7368631548352, 1820.2264037784153, 897.3808072430003, 911.7538264668502, 941.1811723800338, 993.557866749304, 1008.2287050406445, 16005.359785608445, 16207.513774586781, 16558.83441165597, 16755.497335079966, 16838.326466941184, 890.7416849113685, 923.4136323434667, 946.9621215151454, 967.274544091931, 988.7231575158967, 9355.578998945064, 9472.0, 9624.470654114091, 9698.078682525149, 9701.8047089758, 344208.0, 344873.0, 345712.0, 443986.0, 447692.0, 51569.74215128901, 68904.0, 70066.299337007, 71366.64316678487, 71367.6431617849, 1006.6476733143488, 1022.5960745505483, 1037.1080870451406, 1041.037040737315, 1049.2340591368343, 15563.0, 15631.531054068397, 15676.451324203597, 15793.236183667583, 15851.682966340839, 24578.754212458363, 32054.99999999907, 32957.0, 33812.66187338095, 35627.0, 40269.0, 41422.0, 42244.0, 42941.78529107334, 43296.13407731765, 7897.68409263623, 7942.483738556975, 8063.919360806317, 8076.232757887991, 8124.512529248264, 11881.0, 12008.579699710817, 12429.75140497203, 12432.067594930235, 12600.432980516081, 9798.608055677978, 10478.738031549272, 10860.945695271788, 10862.728431789268, 11280.7743845121, 10644.361338319726, 10745.570177192825, 10826.242163048826, 10914.672559823219, 10935.015848573667, 10768.838467422838, 10897.67306980792, 11018.0, 11078.335299882034, 11392.0, 7461.253874612496, 7617.923820761943, 7660.69357225727, 7785.493942893694, 7924.247196516321, 9214.953925230331, 10743.570257189625, 10789.784204316027, 11031.944840275748, 11194.216404851582], "unit": "score", "name": "jquery.html", "value": 8196.47982879559}, {"lowerIsBetter": false, "replicates": [1284.3899147904751, 1414.5402744108164, 1428.671405576717, 1572.2688949638416, 1744.2935611077519, 7068.540544864587, 7193.56838589685, 7193.784186474401, 7200.675969581368, 7201.675924583393, 7091.078159839214, 7182.209956904736, 7256.528325658842, 7278.0, 7283.162436319825, 1891.7824450188198, 2132.712083868681, 2137.0703743871386, 2169.533550286688, 2186.049068655132, 2144.849860509757, 2152.967705484419, 2153.3432303147533, 2156.0513374115417, 2156.1590979518, 2098.6327392706294, 2165.133946421436, 2172.5546263016045, 2178.281167214823, 2179.727534058243, 1946.1436967734294, 1958.7061940708866, 1964.72493850861, 1967.9409617711492, 1980.8811471311767, 2159.3953692965993, 2165.65026945764, 2171.543975765091, 2193.7477190123022, 2198.274569392113, 7214.458915581353, 7283.380912622433, 7318.81702957425, 7324.963375183143, 7363.005994190769, 4359.803808828578, 4466.4640243171025, 4466.709663871838, 4471.39636149119, 4475.776211189427, 2814.0854222377607, 2854.942901141986, 2875.353045564752, 2897.5219088850313, 2936.236578489587, 920.3143657974784, 920.4339331311195, 921.8893732752045, 925.4586067150725, 959.4195511715382, 9815.803683926353, 9952.353097048668, 9973.75065623358, 9975.25185611082, 9987.450690212036, 4007.0583412897945, 4019.8392064317686, 4045.8179381927885, 4110.897227569335, 4120.546739858613, 8538.87191692125, 8651.091635378321, 8848.247898928534, 8867.201951824367, 8873.600687969058, 4025.134596061861, 4575.816967321336, 4585.358049873021, 4590.98998220391, 4596.632269418438, 3686.8340924658455, 4005.319095753671, 4065.390191471303, 4111.218868414991, 4124.030852749602, 3474.8436320365645, 3526.9118272043406, 3531.1172206948263, 3553.982230088833, 3589.2283159120393, 1106.8339749037548, 1114.0530549033258, 1117.0449265877558, 1117.2905205194759, 1128.5937062657438, 1240.4356018011783, 1262.1354372255034, 1262.9242245465302, 1263.5514392390753, 1275.687456573127, 7057.752978645723, 7141.143062832493, 7150.642467876585, 7153.284671532909, 7158.141023077264, 488.5700583486509, 496.02283501501984, 496.84101087651607, 498.5014985014985, 499.3757802746567, 5568.610197286151, 5590.888182236414, 5596.916046259309, 5605.467480589337, 5645.887082258332, 8490.745277641681, 8564.657413703382, 8588.785280367916, 8659.740207793777, 8703.47779133254, 8606.0, 8632.654693812177, 8633.740987770252, 8639.611217495101, 8642.913570864212, 6771.356721111487, 6898.586084834826, 6908.861822763517, 7019.3682568569075, 7023.543469674455, 6676.432503237279, 6742.9662851685425, 6759.053732477555, 6762.222344430454, 6795.116634837439, 7648.196939321291, 7735.7679269622, 7890.802729931797, 7937.682492700227, 7975.441719079608, 7840.490368126054, 8124.8781268279845, 8134.796630084295, 8215.548144851851, 8219.95890020546, 5819.747161129149, 5821.277945454582, 6190.783322583688, 6558.967205164135, 6667.133272674521, 6545.607263564201, 6566.9014964776525, 6589.0775291460195, 6590.934090659032, 7116.181639111568, 6432.614043157426, 6475.838104047437, 6481.708323125565, 6562.671866406565, 6577.736890524326, 6336.0, 6402.775902843378, 6406.359364063556, 6484.28672845996, 6508.349165083454, 6739.629320387426, 6789.083473731181, 6789.830254243683, 6857.5199736018, 6912.170539535086, 6249.0, 6284.214473190851, 6292.0, 6295.244570651551, 6303.9684801575695, 6009.879802404015, 6077.4226448487325, 6080.148779171008, 6083.482903953213, 6084.7566097357385], "unit": "score", "name": "mootools.html", "value": 4147.603040715892}, {"lowerIsBetter": false, "replicates": [304.7287913756757, 323.20814005686066, 323.80409852039514, 326.56077575660726, 330.8312760492148, 5919.319278282998, 5922.437368449996, 5936.1689363489095, 5978.611390259641, 5992.280926288846, 5868.677222752747, 5904.114382842576, 5908.02517584598, 5911.556633252512, 5913.793017244398, 4307.396964424967, 4438.7780610969485, 4515.954840451603, 4567.885802854922, 4574.451065872092, 4570.33730109134, 4573.63410927125, 4598.655100867431, 4602.102589994953, 4606.493285738566, 4528.18492671319, 4530.75080870552, 4540.432445944257, 4542.500324964251, 4544.1593305238475, 4284.443022407083, 4399.18615056214, 4513.0296986147805, 4524.072565124175, 4537.228671125917, 3976.383660532622, 3977.463042489285, 3982.721209515335, 3987.80060996949, 3987.8404863805413, 5609.130584759328, 5637.182608521783, 5638.267025286727, 5638.379778224392, 5640.407757185519, 5284.128118860383, 5288.0, 5294.100002999499, 5294.68231906083, 5302.44324345942, 6276.403741644536, 6281.403266689657, 6282.560220784547, 6288.276848162474, 6288.748450061992, 4324.308110702304, 4412.823487060514, 4423.026934074531, 4429.269170586849, 4433.024734558392, 6462.935370646281, 6489.059086432488, 6500.349965003509, 6503.0, 6506.609603423763, 4511.120331535385, 4515.367848501212, 4532.501424843264, 4533.320001999727, 4541.296099104644, 4587.4036375271, 4589.242774942164, 4593.379893714306, 4596.862094137181, 4600.723956562617, 5272.420033796279, 5274.393444753826, 5281.9207711884355, 5287.286216360819, 5287.391949925808, 6152.815415537541, 6325.5255855811, 6335.271443783931, 6338.556301058881, 6346.4605508532295, 1600.3518574977154, 1606.2129556517223, 1617.191404297851, 1620.1899050474763, 1622.9026258424296, 999.480270259461, 1013.5996281468779, 1018.6485662446444, 1047.4396198034015, 1056.0864851903048, 5770.16332631766, 5837.824865254049, 5840.29916410025, 5848.444397782204, 5863.882722345615, 6406.551541392151, 6422.967885160638, 6427.967860160763, 6436.935630643634, 6441.388068133613, 5906.202662640489, 5910.822675319747, 5911.142884281755, 5911.261092363455, 5912.615679980873, 3444.896653100411, 3473.027552285364, 3476.2526056897887, 3477.3393055319916, 3483.7213022958103, 6561.507886908501, 6670.332966703291, 6692.0, 6730.461563074942, 6752.08846805675, 6562.967185164043, 6580.605163690098, 6580.63806490638, 6586.27550969393, 6594.8351291218105, 6704.430123439464, 6708.731650734014, 6712.463002959751, 6715.529912906148, 6732.932670673231, 6427.196600424947, 6430.453411460078, 6432.067350234096, 6433.292337842927, 6433.678316084083, 6217.347178546368, 6325.683715814283, 6350.618962862243, 6355.269144048493, 6369.01280301554, 6715.764948226789, 6746.628935408599, 6750.1562304711915, 6750.45996320303, 6751.56114852533, 4517.344984977094, 4519.299508576176, 4521.276595744796, 4524.705894116872, 4526.954730452653, 6442.194725659293, 6446.161998940295, 6450.193725784277, 6451.0, 6452.483801295791, 6178.907316390168, 6207.441330280297, 6247.062940558771, 6248.562600617913, 6250.656213908097, 6085.208922840179, 6223.595466294676, 6236.812895613139, 6237.345078766664, 6252.624842509464, 6112.877742445037, 6136.386361363828, 6144.78493252734, 6146.784862529968, 6148.815535533941, 6257.937420625735, 6268.623882567061, 6269.7178626962805, 6271.592346497463, 6282.748690052346, 5989.221401217814, 6042.244719410074, 6130.693465326805, 6143.662098584621, 6147.631142131308], "unit": "score", "name": "prototype.html", "value": 4724.658180377642}, {"lowerIsBetter": false, "replicates": [721.6355740351123, 782.9725959591416, 786.7482405630201, 786.8701664225404, 825.9421840471166, 13823.37794799234, 14048.08687435316, 14064.367103480343, 14095.929520352396, 14104.15375077496, 14445.63885902853, 14516.129032258072, 14613.634659133528, 14624.341904614292, 14882.776758348606, 775.3564541430627, 785.5286827903269, 785.7407055671644, 786.1588100732218, 786.4455558831039, 640.0910706796337, 770.8496843115595, 785.3677789379548, 786.5084322298563, 786.7561056072636, 837.1168417319725, 839.0518713853337, 842.1620487614832, 843.1694780641063, 843.5908584336592, 823.6293667849492, 831.0484495252932, 831.4969443486664, 831.5218749219223, 832.8126171611369, 496.97018178909383, 603.0772917436329, 611.6819253987901, 612.2713970375239, 612.4120843989775, 14138.787918181235, 14196.85803141976, 14199.077059991068, 14206.218657973808, 14234.14595124296, 12715.936420317932, 12982.221066736027, 13034.869651303461, 13107.082504224709, 13235.536756213583, 10965.0, 10974.670759877217, 11027.889721102847, 11135.944320278346, 11264.0, 3498.8690924963266, 3508.6329011104326, 3542.3092496963104, 3594.946075808865, 3654.086478380405, 51322.486775132515, 51988.48011519874, 52221.47778522204, 52333.215001775, 52370.738146309406, 9774.462404567817, 10084.798304033879, 10179.7455063624, 10215.846762298572, 10375.533101010473, 17975.910120449575, 17996.190171442315, 18016.9099154506, 18038.36865709694, 18052.909735451238, 7809.882851757228, 7914.881276780853, 7992.800179995546, 8018.077921039038, 8064.193580642006, 4008.599140086026, 4040.313146765057, 4071.6131967463043, 4156.064885400821, 4199.97900010498, 2822.788290878192, 2824.4633519631207, 2874.453853767777, 2881.639795025622, 2893.956590651142, 541.1639017717557, 555.1201345866847, 555.824915151734, 559.1110134885552, 572.0246978900964, 519.6336582709181, 552.2489414396417, 571.4970825673381, 579.183351474419, 596.8895754285471, 7637.694492220249, 7788.260115289038, 7934.722284720007, 8037.638306276232, 8076.83846323082, 495.58370968386726, 599.7660912244228, 624.9281332646713, 631.8767840271103, 676.7766637009873, 3569.203160439639, 3603.261331427051, 3681.5398075240596, 3684.8526058957877, 3792.7534710243744, 55896.44103558994, 56028.0, 56934.0, 56985.14522282169, 57142.42857571371, 47552.01407704352, 47904.5209547907, 48496.27255591169, 49134.0, 49955.25067123996, 43082.0, 43986.34020489695, 44048.0, 44974.0, 45464.0, 7797.0, 7958.960205198937, 8000.759977200693, 8124.22819832115, 8291.461055031403, 33603.66396336005, 34566.0, 34818.47772283469, 35010.124746881535, 35085.64914350926, 42560.14879702327, 43104.0, 43133.3529997044, 43539.78230108829, 43621.0, 11303.943480282545, 11411.144164187885, 11582.189246752647, 11659.76680466369, 11695.239809412362, 12412.689682758004, 12462.750744984869, 12813.487460501476, 12835.807462888251, 13311.66720831987, 10581.677290338708, 10766.354018758899, 10835.295705779099, 10837.783244335227, 11264.831027534758, 10996.395198264172, 11045.889541104487, 11476.942615286871, 11485.081193504333, 11947.761044778881, 11373.090152787923, 11518.649476514589, 11712.297262164297, 12135.393230338625, 12156.513739450676, 9505.477198754135, 9577.569009394454, 9701.272404569827, 9931.205503559553, 9968.102870741668, 8223.136570659995, 8433.915660843313, 8567.700130495403, 8753.0, 9063.728088157366], "unit": "score", "name": "yui.html", "value": 6214.814942896529}], "name": "dromaeo_css", "value": 6697.33930820219}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 112.0, 111.0, 112.0, 101.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 150.0, 177.0, 129.0, 151.0, 152.0, 132.0, 170.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 164.0, 161.0, 163.0, 162.0, 166.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 95.0, 92.0, 75.0, 72.0, 76.0, 127.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 93.0, 94.0, 94.0, 144.0, 94.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 118.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 55.0, 57.0, 57.0, 57.0, 57.0, 66.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 90.0, 81.0, 82.0, 82.0, 93.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [114.0, 118.0, 116.0, 114.0, 126.0, 116.0, 114.0, 118.0, 120.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [153.0, 143.0, 150.0, 151.0, 151.0, 144.0, 150.0, 156.0, 156.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 72.0, 69.0, 69.0, 69.0, 69.0, 72.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1520.6000000000001}]} 22:19:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1520.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6697.34"}}} 22:19:59 INFO - Return code: 0 22:19:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:19:59 INFO - # TBPL SUCCESS # 22:19:59 INFO - Running post-action listener: _resource_record_post_action 22:19:59 INFO - Running post-run listener: _resource_record_post_run 22:20:00 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 3002368; Write bytes: 290553856; Read time: 1228; Write time: 347376 22:20:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1499136; Read time: 0; Write time: 224 22:20:00 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3002368; Write bytes: 289054720; Read time: 1228; Write time: 347152 22:20:00 INFO - Running post-run listener: _upload_blobber_files 22:20:00 INFO - Blob upload gear active. 22:20:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:20:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:20:00 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'] 22:20:00 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 22:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:02 INFO - (blobuploader) - INFO - Done attempting. 22:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:03 INFO - (blobuploader) - INFO - Done attempting. 22:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:03 INFO - Return code: 0 22:20:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a79bc3d05929c9874f7fc420793ac35d80302deb9870a45d3dfd6694c9238b625e63a2c34ac16d1bfd874188b1df42d67b289d4cd246e6d10983a7c450de279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/facf7d96cd50fd5ce2b1b19c23c513dcb58cf8ed80d85d69b0d2b8d7b5d3c3a55e0b0865e2c6e889c8a1817734543715a83537761c3fa20ae670bd4033fcac1f"} 22:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:20:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:20:03 INFO - Contents: 22:20:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a79bc3d05929c9874f7fc420793ac35d80302deb9870a45d3dfd6694c9238b625e63a2c34ac16d1bfd874188b1df42d67b289d4cd246e6d10983a7c450de279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/facf7d96cd50fd5ce2b1b19c23c513dcb58cf8ed80d85d69b0d2b8d7b5d3c3a55e0b0865e2c6e889c8a1817734543715a83537761c3fa20ae670bd4033fcac1f"} 22:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:03 INFO - Copying logs to upload dir... 22:20:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.389289 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-03-01 22:20:03.377316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:03.381180) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 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/6a79bc3d05929c9874f7fc420793ac35d80302deb9870a45d3dfd6694c9238b625e63a2c34ac16d1bfd874188b1df42d67b289d4cd246e6d10983a7c450de279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/facf7d96cd50fd5ce2b1b19c23c513dcb58cf8ed80d85d69b0d2b8d7b5d3c3a55e0b0865e2c6e889c8a1817734543715a83537761c3fa20ae670bd4033fcac1f"} build_url:https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011585 build_url: 'https://queue.taskcluster.net/v1/task/S2Xpn_6PSxKDVQR_n5T2Yg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6a79bc3d05929c9874f7fc420793ac35d80302deb9870a45d3dfd6694c9238b625e63a2c34ac16d1bfd874188b1df42d67b289d4cd246e6d10983a7c450de279", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/facf7d96cd50fd5ce2b1b19c23c513dcb58cf8ed80d85d69b0d2b8d7b5d3c3a55e0b0865e2c6e889c8a1817734543715a83537761c3fa20ae670bd4033fcac1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:03.406679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:03.407045) ========= 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=af724c981e2a0f424dbabf99000001e7-1456898096.52768-550049278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 22:20:03.490531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 22:20:03.490891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 22:20:03.491197) ========= ========= Total master_lag: 0.24 =========