builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1459745771.1 results: success (0) buildid: 20160403193250 builduid: 54ff50009bc84010ab2bb52b463c2616 revision: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.099693) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.100114) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.100436) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006332 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.250719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.251039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.337214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.337852) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.404227) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.407446) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.407954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.408265) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-03 21:56:11-- 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% 89.6M=0s 2016-04-03 21:56:11 (89.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157204 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.592819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.593122) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014846 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:11.646548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-03 21:56:11.646885) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 600f96d25f8c94c73849dc98f0ad36769f9b57d3 --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 600f96d25f8c94c73849dc98f0ad36769f9b57d3 --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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-03 21:56:11,919 truncating revision to first 12 chars 2016-04-03 21:56:11,919 Setting DEBUG logging. 2016-04-03 21:56:11,919 attempt 1/10 2016-04-03 21:56:11,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/600f96d25f8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-03 21:56:12,813 unpacking tar archive at: mozilla-inbound-600f96d25f8c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.229927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-03 21:56:12.893054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.893456) ========= echo 600f96d25f8c94c73849dc98f0ad36769f9b57d3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'600f96d25f8c94c73849dc98f0ad36769f9b57d3'] 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 600f96d25f8c94c73849dc98f0ad36769f9b57d3 program finished with exit code 0 elapsedTime=0.003782 script_repo_revision: '600f96d25f8c94c73849dc98f0ad36769f9b57d3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.942443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.942816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-03 21:56:12.953082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-03 21:56:12.953490) ========= /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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:13 INFO - MultiFileLogger online at 20160403 21:56:13 in /builds/slave/test-pgo 21:56:13 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:56:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:13 INFO - {'append_to_log': False, 21:56:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:56:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:13 INFO - 'branch': 'Mozilla-Inbound', 21:56:13 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:13 INFO - 'config_files': ('talos/linux_config.py',), 21:56:13 INFO - 'default_actions': ('clobber', 21:56:13 INFO - 'read-buildbot-config', 21:56:13 INFO - 'download-and-extract', 21:56:13 INFO - 'populate-webroot', 21:56:13 INFO - 'create-virtualenv', 21:56:13 INFO - 'install', 21:56:13 INFO - 'run-tests'), 21:56:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:13 INFO - 'download_minidump_stackwalk': True, 21:56:13 INFO - 'download_symbols': 'ondemand', 21:56:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:13 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:13 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:13 INFO - 'installer_path': 'installer.exe', 21:56:13 INFO - 'log_level': 'info', 21:56:13 INFO - 'log_name': 'talos', 21:56:13 INFO - 'log_to_console': True, 21:56:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:13 INFO - 'opt_config_files': (), 21:56:13 INFO - 'pip_index': False, 21:56:13 INFO - 'sps_profile': False, 21:56:13 INFO - 'sps_profile_interval': 0, 21:56:13 INFO - 'suite': 'dromaeojs', 21:56:13 INFO - 'system_bits': '32', 21:56:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:13 INFO - 'title': 'talos-linux64-ix-024', 21:56:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:13 INFO - 'use_talos_json': True, 21:56:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:13 INFO - 'work_dir': 'build'} 21:56:13 INFO - ##### 21:56:13 INFO - ##### Running clobber step. 21:56:13 INFO - ##### 21:56:13 INFO - Running pre-action listener: _resource_record_pre_action 21:56:13 INFO - Running main action method: clobber 21:56:13 INFO - rmtree: /builds/slave/test-pgo/build 21:56:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:14 INFO - Running post-action listener: _resource_record_post_action 21:56:14 INFO - ##### 21:56:14 INFO - ##### Running read-buildbot-config step. 21:56:14 INFO - ##### 21:56:14 INFO - Running pre-action listener: _resource_record_pre_action 21:56:14 INFO - Running main action method: read_buildbot_config 21:56:14 INFO - Using buildbot properties: 21:56:14 INFO - { 21:56:14 INFO - "project": "", 21:56:14 INFO - "product": "firefox", 21:56:14 INFO - "script_repo_revision": "production", 21:56:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:56:14 INFO - "repository": "", 21:56:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:56:14 INFO - "buildid": "20160403193250", 21:56:14 INFO - "pgo_build": "True", 21:56:14 INFO - "basedir": "/builds/slave/test-pgo", 21:56:14 INFO - "buildnumber": 826, 21:56:14 INFO - "slavename": "talos-linux64-ix-024", 21:56:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:56:14 INFO - "platform": "ubuntu64_hw", 21:56:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:56:14 INFO - "branch": "mozilla-inbound", 21:56:14 INFO - "repo_path": "integration/mozilla-inbound", 21:56:14 INFO - "revision": "600f96d25f8c94c73849dc98f0ad36769f9b57d3", 21:56:14 INFO - "stage_platform": "linux64-pgo", 21:56:14 INFO - "builduid": "54ff50009bc84010ab2bb52b463c2616", 21:56:14 INFO - "slavebuilddir": "test" 21:56:14 INFO - } 21:56:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 21:56:14 INFO - Running post-action listener: _resource_record_post_action 21:56:14 INFO - ##### 21:56:14 INFO - ##### Running download-and-extract step. 21:56:14 INFO - ##### 21:56:14 INFO - Running pre-action listener: _resource_record_pre_action 21:56:14 INFO - Running main action method: download_and_extract 21:56:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:14 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:56:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:56:23 INFO - Downloaded 1361 bytes. 21:56:23 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 21:56:23 INFO - Using the following test package requirements: 21:56:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:56:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'jsshell-linux-x86_64.zip'], 21:56:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:23 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:31 INFO - Downloaded 23696118 bytes. 21:56:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:32 INFO - Return code: 0 21:56:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:56:32 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:56:32 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 21:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:56:33 INFO - Downloaded 23696118 bytes. 21:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:35 INFO - Return code: 0 21:56: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:56:35 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:56:37 INFO - Downloaded 10847584 bytes. 21:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:56:37 INFO - Return code: 0 21:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:37 INFO - https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:56:38 INFO - Downloaded 57685198 bytes. 21:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:38 INFO - mkdir: /builds/slave/test-pgo/properties 21:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:56:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:56:38 INFO - Contents: 21:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 21:56:39 INFO - Running post-action listener: _resource_record_post_action 21:56:39 INFO - Running post-action listener: set_extra_try_arguments 21:56:39 INFO - ##### 21:56:39 INFO - ##### Running populate-webroot step. 21:56:39 INFO - ##### 21:56:39 INFO - Running pre-action listener: _resource_record_pre_action 21:56:39 INFO - Running main action method: populate_webroot 21:56:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:39 INFO - '--tppagecycles', 21:56:39 INFO - '7'], 21:56:39 INFO - 'tests': ['tsvgm']}}, 21:56:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:56:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:56:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'tests': ['damp', 'tps']}, 21:56:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['damp', 'tps']}, 21:56:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:56:39 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['dromaeo_dom']}, 21:56:39 INFO - 'other': {'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'other_l64': {'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'other_nol64': {'tests': ['a11yr', 21:56:39 INFO - 'ts_paint', 21:56:39 INFO - 'tpaint', 21:56:39 INFO - 'sessionrestore', 21:56:39 INFO - 'sessionrestore_no_auto_restore', 21:56:39 INFO - 'tabpaint']}, 21:56:39 INFO - 'svgr': {'tests': ['tsvgx', 21:56:39 INFO - 'tsvgr_opacity', 21:56:39 INFO - 'tart', 21:56:39 INFO - 'tscrollx', 21:56:39 INFO - 'cart']}, 21:56:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['tsvgx', 21:56:39 INFO - 'tsvgr_opacity', 21:56:39 INFO - 'tart', 21:56:39 INFO - 'tscrollx', 21:56:39 INFO - 'cart']}, 21:56:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'tests': ['tp5o']}, 21:56:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'talos_options': ['--e10s'], 21:56:39 INFO - 'tests': ['tp5o']}, 21:56:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'talos_options': ['--xperf_path', 21:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:39 INFO - 'tests': ['tp5n']}, 21:56:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:39 INFO - 'talos_options': ['--e10s', 21:56:39 INFO - '--xperf_path', 21:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:39 INFO - 'tests': ['tp5n']}}, 21:56:39 INFO - 'talos.zip': {'path': '', 21:56:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:39 INFO - Running post-action listener: _resource_record_post_action 21:56:39 INFO - ##### 21:56:39 INFO - ##### Running create-virtualenv step. 21:56:39 INFO - ##### 21:56:39 INFO - Running pre-action listener: _resource_record_pre_action 21:56:39 INFO - Running main action method: create_virtualenv 21:56:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:56:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:56:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:56:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:39 INFO - Using real prefix '/usr' 21:56:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:56:40 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:42 INFO - Installing pip.................done. 21:56:42 INFO - Return code: 0 21:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:42 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:56:42 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:56:42 INFO - Using env: {'DISPLAY': ':0', 21:56:42 INFO - 'HOME': '/home/cltbld', 21:56:42 INFO - 'LANG': 'en_US.UTF-8', 21:56:42 INFO - 'LANGUAGE': 'en_US:en', 21:56:42 INFO - 'LOGNAME': 'cltbld', 21:56:42 INFO - 'MAIL': '/var/mail/cltbld', 21:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:42 INFO - 'MOZ_NO_REMOTE': '1', 21:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:42 INFO - 'NO_EM_RESTART': '1', 21:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:42 INFO - 'SHELL': '/bin/bash', 21:56:42 INFO - 'SHLVL': '1', 21:56:42 INFO - 'TERM': 'linux', 21:56:42 INFO - 'TMOUT': '86400', 21:56:42 INFO - 'USER': 'cltbld', 21:56:42 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:42 INFO - '_': '/tools/buildbot/bin/python'} 21:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:42 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:56:42 INFO - Cleaning up... 21:56:42 INFO - Return code: 0 21:56:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:42 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:42 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:56:42 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:56:42 INFO - Using env: {'DISPLAY': ':0', 21:56:42 INFO - 'HOME': '/home/cltbld', 21:56:42 INFO - 'LANG': 'en_US.UTF-8', 21:56:42 INFO - 'LANGUAGE': 'en_US:en', 21:56:42 INFO - 'LOGNAME': 'cltbld', 21:56:42 INFO - 'MAIL': '/var/mail/cltbld', 21:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:42 INFO - 'MOZ_NO_REMOTE': '1', 21:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:42 INFO - 'NO_EM_RESTART': '1', 21:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:42 INFO - 'SHELL': '/bin/bash', 21:56:42 INFO - 'SHLVL': '1', 21:56:42 INFO - 'TERM': 'linux', 21:56:42 INFO - 'TMOUT': '86400', 21:56:42 INFO - 'USER': 'cltbld', 21:56:42 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:42 INFO - '_': '/tools/buildbot/bin/python'} 21:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:42 INFO - Downloading/unpacking psutil>=0.7.1 21:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:44 INFO - Installing collected packages: psutil 21:56:44 INFO - Running setup.py install for psutil 21:56:44 INFO - building 'psutil._psutil_linux' extension 21:56:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:56:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:56:44 INFO - building 'psutil._psutil_posix' extension 21:56:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:56:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:44 INFO - Successfully installed psutil 21:56:44 INFO - Cleaning up... 21:56:45 INFO - Return code: 0 21:56:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:56: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:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56: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', '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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:56: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 mozsystemmonitor==0.0.0 21:56:45 INFO - Using env: {'DISPLAY': ':0', 21:56:45 INFO - 'HOME': '/home/cltbld', 21:56:45 INFO - 'LANG': 'en_US.UTF-8', 21:56:45 INFO - 'LANGUAGE': 'en_US:en', 21:56:45 INFO - 'LOGNAME': 'cltbld', 21:56:45 INFO - 'MAIL': '/var/mail/cltbld', 21:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:45 INFO - 'MOZ_NO_REMOTE': '1', 21:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:45 INFO - 'NO_EM_RESTART': '1', 21:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:45 INFO - 'SHELL': '/bin/bash', 21:56:45 INFO - 'SHLVL': '1', 21:56:45 INFO - 'TERM': 'linux', 21:56:45 INFO - 'TMOUT': '86400', 21:56:45 INFO - 'USER': 'cltbld', 21:56:45 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:45 INFO - '_': '/tools/buildbot/bin/python'} 21:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:56:45 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:56:45 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:56:45 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:56:45 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:56:45 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:56:45 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:56:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:56:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:47 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:56:47 INFO - Installing collected packages: mozsystemmonitor 21:56:47 INFO - Running setup.py install for mozsystemmonitor 21:56:47 INFO - Successfully installed mozsystemmonitor 21:56:47 INFO - Cleaning up... 21:56:47 INFO - Return code: 0 21:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:56:47 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:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 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:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:47 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:47 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:56:47 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:56:47 INFO - Using env: {'DISPLAY': ':0', 21:56:47 INFO - 'HOME': '/home/cltbld', 21:56:47 INFO - 'LANG': 'en_US.UTF-8', 21:56:47 INFO - 'LANGUAGE': 'en_US:en', 21:56:47 INFO - 'LOGNAME': 'cltbld', 21:56:47 INFO - 'MAIL': '/var/mail/cltbld', 21:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:47 INFO - 'MOZ_NO_REMOTE': '1', 21:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:47 INFO - 'NO_EM_RESTART': '1', 21:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:47 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:47 INFO - 'SHELL': '/bin/bash', 21:56:47 INFO - 'SHLVL': '1', 21:56:47 INFO - 'TERM': 'linux', 21:56:47 INFO - 'TMOUT': '86400', 21:56:47 INFO - 'USER': 'cltbld', 21:56:47 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:47 INFO - '_': '/tools/buildbot/bin/python'} 21:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:47 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:49 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:56:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:50 INFO - Downloading docopt-0.6.1.tar.gz 21:56:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:50 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:50 INFO - Running setup.py install for blobuploader 21:56:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:56:50 INFO - Running setup.py install for requests 21:56:50 INFO - Running setup.py install for docopt 21:56:50 INFO - Successfully installed blobuploader requests docopt 21:56:50 INFO - Cleaning up... 21:56:50 INFO - Return code: 0 21:56:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:50 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:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 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:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:50 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:50 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:56:50 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:56:50 INFO - Using env: {'DISPLAY': ':0', 21:56:50 INFO - 'HOME': '/home/cltbld', 21:56:50 INFO - 'LANG': 'en_US.UTF-8', 21:56:50 INFO - 'LANGUAGE': 'en_US:en', 21:56:50 INFO - 'LOGNAME': 'cltbld', 21:56:50 INFO - 'MAIL': '/var/mail/cltbld', 21:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:50 INFO - 'MOZ_NO_REMOTE': '1', 21:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:50 INFO - 'NO_EM_RESTART': '1', 21:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:50 INFO - 'SHELL': '/bin/bash', 21:56:50 INFO - 'SHLVL': '1', 21:56:50 INFO - 'TERM': 'linux', 21:56:50 INFO - 'TMOUT': '86400', 21:56:50 INFO - 'USER': 'cltbld', 21:56:50 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:50 INFO - '_': '/tools/buildbot/bin/python'} 21:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:50 INFO - Running setup.py (path:/tmp/pip-OeiFJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:51 INFO - Running setup.py (path:/tmp/pip-e17zoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:51 INFO - Running setup.py (path:/tmp/pip-mjKsLd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:51 INFO - Running setup.py (path:/tmp/pip-GjY4Cy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:51 INFO - Running setup.py (path:/tmp/pip-Nh9T28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:51 INFO - Running setup.py (path:/tmp/pip-e_yJ6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:51 INFO - Running setup.py (path:/tmp/pip-rp8S_e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:51 INFO - Running setup.py (path:/tmp/pip-xFTHQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:51 INFO - Running setup.py (path:/tmp/pip-OmgQLr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:51 INFO - Running setup.py (path:/tmp/pip-fpU9vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:51 INFO - Running setup.py (path:/tmp/pip-bGHykD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:51 INFO - Running setup.py (path:/tmp/pip-xyECNj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:51 INFO - Running setup.py (path:/tmp/pip-o764tL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:52 INFO - Running setup.py (path:/tmp/pip-0_Ekcw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:52 INFO - Running setup.py (path:/tmp/pip-H8lnvb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:52 INFO - Running setup.py (path:/tmp/pip-Zt6jUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:52 INFO - Running setup.py (path:/tmp/pip-PeaReo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:52 INFO - Running setup.py install for manifestparser 21:56:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:56:52 INFO - Running setup.py install for mozcrash 21:56:52 INFO - Running setup.py install for mozdebug 21:56:52 INFO - Running setup.py install for mozdevice 21:56:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:56:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:56:52 INFO - Running setup.py install for mozfile 21:56:52 INFO - Running setup.py install for mozhttpd 21:56:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:56:52 INFO - Running setup.py install for mozinfo 21:56:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:56:52 INFO - Running setup.py install for mozInstall 21:56:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Running setup.py install for mozleak 21:56:53 INFO - Running setup.py install for mozlog 21:56:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Running setup.py install for moznetwork 21:56:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Running setup.py install for mozprocess 21:56:53 INFO - Running setup.py install for mozprofile 21:56:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Running setup.py install for mozrunner 21:56:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:56:53 INFO - Running setup.py install for mozscreenshot 21:56:53 INFO - Running setup.py install for moztest 21:56:53 INFO - Running setup.py install for mozversion 21:56:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:56:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:54 INFO - Cleaning up... 21:56:54 INFO - Return code: 0 21:56:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:54 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:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 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:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:54 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:56:54 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:56:54 INFO - Using env: {'DISPLAY': ':0', 21:56:54 INFO - 'HOME': '/home/cltbld', 21:56:54 INFO - 'LANG': 'en_US.UTF-8', 21:56:54 INFO - 'LANGUAGE': 'en_US:en', 21:56:54 INFO - 'LOGNAME': 'cltbld', 21:56:54 INFO - 'MAIL': '/var/mail/cltbld', 21:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:54 INFO - 'MOZ_NO_REMOTE': '1', 21:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:54 INFO - 'NO_EM_RESTART': '1', 21:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:54 INFO - 'SHELL': '/bin/bash', 21:56:54 INFO - 'SHLVL': '1', 21:56:54 INFO - 'TERM': 'linux', 21:56:54 INFO - 'TMOUT': '86400', 21:56:54 INFO - 'USER': 'cltbld', 21:56:54 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:54 INFO - '_': '/tools/buildbot/bin/python'} 21:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:54 INFO - Running setup.py (path:/tmp/pip-_U_XrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:54 INFO - Running setup.py (path:/tmp/pip-6b_P3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:54 INFO - Running setup.py (path:/tmp/pip-ni1N2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:54 INFO - Running setup.py (path:/tmp/pip-6nOSOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:54 INFO - Running setup.py (path:/tmp/pip-lzvp9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:54 INFO - Running setup.py (path:/tmp/pip-P7XvC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:54 INFO - Running setup.py (path:/tmp/pip-DaQVmf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:54 INFO - Running setup.py (path:/tmp/pip-H_R3U1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:54 INFO - Running setup.py (path:/tmp/pip-NhTOt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:54 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:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:54 INFO - Running setup.py (path:/tmp/pip-Fszm7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:55 INFO - Running setup.py (path:/tmp/pip-3e2QqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:55 INFO - Running setup.py (path:/tmp/pip-mH73VF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:55 INFO - Running setup.py (path:/tmp/pip-82Fg3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:55 INFO - Running setup.py (path:/tmp/pip-VdsGDO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:55 INFO - Running setup.py (path:/tmp/pip-vPSEwV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:55 INFO - Running setup.py (path:/tmp/pip-GMqfVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:55 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:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:55 INFO - Running setup.py (path:/tmp/pip-GxxMRS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:55 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:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:55 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:56:55 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:56:55 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:56:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:57 INFO - Downloading blessings-1.6.tar.gz 21:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:57 INFO - Installing collected packages: blessings 21:56:57 INFO - Running setup.py install for blessings 21:56:57 INFO - Successfully installed blessings 21:56:57 INFO - Cleaning up... 21:56:57 INFO - Return code: 0 21:56:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:56:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:56:57 INFO - Reading from file tmpfile_stdout 21:56:57 INFO - Current package versions: 21:56:57 INFO - argparse == 1.2.1 21:56:57 INFO - blessings == 1.6 21:56:57 INFO - blobuploader == 1.2.4 21:56:57 INFO - docopt == 0.6.1 21:56:57 INFO - manifestparser == 1.1 21:56:57 INFO - mozInstall == 1.12 21:56:57 INFO - mozcrash == 0.17 21:56:57 INFO - mozdebug == 0.1 21:56:57 INFO - mozdevice == 0.48 21:56:57 INFO - mozfile == 1.2 21:56:57 INFO - mozhttpd == 0.7 21:56:57 INFO - mozinfo == 0.9 21:56:57 INFO - mozleak == 0.1 21:56:57 INFO - mozlog == 3.1 21:56:57 INFO - moznetwork == 0.27 21:56:57 INFO - mozprocess == 0.22 21:56:57 INFO - mozprofile == 0.28 21:56:57 INFO - mozrunner == 6.11 21:56:57 INFO - mozscreenshot == 0.1 21:56:57 INFO - mozsystemmonitor == 0.0 21:56:57 INFO - moztest == 0.7 21:56:57 INFO - mozversion == 1.4 21:56:57 INFO - psutil == 3.1.1 21:56:57 INFO - requests == 1.2.3 21:56:57 INFO - wsgiref == 0.1.2 21:56:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:57 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:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 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:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:57 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 21:56:57 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 21:56:57 INFO - Using env: {'DISPLAY': ':0', 21:56:57 INFO - 'HOME': '/home/cltbld', 21:56:57 INFO - 'LANG': 'en_US.UTF-8', 21:56:57 INFO - 'LANGUAGE': 'en_US:en', 21:56:57 INFO - 'LOGNAME': 'cltbld', 21:56:57 INFO - 'MAIL': '/var/mail/cltbld', 21:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:57 INFO - 'MOZ_NO_REMOTE': '1', 21:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:57 INFO - 'NO_EM_RESTART': '1', 21:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:57 INFO - 'SHELL': '/bin/bash', 21:56:57 INFO - 'SHLVL': '1', 21:56:57 INFO - 'TERM': 'linux', 21:56:57 INFO - 'TMOUT': '86400', 21:56:57 INFO - 'USER': 'cltbld', 21:56:57 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:57 INFO - '_': '/tools/buildbot/bin/python'} 21:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 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)) 21:56:58 INFO - Cleaning up... 21:56:58 INFO - Return code: 0 21:56:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:56:58 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:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:58 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:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:58 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 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:56:58 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 21:56:58 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 21:56:58 INFO - Using env: {'DISPLAY': ':0', 21:56:58 INFO - 'HOME': '/home/cltbld', 21:56:58 INFO - 'LANG': 'en_US.UTF-8', 21:56:58 INFO - 'LANGUAGE': 'en_US:en', 21:56:58 INFO - 'LOGNAME': 'cltbld', 21:56:58 INFO - 'MAIL': '/var/mail/cltbld', 21:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:58 INFO - 'MOZ_NO_REMOTE': '1', 21:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:58 INFO - 'NO_EM_RESTART': '1', 21:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:58 INFO - 'SHELL': '/bin/bash', 21:56:58 INFO - 'SHLVL': '1', 21:56:58 INFO - 'TERM': 'linux', 21:56:58 INFO - 'TMOUT': '86400', 21:56:58 INFO - 'USER': 'cltbld', 21:56:58 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:58 INFO - '_': '/tools/buildbot/bin/python'} 21:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:58 INFO - Downloading/unpacking jsonschema 21:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:57:00 INFO - Downloading/unpacking functools32 (from jsonschema) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:00 INFO - Downloading functools32-3.2.3-2.tar.gz 21:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:57:00 INFO - warning: no files found matching '*.txt' 21:57:00 INFO - no previously-included directories found matching 'build' 21:57:00 INFO - no previously-included directories found matching 'dist' 21:57:00 INFO - no previously-included directories found matching '.git*' 21:57:00 INFO - Installing collected packages: jsonschema, functools32 21:57:00 INFO - Running setup.py install for functools32 21:57:00 INFO - warning: no files found matching '*.txt' 21:57:00 INFO - no previously-included directories found matching 'build' 21:57:00 INFO - no previously-included directories found matching 'dist' 21:57:00 INFO - no previously-included directories found matching '.git*' 21:57:00 INFO - Successfully installed jsonschema functools32 21:57:00 INFO - Cleaning up... 21:57:00 INFO - Return code: 0 21:57:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:57: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')]} 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffeb840df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26168d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, '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': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', '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:57: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', 'flake8'] in /builds/slave/test-pgo/build 21:57: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 flake8 21:57:00 INFO - Using env: {'DISPLAY': ':0', 21:57:00 INFO - 'HOME': '/home/cltbld', 21:57:00 INFO - 'LANG': 'en_US.UTF-8', 21:57:00 INFO - 'LANGUAGE': 'en_US:en', 21:57:00 INFO - 'LOGNAME': 'cltbld', 21:57:00 INFO - 'MAIL': '/var/mail/cltbld', 21:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:00 INFO - 'MOZ_NO_REMOTE': '1', 21:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:00 INFO - 'NO_EM_RESTART': '1', 21:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:00 INFO - 'SHELL': '/bin/bash', 21:57:00 INFO - 'SHLVL': '1', 21:57:00 INFO - 'TERM': 'linux', 21:57:00 INFO - 'TMOUT': '86400', 21:57:00 INFO - 'USER': 'cltbld', 21:57:00 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:00 INFO - '_': '/tools/buildbot/bin/python'} 21:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:00 INFO - Downloading/unpacking flake8 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:57:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:57:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:03 INFO - no previously-included directories found matching 'docs/_build' 21:57:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:57:03 INFO - Running setup.py install for pep8 21:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:03 INFO - no previously-included directories found matching 'docs/_build' 21:57:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:57:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:57:03 INFO - Cleaning up... 21:57:03 INFO - Return code: 0 21:57:03 INFO - Running post-action listener: _resource_record_post_action 21:57:03 INFO - Running post-action listener: _start_resource_monitoring 21:57:03 INFO - Starting resource monitoring. 21:57:03 INFO - ##### 21:57:03 INFO - ##### Running install step. 21:57:03 INFO - ##### 21:57:03 INFO - Running pre-action listener: _resource_record_pre_action 21:57:03 INFO - Running main action method: install 21:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:03 INFO - Reading from file tmpfile_stdout 21:57:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:03 INFO - Reading from file tmpfile_stdout 21:57:03 INFO - Output received: 21:57:03 INFO - Usage: mozinstall [options] installer 21:57:03 INFO - Options: 21:57:03 INFO - -h, --help show this help message and exit 21:57:03 INFO - -d DEST, --destination=DEST 21:57:03 INFO - Directory to install application into. [default: 21:57:03 INFO - "/builds/slave/test-pgo"] 21:57:03 INFO - --app=APP Application being installed. [default: firefox] 21:57:03 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:57:20 INFO - Reading from file tmpfile_stdout 21:57:20 INFO - Output received: 21:57:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:20 INFO - Running post-action listener: _resource_record_post_action 21:57:20 INFO - ##### 21:57:20 INFO - ##### Running run-tests step. 21:57:20 INFO - ##### 21:57:20 INFO - Running pre-action listener: _resource_record_pre_action 21:57:20 INFO - Running main action method: run_tests 21:57:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:20 INFO - Python 2.7.3 21:57:20 INFO - Return code: 0 21:57:20 INFO - grabbing minidump binary from tooltool 21:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:20 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 0x26a58b0>, '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 0x26a67b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a6c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:20 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 21:57:20 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 21:57:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:20 INFO - Return code: 0 21:57:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:57:21 INFO - Return code: 0 21:57:21 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/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 21:57:21 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/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 21:57:21 INFO - Using env: {'DISPLAY': ':0', 21:57:21 INFO - 'HOME': '/home/cltbld', 21:57:21 INFO - 'LANG': 'en_US.UTF-8', 21:57:21 INFO - 'LANGUAGE': 'en_US:en', 21:57:21 INFO - 'LOGNAME': 'cltbld', 21:57:21 INFO - 'MAIL': '/var/mail/cltbld', 21:57:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:21 INFO - 'MOZ_NO_REMOTE': '1', 21:57:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:21 INFO - 'NO_EM_RESTART': '1', 21:57:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:21 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:21 INFO - 'SHELL': '/bin/bash', 21:57:21 INFO - 'SHLVL': '1', 21:57:21 INFO - 'TERM': 'linux', 21:57:21 INFO - 'TMOUT': '86400', 21:57:21 INFO - 'USER': 'cltbld', 21:57:21 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256', 21:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:21 INFO - '_': '/tools/buildbot/bin/python'} 21:57:21 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/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 21:57:21 INFO - mozversion application_buildid: 20160403193250 21:57:21 INFO - mozversion application_changeset: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 21:57:21 INFO - mozversion application_display_name: Nightly 21:57:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:21 INFO - mozversion application_name: Firefox 21:57:21 INFO - mozversion application_remotingname: firefox 21:57:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:57:21 INFO - mozversion application_vendor: Mozilla 21:57:21 INFO - mozversion application_version: 48.0a1 21:57:21 INFO - mozversion platform_buildid: 20160403193250 21:57:21 INFO - mozversion platform_changeset: 600f96d25f8c94c73849dc98f0ad36769f9b57d3 21:57:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:57:21 INFO - mozversion platform_version: 48.0a1 21:57:21 INFO - using testdate: 1459745841 21:57:21 INFO - actual date: 1459745841 21:57:21 INFO - starting webserver on 'localhost:56904' 21:57:21 INFO - SUITE-START | Running 2 tests 21:57:21 INFO - TEST-START | dromaeo_css 21:57:21 INFO - operating with platform_type : linux_ 21:57:21 INFO - Initialising browser for dromaeo_css test... 21:57:21 INFO - TEST-INFO | started process 28622 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1hcH75/profile http://localhost:56904/getInfo.html) 21:57:25 INFO - PROCESS | 28622 | __metrics Screen width/height:1600/1200 21:57:25 INFO - PROCESS | 28622 | colorDepth:24 21:57:25 INFO - PROCESS | 28622 | Browser inner width/height: 1024/697 21:57:25 INFO - PROCESS | 28622 | __metrics 21:57:26 ERROR - PROCESS | 28622 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:57:27 INFO - TEST-INFO | 28622: exit 0 21:57:27 INFO - Browser initialized. 21:57:27 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:27 INFO - TEST-INFO | started process 28702 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1hcH75/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:39 INFO - PROCESS | 28702 | RSS: Main: 152748032 21:57:39 INFO - PROCESS | 28702 | 21:58:30 INFO - PROCESS | 28702 | 1459745910071 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:00:37 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56904/tests/dromaeo/cssquery-ext.html) 22:00:38 INFO - PROCESS | 28702 | RSS: Main: 257515520 22:00:38 INFO - PROCESS | 28702 | 22:03:40 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-ext.html (next: http://localhost:56904/tests/dromaeo/cssquery-jquery.html) 22:03:41 INFO - PROCESS | 28702 | RSS: Main: 233263104 22:03:41 INFO - PROCESS | 28702 | 22:06:43 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56904/tests/dromaeo/cssquery-mootools.html) 22:06:43 INFO - PROCESS | 28702 | RSS: Main: 226717696 22:06:43 INFO - PROCESS | 28702 | 22:09:45 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56904/tests/dromaeo/cssquery-prototype.html) 22:09:46 INFO - PROCESS | 28702 | RSS: Main: 216780800 22:09:46 INFO - PROCESS | 28702 | 22:12:48 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56904/tests/dromaeo/cssquery-yui.html) 22:12:49 INFO - PROCESS | 28702 | RSS: Main: 219934720 22:12:49 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | Cycle 1(1): loaded http://localhost:56904/tests/dromaeo/cssquery-yui.html (next: http://localhost:56904/tests/dromaeo/cssquery-dojo.html) 22:15:51 INFO - PROCESS | 28702 | RSS: Main: 245899264 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | __start_tp_report 22:15:51 INFO - PROCESS | 28702 | _x_x_mozilla_page_load 22:15:51 INFO - PROCESS | 28702 | _x_x_mozilla_page_load_details 22:15:51 INFO - PROCESS | 28702 | |i|pagename|runs| 22:15:51 INFO - PROCESS | 28702 | |0;dojo.html;3079.1070589529036;3144.2610986418204;3177.4439473092216;3179.9506162966222;3208.4064448077106;5035.345405097341;5219.982103489826;5226.817061402851;5230.084735171339;5263.289455923449;5279.392869819972;5287.312649355588;5295.549878260343;5314.9468505314935;5327.653702509344;4653.8371157009515;4690.765461726917;4794.9760251198695;4827.63792715546;4855.708657480563;4606;4800.687955282913;4809.975950120244;4838.298446725223;4840.273958906157;4652;4688.601468875149;4691.671582989192;4702.388689470381;4738.455077666078;4727.858164255043;4728.078024785168;4740.099381117611;4744.5492678195515;4770.642201834877;4560.019595786888;4695.506971767949;4708.176069187878;4713.952860471386;4769.403824521934;5052.191649336089;5060.797568097271;5072.51811077947;5074.594032477393;5112.642115051948;5451.073317536028;5451.400345961941;5456.399796022434;5469.097598896217;5502.669839809624;5345.786168553253;5526.088195447786;5627.240322556484;5718.714064296769;5726.971365143189;5250;5258.81594144207;5278.5513231375;5282.392524859613;5286.735663216824;5729.8567535811935;5770.682612456271;5771.711414429262;5774.566907481872;5800.709964501758;5336.306280183629;5525.475079867406;5566.916496252559;5611.719414029364;5618.943810561924;5570.164475328733;5598.300212473441;5604.327480702342;5610.943890561124;5613.578981576398;5337.786488540492;5541.6674999499355;5550.056490396642;5565.2486914266865;5573.710153145276;5536.501714845684;5569.913866796017;5573.275474188411;5580.804671836466;5614.438556144434;4169.2703776838935;4170.603792639695;4170.91658166835;4181.832726690898;4206.684498662613;3754.324221640131;3756.586775454698;3804.0489877530617;3815.5993620669983;3817.2365526894732;5269.5257426831;5284.497972692588;5303.310569626001;5329.147336426153;5346.304980352529;5592.636478628876;5600.691961942132;5622.493975542139;5622.493975542139;5638.43615638441;5142.331496905378;5280.313559237351;5308.9734551327765;5344.706041167696;5360.785568577291;4631.490536041033;4639.211334073216;4650.534946505322;4684.250519916797;4692.835750748775;5711.971440142773;5712.943105525491;5715.742791574389;5716.5998380113;5724.284464441945;5373.596980226421;5525.557955363481;5572.609917305912;5625.887482250414;5651.124075768263;5695.117256825199;5696.515796157208;5700.686462244616;5709.68596727184;5729.598928075162;5432.782688692408;5461.2627295316215;5462.098753705753;5469.42571030052;5473.480019398151;5481.068218402961;5579.553635709215;5598.776048957996;5630.23991761107;5661.858453538694;5481.068218402801;5495.890082198253;5497.202905578589;5498.037843377313;5499.477549632778;5452.836414907559;5474.425185355481;5476.67139971603;5485.177223416519;5531.115021596525;5154.716490593053;5330.866728331823;5377.059014672495;5385.40760516335;5418.268533747893;5492.368377636623;5504.587155963239;5528.806491772769;5529.585281104014;5532.944670553243;5223.582113430841;5385.569154467712;5409.1886217066185;5413.918791218213;5418.051840927743 22:15:51 INFO - PROCESS | 28702 | |1;ext.html;525.3039722367863;536.8711509237783;561.955043596512;570.0963972104216;602.8184757874566;29518.40963180735;29995.700042999564;29998;30015.399692006147;30016.54975175374;40029.799851000775;40077.39883901736;40645.18709625806;40654.7967260164;40672.186556268854;8674.089220631853;8860.556972151398;8864.556772161399;8883.067277935788;8890.377673562853;8026.357891368706;8688.956555217215;8822.382433229677;10442.477876106203;10732.087772539344;10406.531706073207;10491.527881245362;10507.789844203111;10509.26435149536;10515.73710657232;10387.792244155113;10525.578976840918;10531.368117912873;10535.26253162279;10543.894561054369;10273.12678422335;10397.220208484317;10424.113950314233;10429.113525350354;10433.530491127918;41962;42032;42349.57650423487;42408;42497.36253956193;3456.688897999167;3592.515010473605;3672.5225720656413;3980.641742243183;4136.751794892316;32180.83909580437;32668;32686.509702354484;32957;33185.170370740685;4299.527052024275;4342.283523218665;4369.847055353048;4371.34429835524;4385.166818304512;330767;331538;332027;332251;332341.99999999756;45968.3104753429;46503.76748116238;46538.06923861504;61011.38988610057;61467.07799383013;46201.537984619725;46386.536134638896;46603.30095048577;46659.533404666196;46904;14369.92815035939;14472;14474.565763026916;14480.203588802506;14481.78277325841;11365.374904380173;11375.146863985234;11424.314541127558;11436.599719009795;11438.656840294805;16260.918695406448;16366.345346186019;16425;16434;16442.34230630785;6060;6330.385751633304;6344.111824344595;6367.840803979845;6470.4823614110755;1041.7760181561;1098.697858089032;1105.8380865408108;1153.106342584487;1173.7535117625393;30749.8462507686;31032.53451198234;31437;31542.684573154434;31973.52039719406;1108.7394462301352;1117.9664610061711;1164.9009834164192;1176.100597534975;1225.7916154253799;15799.526014219591;16020;16393;16455.341786328652;16481.264929587338;395174;396689;399038;399842;401621;55626.16560751592;55872;56542.7172864133;56569;56668.14997775036;1279.942402591867;1366.41244264967;1374.780035194364;1392.324722509582;1404.3539971613172;28320.858395707888;28879.7112028877;29212.26969325784;29479;29731.851340743156;50484.242736359716;51206.231906522175;51295.48704512907;51554.74222628863;51721.672524735724;279266;285513;285814;286165;286257;40310.596894031856;40946.79526602348;43465.565344347415;44532.332015020445;48613;46031.53968460273;46088;46860.7656961713;46997.76501117473;47361.52638473571;39460.802695987484;39728.80135599419;40450.79774601226;40785;40957.590424095375;38545.421818673305;38917.80541097277;39117.41323880087;39442.802785985885;39914.80042599768;39706.602933971444;39981.60018399779;44327;44392;44804.55195448134;36899.81550092233;37607.62392376041;37644.81177594204;38276.6172338273;38550.2289954205;29063.44260251776;29504.262393439476;29539.409211816073;29874.402511949203;29899.252518687208 22:15:51 INFO - PROCESS | 28702 | |2;jquery.html;368;376.9283836071147;377.1514093290097;381.728972429575;384.76529317116564;17321.7401738974;18848;19069.809301906993;19439.805601943975;19450.70823937642;17972.820271797278;18112.184951677173;18214.635707285845;18576.907115464404;18591.721124183146;5402.243685883979;5512.669239845602;5552.500274975251;5605.831825045255;5615.9157612635845;4049.392591111342;5437.401885792579;5815.156802263669;6039.879202415949;6049.334573196945;5982.820515384546;5992.940070599304;6011.218541589609;6011.699415029253;6015.0676645120075;5924.674142922137;5985.88028239435;6027.578069535134;6128.846778830565;6135.723892424851;3744.5319335083113;5042.546170844605;5215.400228973679;5217.713025783581;5449.5640348772;20482.692759608617;20557.69163462549;20618.79381206184;22401.10395584191;22454.775452245594;2278.6809846621486;2462.56905041617;2527.5955847064565;2666.546687063204;3009.217603423104;13527.932360338134;13789;14058.367373468116;14065.156090634493;14323.928380358137;1902.876313039662;1948.2401863273335;1949.4638974282045;1969.517468220295;2009.2164056018164;70398;70566.15639552553;71996;73085.63457182734;73745;9908.603655853829;10145.594176233015;10189.133923616575;10434.321769084985;10449.582016719247;13804.03371763987;13830.723385532234;13856.713642249118;13872.791908121386;13941.651458713613;7521.05986751656;7594.31651151399;7713.807154821175;7774.378049756006;7795.688172473037;7449.515781474187;7471.290227428385;7538.773836784905;7548.396128309722;7560.130584982798;6168.259808822881;6199.225096862892;6251.3123556408755;6354.3010268870385;6374.426301632782;1689.6536210076904;1739.3042782886694;1749.4839022488397;1762.629847731965;1833.3308342455175;976.6132092428768;1006.0241565681424;1058.793535260632;1063.5905176507101;1065.3181963543338;17678.46964591064;18280.817191828177;18468.907655461637;18841.98528235503;19117.90441047786;1009.6365308488938;1025.7281820317621;1033.1115240892825;1058.8729352477599;1067.2475904487317;10363;10936.890631093745;10945.507452164671;10958.945205273923;10960.177986651033;434354;441394;471677;474260;478984;88050.55974720085;88306.55846720726;89079.55460222658;89563.55218223867;90912;1050.3225419604312;1062.1184416934082;1064.7870425914848;1067.9305845120043;1076.4832880217539;16805.327786888876;16887.408940687015;16892.473650353608;16944.49166524957;17087.487375378758;38572.22855542817;38949;39127.608723912395;39451.60548394594;39703.60296397115;54924;54963.45036549583;54967.45032549623;55021.174682380595;55078.44921550893;8578;8614.698485552975;8745.256653184551;8793.29653627721;8870.822583548423;10494.632687855888;12345.876541234831;13235.27206003679;13351.198928064347;13383.732325353243;10724.89275107239;11395.487203076047;11455.713607159887;11535.423228838357;11657.650270491898;10846;11040.447977601249;11051.005409513182;11167.218294719292;11268.3802390866;11462.4268786562;11629;11696.122790790894;11809.763804724029;11817.409129543317;8250.628721707417;8354.45696029756;8412.369072319478;8571.271441927505;8636.050034496075;10406.895931040593;11638;11801.52793888235;11826.34955077479;11871.287722736663 22:15:51 INFO - PROCESS | 28702 | |3;mootools.html;1378.4761790519601;1490.4187366926901;1496.3042185383795;1643.5480242933193;1802.1169626882831;7167.319104685053;7589.772306830797;7676.9232307676975;7699.846003079935;7701.730439434621;7501.1748707642255;7645.923540764591;7655.08139023318;7658.6553605087765;7675.692972281102;1945.785963544009;2144.1209104267255;2177.357679484548;2211.524522227721;2234.452559123017;2071.2439959414855;2077.802608752174;2078.282992367631;2079.08520251089;2089.2583132987797;2141.1886841422292;2205.228170140454;2221.3447033125185;2222.9888850555726;2227.2204728345114;2194.0565556810566;2233.475133343663;2234.0505285253867;2236.7204099487562;2238.608243557379;2187.289131032405;2199.7800219978035;2208.1608988584235;2211.1708109458955;2211.8672879627275;8149.877751833727;8209.671613135468;8231.917680823175;8237.258646721764;8245.299149572293;4943.8516844494725;5047.293378926953;5047.369078865142;5047.7476126193915;5056.974715126437;3262.13553408347;3262.8531716072835;3279.5736554248033;3311.6522765109557;3331.8833840815455;1098.3849044535086;1122.685648018556;1124.5670416889475;1139.481535901163;1143.5654451308533;11553.07575393975;11563.01714354281;11583.710407239801;11593.029185038564;11630.185886987914;4357.891052723644;4384.167008268419;4429.911401772011;4441.422615060022;4464.620507256855;9658.951705241428;9672.661456849117;9676.274279429072;9682.225421966366;9689.27330450219;4373.890652733643;5022.397312322471;5081.466446023188;5081.771320290596;5089.541941225308;4382.715123516961;4460.0633866887665;4460.30865215892;4489.842855500042;4493.146302202636;3689.1146124929824;3759.2105657812167;3772.4529943158636;3794.6015668354976;3797.1646237828186;1179.8289248058984;1195.7488927325185;1197.7963746163173;1197.9221350612183;1219.4451524556482;1402.6142810726928;1415.5894790510843;1433.8422773494908;1448.1383576771805;1462.6050966239056;7651.120121186023;7821.335186509096;7838.294553490213;7841.333486653584;7847.1368149503505;488.16280079663545;488.8142505847826;490.46784239100975;497.830737549235;510.9821156259513;5946.672932988728;5946.821595352147;5975.4024597540765;6003.849903752441;6004.219451471281;9248.630054797868;9729.659461918798;9797.853032204523;9817.509124543743;9818;9578.329516933747;9616.51917404127;9649.662261820942;9662.130408263149;9707.514624268759;7400.296971787671;7670.463067585216;7673.961630191813;7733.845323093619;7734.497257678233;7362.7423040193335;7465.925340746523;7468.365188958999;7489.737859174903;7491.127218195451;8704.303655707401;8777.868331974898;8892.911070889468;8929.330300227379;8968.192862642394;8840.071792461698;8998.550072496218;9005.594748236213;9030.729078127666;9153;6321.146645203023;6801.8639627206185;6973.093497845248;7237.131544214728;7332.853342933005;7467.253274672489;7519.473636845369;7523.247675232652;7531.698732050657;7560.773176804704;6663.8667226654225;6776.356246156607;6818.488613353919;6885.758998435031;6901;6556.803295901131;6580.407763301326;6707.061011458302;6779.220389655253;6792.796216113525;6950.4787140965645;6995.580265184105;7036.577805331696;7044.330788575077;7198.8920166198595;6657.900131498128;6702.36327548882;6709.228438729609;6713.597184168965;6721.294264102395;6662.766803161866;6753.831154221184;6763.763268285783;6767.695453704693;6771.3905748482875 22:15:51 INFO - PROCESS | 28702 | |4;prototype.html;337.20924432206476;339.4433129667346;340.2327750921671;344.962054174041;351.7326831607979;6061.515078793697;6083.817485475437;6087.4825639820665;6106.419890110444;6127.877442451148;6035.637861728299;6039.486643635296;6040.244969378828;6042.335343112265;6044.395560443953;4338.609525142737;4446.266366049598;4514.232580461329;4591.517890621487;4596.448426188854;4544.750038747868;4557.977210113945;4565;4578.793954272049;4579.771011449431;4518.344839998198;4519.4124763780665;4527.569880861313;4532.09358128374;4543.636509079282;4395.582419670142;4485.416895803557;4553.68124231304;4560.635149188057;4561.1789877821975;3987.760734355948;3997.3004724173443;4001.479807625019;4006.799660017017;4011.7392369496183;5828.388019258002;5840.707964601753;5841.153032810219;5842.094475356326;5846.941530584682;5366.275552800361;5369.570434365241;5374.059539580558;5377.919331210035;5381.139017757179;6382.904256436157;6419.3259707730485;6430.807075787734;6450.870982580369;6457.547971641987;4258.6380157686635;4381.38660587518;4394.846180383671;4398.824047038114;4523.389342438794;6581.80254592363;6654.767083152066;6675.132232809704;6677.499187560904;6697.464202863759;4496.797644106023;4506.909861802746;4509.34614480905;4510.503844577094;4513.413256276663;4551.362809206714;4557.886052848706;4559.065391594715;4560.794764235618;4564;5262.079136151235;5271.103912334912;5286.101362768339;5288.81489147878;5299.867503312448;6152.477039451607;6358.618482891041;6406.391392817675;6411;6414.967925160345;1634.8038235411589;1645.3254165792207;1654.2638525855878;1657.2211060801403;1661.1196066084995;1039.4127318065268;1059.2585190366774;1098.566066403766;1101.1411099342527;1118.5693507999479;5994.310654274727;5998.640081595118;6004.969975150184;6222.315545290015;6223.1287619733275;6653.933460665428;6654.633995130314;6660.067590537328;6675.632840193739;6681.198256209286;6239.750409983641;6251.343608921089;6256.311805701369;6258.655773932386;6264.342244064399;3550.2544465661986;3573.6956011055777;3582.46263060543;3587;3587.820608969541;6658.1344425224415;6894.931050689529;6922.273161317989;6934.375906168469;6944.340287672764;6789.5586786859685;6801.931980680229;6810.693518791666;6811.1145551079035;6815.522913396114;6901.275366086589;6906.965465172742;6919.481038922;6921.204061532888;6923.411510021705;6587.505937054644;6671;6672.366125218096;6674.098996635586;6674.365935236145;6413.807585772248;6469.77355792545;6544.640044797582;6547.083408322744;6547.836304092436;6849.1780986281965;6895.448364130958;6896.586204827727;6898.241193468614;6903.275156108536;4512.4133862597655;4543.091381723602;4548.272276435754;4555.180067587866;4557.658175636774;6666.633335166418;6667.033280174444;6678.565893216925;6681.732730690718;6682.799516014527;6410.423061924449;6498.707558159799;6530.575512591667;6554.934450655433;6558.639274839929;6420.357964203729;6452.12896258999;6456.7740129095255;6460.903086453801;6462.224533055875;6273.96863015682;6276.1213430118905;6283.8114856554375;6288.748450061947;6298.559100862895;6487.22153341602;6497.675116244263;6500.5449618526245;6510.0885875976455;6511;6065.8180254592435;6211.534134939807;6319.462845657987;6325.873482530232;6370.267419246846 22:15:51 INFO - PROCESS | 28702 | |5;yui.html;719.9784006479807;772.9768106956791;802.4783890471197;828.7762304177872;845.4082142500251;12834.614961551146;12964.222146671184;12970.027247956417;12985.155964862277;12989.025823063273;12379.25724456531;12645.62063138105;13286.468541258362;13368.064235503518;13412.46350145993;807.4468988742715;815.7144999250274;819.0130892274824;819.3117781063905;820.0159808230118;808.745245247748;809.4738420026971;810.4124509730427;810.7243537197352;813.1746277528314;852.5055467828645;852.846487632229;853.0573716043775;853.714005808055;857.6312185760121;850.8596081646521;851.6933903794629;851.974440766778;852.5311078906576;852.7313896122732;620.5439002333281;620.6400287833046;620.906863970408;621.201755743867;621.3196549777986;12404.193727407779;12418.937905310506;12428.56500022495;12445.813312800316;13521.256330901797;12274.324912129829;12363.814542781865;12433.502659893684;12448;12628.558000469939;10500.632477863239;10572.154227661846;10931.672049838518;10978.451077446096;11010.119190464744;3689.501917241165;3739.738218324718;3766.5103536540073;3773.0944573302486;3831.885043448673;46923.53076469226;48848;50130;50910.490895090945;51098.7445062776;9982.850257246148;10020.949895250476;10139.7465063374;10338.586456541654;10403.167746580406;17693.646127077387;17752.20115094824;17753.289868405118;17888.731669024975;17963.371282005068;7746.728864489828;7780.92219077802;8206.753797386087;8228.62971166299;8332.958335208285;4471.754053527087;4548.658850586219;4549.363089167519;4562.657800664963;4616.399868017136;3227.2254658881698;3314.9005529834144;3325.085601459618;3325.9667403325657;3326.168457885529;633.4235845380681;637.4645297949744;647.1037612906065;650.6844180572418;651.7295322441133;599.6102533353268;676.3067855448205;712.4442934511089;741.7255615422329;772.907251129868;8617.267532259702;8813.294936405073;8895.24390426808;9077.818443631091;9112.179903808557;619.5786864931799;643.1380357409546;716.8387112899555;734.0933946575974;746.488655271141;4258.403823464718;4302.698811083194;4443.200223959654;4492.460904691458;4497.550244975476;59998.70000650056;61191.69404152951;61318.38681613216;62918;63041;52678.473215268124;53206.73396632992;53831.73084134554;54256;54836.45163548393;42668.359974600404;48661.75669121632;48829.5117048832;51549.7422512885;54656.90686186254;9275.118863707938;9283.35016548862;9341.439513629204;9892.543113438871;10022;33242.66757332395;35279.294414111064;38068.42897356486;38516.80741596274;39562.80218598888;49750;49839.50160498494;50164.749176253885;50370.207426146466;51211.2318315233;12096.274223546616;12185.573504927284;12233.755324893631;12427.254364737782;12437.37813109359;12750.171238869443;12903;12978.286194259406;13025.153365031243;13166.210027398387;12371.505139794668;12463.189892656948;12501.874981250072;12943.352832358532;13242;12930.935345323212;13018.739625207632;13227.80158297607;13497.86502134966;13713.520026799015;12445.751084978068;12502.87497125017;12854;13031.283279419724;13133.343332833128;10741.89258107409;10829.620963266249;10842.891571084503;11182.161337899528;11485.19603627738;10516.351461767008;10586.523606437882;10757.677269681923;10820.18848586375;10832.133429325477 22:15:51 INFO - PROCESS | 28702 | __end_tp_report 22:15:51 INFO - PROCESS | 28702 | __start_cc_report 22:15:51 INFO - PROCESS | 28702 | _x_x_mozilla_cycle_collect,812 22:15:51 INFO - PROCESS | 28702 | __end_cc_report 22:15:51 INFO - PROCESS | 28702 | __startTimestamp1459746951883__endTimestamp 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | ------- Summary: start ------- 22:15:51 INFO - PROCESS | 28702 | Number of tests: 6 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#0] dojo.html Cycles:165 Average:5174.99 Median:5377.06 stddev:582.50 (10.8%) stddev-sans-first:560.60 22:15:51 INFO - PROCESS | 28702 | Values: 3079.1 3144.3 3177.4 3180.0 3208.4 5035.3 5220.0 5226.8 5230.1 5263.3 5279.4 5287.3 5295.5 5314.9 5327.7 4653.8 4690.8 4795.0 4827.6 4855.7 4606.0 4800.7 4810.0 4838.3 4840.3 4652.0 4688.6 4691.7 4702.4 4738.5 4727.9 4728.1 4740.1 4744.5 4770.6 4560.0 4695.5 4708.2 4714.0 4769.4 5052.2 5060.8 5072.5 5074.6 5112.6 5451.1 5451.4 5456.4 5469.1 5502.7 5345.8 5526.1 5627.2 5718.7 5727.0 5250.0 5258.8 5278.6 5282.4 5286.7 5729.9 5770.7 5771.7 5774.6 5800.7 5336.3 5525.5 5566.9 5611.7 5618.9 5570.2 5598.3 5604.3 5610.9 5613.6 5337.8 5541.7 5550.1 5565.2 5573.7 5536.5 5569.9 5573.3 5580.8 5614.4 4169.3 4170.6 4170.9 4181.8 4206.7 3754.3 3756.6 3804.0 3815.6 3817.2 5269.5 5284.5 5303.3 5329.1 5346.3 5592.6 5600.7 5622.5 5622.5 5638.4 5142.3 5280.3 5309.0 5344.7 5360.8 4631.5 4639.2 4650.5 4684.3 4692.8 5712.0 5712.9 5715.7 5716.6 5724.3 5373.6 5525.6 5572.6 5625.9 5651.1 5695.1 5696.5 5700.7 5709.7 5729.6 5432.8 5461.3 5462.1 5469.4 5473.5 5481.1 5579.6 5598.8 5630.2 5661.9 5481.1 5495.9 5497.2 5498.0 5499.5 5452.8 5474.4 5476.7 5485.2 5531.1 5154.7 5330.9 5377.1 5385.4 5418.3 5492.4 5504.6 5528.8 5529.6 5532.9 5223.6 5385.6 5409.2 5413.9 5418.1 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#1] ext.html Cycles:180 Average:50927.51 Median:37253.72 stddev:89580.36 (240.5%) stddev-sans-first:89751.72 22:15:51 INFO - PROCESS | 28702 | Values: 525.3 536.9 562.0 570.1 602.8 29518.4 29995.7 29998.0 30015.4 30016.5 40029.8 40077.4 40645.2 40654.8 40672.2 8674.1 8860.6 8864.6 8883.1 8890.4 8026.4 8689.0 8822.4 10442.5 10732.1 10406.5 10491.5 10507.8 10509.3 10515.7 10387.8 10525.6 10531.4 10535.3 10543.9 10273.1 10397.2 10424.1 10429.1 10433.5 41962.0 42032.0 42349.6 42408.0 42497.4 3456.7 3592.5 3672.5 3980.6 4136.8 32180.8 32668.0 32686.5 32957.0 33185.2 4299.5 4342.3 4369.8 4371.3 4385.2 330767.0 331538.0 332027.0 332251.0 332342.0 45968.3 46503.8 46538.1 61011.4 61467.1 46201.5 46386.5 46603.3 46659.5 46904.0 14369.9 14472.0 14474.6 14480.2 14481.8 11365.4 11375.1 11424.3 11436.6 11438.7 16260.9 16366.3 16425.0 16434.0 16442.3 6060.0 6330.4 6344.1 6367.8 6470.5 1041.8 1098.7 1105.8 1153.1 1173.8 30749.8 31032.5 31437.0 31542.7 31973.5 1108.7 1118.0 1164.9 1176.1 1225.8 15799.5 16020.0 16393.0 16455.3 16481.3 395174.0 396689.0 399038.0 399842.0 401621.0 55626.2 55872.0 56542.7 56569.0 56668.1 1279.9 1366.4 1374.8 1392.3 1404.4 28320.9 28879.7 29212.3 29479.0 29731.9 50484.2 51206.2 51295.5 51554.7 51721.7 279266.0 285513.0 285814.0 286165.0 286257.0 40310.6 40946.8 43465.6 44532.3 48613.0 46031.5 46088.0 46860.8 46997.8 47361.5 39460.8 39728.8 40450.8 40785.0 40957.6 38545.4 38917.8 39117.4 39442.8 39914.8 39706.6 39981.6 44327.0 44392.0 44804.6 36899.8 37607.6 37644.8 38276.6 38550.2 29063.4 29504.3 29539.4 29874.4 29899.3 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#2] jquery.html Cycles:180 Average:27576.14 Median:21509.95 stddev:75841.47 (352.6%) stddev-sans-first:76026.71 22:15:51 INFO - PROCESS | 28702 | Values: 368.0 376.9 377.2 381.7 384.8 17321.7 18848.0 19069.8 19439.8 19450.7 17972.8 18112.2 18214.6 18576.9 18591.7 5402.2 5512.7 5552.5 5605.8 5615.9 4049.4 5437.4 5815.2 6039.9 6049.3 5982.8 5992.9 6011.2 6011.7 6015.1 5924.7 5985.9 6027.6 6128.8 6135.7 3744.5 5042.5 5215.4 5217.7 5449.6 20482.7 20557.7 20618.8 22401.1 22454.8 2278.7 2462.6 2527.6 2666.5 3009.2 13527.9 13789.0 14058.4 14065.2 14323.9 1902.9 1948.2 1949.5 1969.5 2009.2 70398.0 70566.2 71996.0 73085.6 73745.0 9908.6 10145.6 10189.1 10434.3 10449.6 13804.0 13830.7 13856.7 13872.8 13941.7 7521.1 7594.3 7713.8 7774.4 7795.7 7449.5 7471.3 7538.8 7548.4 7560.1 6168.3 6199.2 6251.3 6354.3 6374.4 1689.7 1739.3 1749.5 1762.6 1833.3 976.6 1006.0 1058.8 1063.6 1065.3 17678.5 18280.8 18468.9 18842.0 19117.9 1009.6 1025.7 1033.1 1058.9 1067.2 10363.0 10936.9 10945.5 10958.9 10960.2 434354.0 441394.0 471677.0 474260.0 478984.0 88050.6 88306.6 89079.6 89563.6 90912.0 1050.3 1062.1 1064.8 1067.9 1076.5 16805.3 16887.4 16892.5 16944.5 17087.5 38572.2 38949.0 39127.6 39451.6 39703.6 54924.0 54963.5 54967.5 55021.2 55078.4 8578.0 8614.7 8745.3 8793.3 8870.8 10494.6 12345.9 13235.3 13351.2 13383.7 10724.9 11395.5 11455.7 11535.4 11657.7 10846.0 11040.4 11051.0 11167.2 11268.4 11462.4 11629.0 11696.1 11809.8 11817.4 8250.6 8354.5 8412.4 8571.3 8636.1 10406.9 11638.0 11801.5 11826.3 11871.3 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#3] mootools.html Cycles:180 Average:5603.28 Median:6438.97 stddev:2981.72 (46.3%) stddev-sans-first:2973.18 22:15:51 INFO - PROCESS | 28702 | Values: 1378.5 1490.4 1496.3 1643.5 1802.1 7167.3 7589.8 7676.9 7699.8 7701.7 7501.2 7645.9 7655.1 7658.7 7675.7 1945.8 2144.1 2177.4 2211.5 2234.5 2071.2 2077.8 2078.3 2079.1 2089.3 2141.2 2205.2 2221.3 2223.0 2227.2 2194.1 2233.5 2234.1 2236.7 2238.6 2187.3 2199.8 2208.2 2211.2 2211.9 8149.9 8209.7 8231.9 8237.3 8245.3 4943.9 5047.3 5047.4 5047.7 5057.0 3262.1 3262.9 3279.6 3311.7 3331.9 1098.4 1122.7 1124.6 1139.5 1143.6 11553.1 11563.0 11583.7 11593.0 11630.2 4357.9 4384.2 4429.9 4441.4 4464.6 9659.0 9672.7 9676.3 9682.2 9689.3 4373.9 5022.4 5081.5 5081.8 5089.5 4382.7 4460.1 4460.3 4489.8 4493.1 3689.1 3759.2 3772.5 3794.6 3797.2 1179.8 1195.7 1197.8 1197.9 1219.4 1402.6 1415.6 1433.8 1448.1 1462.6 7651.1 7821.3 7838.3 7841.3 7847.1 488.2 488.8 490.5 497.8 511.0 5946.7 5946.8 5975.4 6003.8 6004.2 9248.6 9729.7 9797.9 9817.5 9818.0 9578.3 9616.5 9649.7 9662.1 9707.5 7400.3 7670.5 7674.0 7733.8 7734.5 7362.7 7465.9 7468.4 7489.7 7491.1 8704.3 8777.9 8892.9 8929.3 8968.2 8840.1 8998.6 9005.6 9030.7 9153.0 6321.1 6801.9 6973.1 7237.1 7332.9 7467.3 7519.5 7523.2 7531.7 7560.8 6663.9 6776.4 6818.5 6885.8 6901.0 6556.8 6580.4 6707.1 6779.2 6792.8 6950.5 6995.6 7036.6 7044.3 7198.9 6657.9 6702.4 6709.2 6713.6 6721.3 6662.8 6753.8 6763.8 6767.7 6771.4 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#4] prototype.html Cycles:180 Average:5365.24 Median:6085.65 stddev:1633.17 (26.8%) stddev-sans-first:1593.55 22:15:51 INFO - PROCESS | 28702 | Values: 337.2 339.4 340.2 345.0 351.7 6061.5 6083.8 6087.5 6106.4 6127.9 6035.6 6039.5 6040.2 6042.3 6044.4 4338.6 4446.3 4514.2 4591.5 4596.4 4544.8 4558.0 4565.0 4578.8 4579.8 4518.3 4519.4 4527.6 4532.1 4543.6 4395.6 4485.4 4553.7 4560.6 4561.2 3987.8 3997.3 4001.5 4006.8 4011.7 5828.4 5840.7 5841.2 5842.1 5846.9 5366.3 5369.6 5374.1 5377.9 5381.1 6382.9 6419.3 6430.8 6450.9 6457.5 4258.6 4381.4 4394.8 4398.8 4523.4 6581.8 6654.8 6675.1 6677.5 6697.5 4496.8 4506.9 4509.3 4510.5 4513.4 4551.4 4557.9 4559.1 4560.8 4564.0 5262.1 5271.1 5286.1 5288.8 5299.9 6152.5 6358.6 6406.4 6411.0 6415.0 1634.8 1645.3 1654.3 1657.2 1661.1 1039.4 1059.3 1098.6 1101.1 1118.6 5994.3 5998.6 6005.0 6222.3 6223.1 6653.9 6654.6 6660.1 6675.6 6681.2 6239.8 6251.3 6256.3 6258.7 6264.3 3550.3 3573.7 3582.5 3587.0 3587.8 6658.1 6894.9 6922.3 6934.4 6944.3 6789.6 6801.9 6810.7 6811.1 6815.5 6901.3 6907.0 6919.5 6921.2 6923.4 6587.5 6671.0 6672.4 6674.1 6674.4 6413.8 6469.8 6544.6 6547.1 6547.8 6849.2 6895.4 6896.6 6898.2 6903.3 4512.4 4543.1 4548.3 4555.2 4557.7 6666.6 6667.0 6678.6 6681.7 6682.8 6410.4 6498.7 6530.6 6554.9 6558.6 6420.4 6452.1 6456.8 6460.9 6462.2 6274.0 6276.1 6283.8 6288.7 6298.6 6487.2 6497.7 6500.5 6510.1 6511.0 6065.8 6211.5 6319.5 6325.9 6370.3 22:15:51 INFO - PROCESS | 28702 | 22:15:51 INFO - PROCESS | 28702 | [#5] yui.html Cycles:180 Average:14622.10 Median:4495.01 stddev:17006.59 (378.3%) stddev-sans-first:17022.25 22:15:51 INFO - PROCESS | 28702 | Values: 720.0 773.0 802.5 828.8 845.4 12834.6 12964.2 12970.0 12985.2 12989.0 12379.3 12645.6 13286.5 13368.1 13412.5 807.4 815.7 819.0 819.3 820.0 808.7 809.5 810.4 810.7 813.2 852.5 852.8 853.1 853.7 857.6 850.9 851.7 852.0 852.5 852.7 620.5 620.6 620.9 621.2 621.3 12404.2 12418.9 12428.6 12445.8 13521.3 12274.3 12363.8 12433.5 12448.0 12628.6 10500.6 10572.2 10931.7 10978.5 11010.1 3689.5 3739.7 3766.5 3773.1 3831.9 46923.5 48848.0 50130.0 50910.5 51098.7 9982.9 10020.9 10139.7 10338.6 10403.2 17693.6 17752.2 17753.3 17888.7 17963.4 7746.7 7780.9 8206.8 8228.6 8333.0 4471.8 4548.7 4549.4 4562.7 4616.4 3227.2 3314.9 3325.1 3326.0 3326.2 633.4 637.5 647.1 650.7 651.7 599.6 676.3 712.4 741.7 772.9 8617.3 8813.3 8895.2 9077.8 9112.2 619.6 643.1 716.8 734.1 746.5 4258.4 4302.7 4443.2 4492.5 4497.6 59998.7 61191.7 61318.4 62918.0 63041.0 52678.5 53206.7 53831.7 54256.0 54836.5 42668.4 48661.8 48829.5 51549.7 54656.9 9275.1 9283.4 9341.4 9892.5 10022.0 33242.7 35279.3 38068.4 38516.8 39562.8 49750.0 49839.5 50164.7 50370.2 51211.2 12096.3 12185.6 12233.8 12427.3 12437.4 12750.2 12903.0 12978.3 13025.2 13166.2 12371.5 12463.2 12501.9 12943.4 13242.0 12930.9 13018.7 13227.8 13497.9 13713.5 12445.8 12502.9 12854.0 13031.3 13133.3 10741.9 10829.6 10842.9 11182.2 11485.2 10516.4 10586.5 10757.7 10820.2 10832.1 22:15:51 INFO - PROCESS | 28702 | -------- Summary: end -------- 22:15:51 INFO - PROCESS | 28702 | 22:15:52 INFO - TEST-INFO | 28702: exit 0 22:15:52 INFO - TEST-OK | dromaeo_css | took 1110995ms 22:15:52 INFO - TEST-START | kraken 22:15:52 INFO - operating with platform_type : linux_ 22:15:52 INFO - Initialising browser for kraken test... 22:15:52 INFO - TEST-INFO | started process 28887 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpspZI5V/profile http://localhost:56904/getInfo.html) 22:15:56 INFO - PROCESS | 28887 | __metrics Screen width/height:1600/1200 22:15:56 INFO - PROCESS | 28887 | colorDepth:24 22:15:56 INFO - PROCESS | 28887 | Browser inner width/height: 1024/697 22:15:56 INFO - PROCESS | 28887 | __metrics 22:15:57 ERROR - PROCESS | 28887 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:15:58 INFO - TEST-INFO | 28887: exit 0 22:15:58 INFO - Browser initialized. 22:15:58 INFO - Running cycle 1/1 for kraken test... 22:15:58 INFO - TEST-INFO | started process 28969 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpspZI5V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:09 INFO - PROCESS | 28969 | RSS: Main: 152883200 22:16:09 INFO - PROCESS | 28969 | 22:16:12 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56904/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:12 INFO - PROCESS | 28969 | RSS: Main: 194641920 22:16:12 INFO - PROCESS | 28969 | 22:16:15 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56904/tests/kraken/driver.html?testName=audio-dft) 22:16:16 INFO - PROCESS | 28969 | RSS: Main: 184393728 22:16:16 INFO - PROCESS | 28969 | 22:16:19 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56904/tests/kraken/driver.html?testName=audio-fft) 22:16:19 INFO - PROCESS | 28969 | RSS: Main: 168275968 22:16:19 INFO - PROCESS | 28969 | 22:16:21 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56904/tests/kraken/driver.html?testName=audio-oscillator) 22:16:22 INFO - PROCESS | 28969 | RSS: Main: 170303488 22:16:22 INFO - PROCESS | 28969 | 22:16:24 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:25 INFO - PROCESS | 28969 | RSS: Main: 172306432 22:16:25 INFO - PROCESS | 28969 | 22:16:28 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56904/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:28 INFO - PROCESS | 28969 | RSS: Main: 172474368 22:16:28 INFO - PROCESS | 28969 | 22:16:32 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56904/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:32 INFO - PROCESS | 28969 | RSS: Main: 172507136 22:16:32 INFO - PROCESS | 28969 | 22:16:35 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56904/tests/kraken/driver.html?testName=json-parse-financial) 22:16:36 INFO - PROCESS | 28969 | RSS: Main: 173744128 22:16:36 INFO - PROCESS | 28969 | 22:16:37 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:38 INFO - PROCESS | 28969 | RSS: Main: 182833152 22:16:38 INFO - PROCESS | 28969 | 22:16:39 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:40 INFO - PROCESS | 28969 | RSS: Main: 180609024 22:16:40 INFO - PROCESS | 28969 | 22:16:42 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:43 INFO - PROCESS | 28969 | RSS: Main: 192565248 22:16:43 INFO - PROCESS | 28969 | 22:16:45 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:45 INFO - PROCESS | 28969 | RSS: Main: 200261632 22:16:45 INFO - PROCESS | 28969 | 22:16:48 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:49 INFO - PROCESS | 28969 | RSS: Main: 200429568 22:16:49 INFO - PROCESS | 28969 | 22:16:50 INFO - PROCESS | 28969 | Cycle 1(1): loaded http://localhost:56904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56904/tests/kraken/driver.html?testName=ai-astar) 22:16:50 INFO - PROCESS | 28969 | RSS: Main: 262217728 22:16:50 INFO - PROCESS | 28969 | 22:16:50 INFO - PROCESS | 28969 | __start_tp_report 22:16:50 INFO - PROCESS | 28969 | _x_x_mozilla_page_load 22:16:50 INFO - PROCESS | 28969 | _x_x_mozilla_page_load_details 22:16:50 INFO - PROCESS | 28969 | |i|pagename|runs| 22:16:50 INFO - PROCESS | 28969 | |0;ai-astar;110;111;104;109;111;111;97;108;107;108 22:16:50 INFO - PROCESS | 28969 | |1;audio-beat-detection;155;127;152;167;126;164;149;132;187;132 22:16:50 INFO - PROCESS | 28969 | |2;audio-dft;163;161;165;161;161;164;162;166;162;161 22:16:50 INFO - PROCESS | 28969 | |3;audio-fft;73;76;99;95;73;72;75;116;101;73 22:16:50 INFO - PROCESS | 28969 | |4;audio-oscillator;93;93;154;93;93;93;146;93;91;148 22:16:50 INFO - PROCESS | 28969 | |5;imaging-gaussian-blur;117;117;117;117;117;116;116;116;117;117 22:16:50 INFO - PROCESS | 28969 | |6;imaging-darkroom;146;145;146;146;145;145;145;145;146;146 22:16:50 INFO - PROCESS | 28969 | |7;imaging-desaturate;96;95;96;95;95;95;95;96;95;96 22:16:51 INFO - PROCESS | 28969 | |8;json-parse-financial;58;57;58;59;58;56;59;66;56;55 22:16:51 INFO - PROCESS | 28969 | |9;json-stringify-tinderbox;60;63;61;61;62;62;61;61;61;61 22:16:51 INFO - PROCESS | 28969 | |10;stanford-crypto-aes;77;87;77;78;78;78;77;79;78;78 22:16:51 INFO - PROCESS | 28969 | |11;stanford-crypto-ccm;114;112;113;116;111;113;110;115;109;111 22:16:51 INFO - PROCESS | 28969 | |12;stanford-crypto-pbkdf2;143;164;146;154;137;145;145;155;152;144 22:16:51 INFO - PROCESS | 28969 | |13;stanford-crypto-sha256-iterative;65;62;65;63;67;63;64;62;62;62 22:16:51 INFO - PROCESS | 28969 | __end_tp_report 22:16:51 INFO - PROCESS | 28969 | __start_cc_report 22:16:51 INFO - PROCESS | 28969 | _x_x_mozilla_cycle_collect,1080 22:16:51 INFO - PROCESS | 28969 | __end_cc_report 22:16:51 INFO - PROCESS | 28969 | __startTimestamp1459747010995__endTimestamp 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | ------- Summary: start ------- 22:16:51 INFO - PROCESS | 28969 | Number of tests: 14 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#0] ai-astar Cycles:10 Average:107.60 Median:110.50 stddev:4.33 (3.9%) stddev-sans-first:4.50 22:16:51 INFO - PROCESS | 28969 | Values: 110.0 111.0 104.0 109.0 111.0 111.0 97.0 108.0 107.0 108.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.50 stddev:20.08 (13.1%) stddev-sans-first:21.18 22:16:51 INFO - PROCESS | 28969 | Values: 155.0 127.0 152.0 167.0 126.0 164.0 149.0 132.0 187.0 132.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 22:16:51 INFO - PROCESS | 28969 | Values: 163.0 161.0 165.0 161.0 161.0 164.0 162.0 166.0 162.0 161.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#3] audio-fft Cycles:10 Average:85.30 Median:74.00 stddev:15.97 (21.6%) stddev-sans-first:16.30 22:16:51 INFO - PROCESS | 28969 | Values: 73.0 76.0 99.0 95.0 73.0 72.0 75.0 116.0 101.0 73.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.00 stddev:27.43 (29.5%) stddev-sans-first:28.42 22:16:51 INFO - PROCESS | 28969 | Values: 93.0 93.0 154.0 93.0 93.0 93.0 146.0 93.0 91.0 148.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:16:51 INFO - PROCESS | 28969 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:16:51 INFO - PROCESS | 28969 | Values: 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:16:51 INFO - PROCESS | 28969 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:3.05 (5.3%) stddev-sans-first:3.23 22:16:51 INFO - PROCESS | 28969 | Values: 58.0 57.0 58.0 59.0 58.0 56.0 59.0 66.0 56.0 55.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 22:16:51 INFO - PROCESS | 28969 | Values: 60.0 63.0 61.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.98 (3.8%) stddev-sans-first:3.10 22:16:51 INFO - PROCESS | 28969 | Values: 77.0 87.0 77.0 78.0 78.0 78.0 77.0 79.0 78.0 78.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:113.00 stddev:2.22 (2.0%) stddev-sans-first:2.28 22:16:51 INFO - PROCESS | 28969 | Values: 114.0 112.0 113.0 116.0 111.0 113.0 110.0 115.0 109.0 111.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:149.00 stddev:7.74 (5.2%) stddev-sans-first:7.94 22:16:51 INFO - PROCESS | 28969 | Values: 143.0 164.0 146.0 154.0 137.0 145.0 145.0 155.0 152.0 144.0 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - PROCESS | 28969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.72 (2.7%) stddev-sans-first:1.73 22:16:51 INFO - PROCESS | 28969 | Values: 65.0 62.0 65.0 63.0 67.0 63.0 64.0 62.0 62.0 62.0 22:16:51 INFO - PROCESS | 28969 | -------- Summary: end -------- 22:16:51 INFO - PROCESS | 28969 | 22:16:51 INFO - TEST-INFO | 28969: exit 0 22:16:51 INFO - TEST-OK | kraken | took 59241ms 22:16:51 INFO - SUITE-END | took 1170s 22:16:52 INFO - Completed test suite (00:19:30) 22:16:52 INFO - javascript benchmark 22:16:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3079.1070589529036, 3144.2610986418204, 3177.4439473092216, 3179.9506162966222, 3208.4064448077106, 5035.345405097341, 5219.982103489826, 5226.817061402851, 5230.084735171339, 5263.289455923449, 5279.392869819972, 5287.312649355588, 5295.549878260343, 5314.9468505314935, 5327.653702509344, 4653.8371157009515, 4690.765461726917, 4794.9760251198695, 4827.63792715546, 4855.708657480563, 4606.0, 4800.687955282913, 4809.975950120244, 4838.298446725223, 4840.273958906157, 4652.0, 4688.601468875149, 4691.671582989192, 4702.388689470381, 4738.455077666078, 4727.858164255043, 4728.078024785168, 4740.099381117611, 4744.5492678195515, 4770.642201834877, 4560.019595786888, 4695.506971767949, 4708.176069187878, 4713.952860471386, 4769.403824521934, 5052.191649336089, 5060.797568097271, 5072.51811077947, 5074.594032477393, 5112.642115051948, 5451.073317536028, 5451.400345961941, 5456.399796022434, 5469.097598896217, 5502.669839809624, 5345.786168553253, 5526.088195447786, 5627.240322556484, 5718.714064296769, 5726.971365143189, 5250.0, 5258.81594144207, 5278.5513231375, 5282.392524859613, 5286.735663216824, 5729.8567535811935, 5770.682612456271, 5771.711414429262, 5774.566907481872, 5800.709964501758, 5336.306280183629, 5525.475079867406, 5566.916496252559, 5611.719414029364, 5618.943810561924, 5570.164475328733, 5598.300212473441, 5604.327480702342, 5610.943890561124, 5613.578981576398, 5337.786488540492, 5541.6674999499355, 5550.056490396642, 5565.2486914266865, 5573.710153145276, 5536.501714845684, 5569.913866796017, 5573.275474188411, 5580.804671836466, 5614.438556144434, 4169.2703776838935, 4170.603792639695, 4170.91658166835, 4181.832726690898, 4206.684498662613, 3754.324221640131, 3756.586775454698, 3804.0489877530617, 3815.5993620669983, 3817.2365526894732, 5269.5257426831, 5284.497972692588, 5303.310569626001, 5329.147336426153, 5346.304980352529, 5592.636478628876, 5600.691961942132, 5622.493975542139, 5622.493975542139, 5638.43615638441, 5142.331496905378, 5280.313559237351, 5308.9734551327765, 5344.706041167696, 5360.785568577291, 4631.490536041033, 4639.211334073216, 4650.534946505322, 4684.250519916797, 4692.835750748775, 5711.971440142773, 5712.943105525491, 5715.742791574389, 5716.5998380113, 5724.284464441945, 5373.596980226421, 5525.557955363481, 5572.609917305912, 5625.887482250414, 5651.124075768263, 5695.117256825199, 5696.515796157208, 5700.686462244616, 5709.68596727184, 5729.598928075162, 5432.782688692408, 5461.2627295316215, 5462.098753705753, 5469.42571030052, 5473.480019398151, 5481.068218402961, 5579.553635709215, 5598.776048957996, 5630.23991761107, 5661.858453538694, 5481.068218402801, 5495.890082198253, 5497.202905578589, 5498.037843377313, 5499.477549632778, 5452.836414907559, 5474.425185355481, 5476.67139971603, 5485.177223416519, 5531.115021596525, 5154.716490593053, 5330.866728331823, 5377.059014672495, 5385.40760516335, 5418.268533747893, 5492.368377636623, 5504.587155963239, 5528.806491772769, 5529.585281104014, 5532.944670553243, 5223.582113430841, 5385.569154467712, 5409.1886217066185, 5413.918791218213, 5418.051840927743], "unit": "score", "name": "dojo.html", "value": 5136.938251751494}, {"lowerIsBetter": false, "replicates": [525.3039722367863, 536.8711509237783, 561.955043596512, 570.0963972104216, 602.8184757874566, 29518.40963180735, 29995.700042999564, 29998.0, 30015.399692006147, 30016.54975175374, 40029.799851000775, 40077.39883901736, 40645.18709625806, 40654.7967260164, 40672.186556268854, 8674.089220631853, 8860.556972151398, 8864.556772161399, 8883.067277935788, 8890.377673562853, 8026.357891368706, 8688.956555217215, 8822.382433229677, 10442.477876106203, 10732.087772539344, 10406.531706073207, 10491.527881245362, 10507.789844203111, 10509.26435149536, 10515.73710657232, 10387.792244155113, 10525.578976840918, 10531.368117912873, 10535.26253162279, 10543.894561054369, 10273.12678422335, 10397.220208484317, 10424.113950314233, 10429.113525350354, 10433.530491127918, 41962.0, 42032.0, 42349.57650423487, 42408.0, 42497.36253956193, 3456.688897999167, 3592.515010473605, 3672.5225720656413, 3980.641742243183, 4136.751794892316, 32180.83909580437, 32668.0, 32686.509702354484, 32957.0, 33185.170370740685, 4299.527052024275, 4342.283523218665, 4369.847055353048, 4371.34429835524, 4385.166818304512, 330767.0, 331538.0, 332027.0, 332251.0, 332341.99999999756, 45968.3104753429, 46503.76748116238, 46538.06923861504, 61011.38988610057, 61467.07799383013, 46201.537984619725, 46386.536134638896, 46603.30095048577, 46659.533404666196, 46904.0, 14369.92815035939, 14472.0, 14474.565763026916, 14480.203588802506, 14481.78277325841, 11365.374904380173, 11375.146863985234, 11424.314541127558, 11436.599719009795, 11438.656840294805, 16260.918695406448, 16366.345346186019, 16425.0, 16434.0, 16442.34230630785, 6060.0, 6330.385751633304, 6344.111824344595, 6367.840803979845, 6470.4823614110755, 1041.7760181561, 1098.697858089032, 1105.8380865408108, 1153.106342584487, 1173.7535117625393, 30749.8462507686, 31032.53451198234, 31437.0, 31542.684573154434, 31973.52039719406, 1108.7394462301352, 1117.9664610061711, 1164.9009834164192, 1176.100597534975, 1225.7916154253799, 15799.526014219591, 16020.0, 16393.0, 16455.341786328652, 16481.264929587338, 395174.0, 396689.0, 399038.0, 399842.0, 401621.0, 55626.16560751592, 55872.0, 56542.7172864133, 56569.0, 56668.14997775036, 1279.942402591867, 1366.41244264967, 1374.780035194364, 1392.324722509582, 1404.3539971613172, 28320.858395707888, 28879.7112028877, 29212.26969325784, 29479.0, 29731.851340743156, 50484.242736359716, 51206.231906522175, 51295.48704512907, 51554.74222628863, 51721.672524735724, 279266.0, 285513.0, 285814.0, 286165.0, 286257.0, 40310.596894031856, 40946.79526602348, 43465.565344347415, 44532.332015020445, 48613.0, 46031.53968460273, 46088.0, 46860.7656961713, 46997.76501117473, 47361.52638473571, 39460.802695987484, 39728.80135599419, 40450.79774601226, 40785.0, 40957.590424095375, 38545.421818673305, 38917.80541097277, 39117.41323880087, 39442.802785985885, 39914.80042599768, 39706.602933971444, 39981.60018399779, 44327.0, 44392.0, 44804.55195448134, 36899.81550092233, 37607.62392376041, 37644.81177594204, 38276.6172338273, 38550.2289954205, 29063.44260251776, 29504.262393439476, 29539.409211816073, 29874.402511949203, 29899.252518687208], "unit": "score", "name": "ext.html", "value": 19471.19211564568}, {"lowerIsBetter": false, "replicates": [368.0, 376.9283836071147, 377.1514093290097, 381.728972429575, 384.76529317116564, 17321.7401738974, 18848.0, 19069.809301906993, 19439.805601943975, 19450.70823937642, 17972.820271797278, 18112.184951677173, 18214.635707285845, 18576.907115464404, 18591.721124183146, 5402.243685883979, 5512.669239845602, 5552.500274975251, 5605.831825045255, 5615.9157612635845, 4049.392591111342, 5437.401885792579, 5815.156802263669, 6039.879202415949, 6049.334573196945, 5982.820515384546, 5992.940070599304, 6011.218541589609, 6011.699415029253, 6015.0676645120075, 5924.674142922137, 5985.88028239435, 6027.578069535134, 6128.846778830565, 6135.723892424851, 3744.5319335083113, 5042.546170844605, 5215.400228973679, 5217.713025783581, 5449.5640348772, 20482.692759608617, 20557.69163462549, 20618.79381206184, 22401.10395584191, 22454.775452245594, 2278.6809846621486, 2462.56905041617, 2527.5955847064565, 2666.546687063204, 3009.217603423104, 13527.932360338134, 13789.0, 14058.367373468116, 14065.156090634493, 14323.928380358137, 1902.876313039662, 1948.2401863273335, 1949.4638974282045, 1969.517468220295, 2009.2164056018164, 70398.0, 70566.15639552553, 71996.0, 73085.63457182734, 73745.0, 9908.603655853829, 10145.594176233015, 10189.133923616575, 10434.321769084985, 10449.582016719247, 13804.03371763987, 13830.723385532234, 13856.713642249118, 13872.791908121386, 13941.651458713613, 7521.05986751656, 7594.31651151399, 7713.807154821175, 7774.378049756006, 7795.688172473037, 7449.515781474187, 7471.290227428385, 7538.773836784905, 7548.396128309722, 7560.130584982798, 6168.259808822881, 6199.225096862892, 6251.3123556408755, 6354.3010268870385, 6374.426301632782, 1689.6536210076904, 1739.3042782886694, 1749.4839022488397, 1762.629847731965, 1833.3308342455175, 976.6132092428768, 1006.0241565681424, 1058.793535260632, 1063.5905176507101, 1065.3181963543338, 17678.46964591064, 18280.817191828177, 18468.907655461637, 18841.98528235503, 19117.90441047786, 1009.6365308488938, 1025.7281820317621, 1033.1115240892825, 1058.8729352477599, 1067.2475904487317, 10363.0, 10936.890631093745, 10945.507452164671, 10958.945205273923, 10960.177986651033, 434354.0, 441394.0, 471677.0, 474260.0, 478984.0, 88050.55974720085, 88306.55846720726, 89079.55460222658, 89563.55218223867, 90912.0, 1050.3225419604312, 1062.1184416934082, 1064.7870425914848, 1067.9305845120043, 1076.4832880217539, 16805.327786888876, 16887.408940687015, 16892.473650353608, 16944.49166524957, 17087.487375378758, 38572.22855542817, 38949.0, 39127.608723912395, 39451.60548394594, 39703.60296397115, 54924.0, 54963.45036549583, 54967.45032549623, 55021.174682380595, 55078.44921550893, 8578.0, 8614.698485552975, 8745.256653184551, 8793.29653627721, 8870.822583548423, 10494.632687855888, 12345.876541234831, 13235.27206003679, 13351.198928064347, 13383.732325353243, 10724.89275107239, 11395.487203076047, 11455.713607159887, 11535.423228838357, 11657.650270491898, 10846.0, 11040.447977601249, 11051.005409513182, 11167.218294719292, 11268.3802390866, 11462.4268786562, 11629.0, 11696.122790790894, 11809.763804724029, 11817.409129543317, 8250.628721707417, 8354.45696029756, 8412.369072319478, 8571.271441927505, 8636.050034496075, 10406.895931040593, 11638.0, 11801.52793888235, 11826.34955077479, 11871.287722736663], "unit": "score", "name": "jquery.html", "value": 9125.212259856959}, {"lowerIsBetter": false, "replicates": [1378.4761790519601, 1490.4187366926901, 1496.3042185383795, 1643.5480242933193, 1802.1169626882831, 7167.319104685053, 7589.772306830797, 7676.9232307676975, 7699.846003079935, 7701.730439434621, 7501.1748707642255, 7645.923540764591, 7655.08139023318, 7658.6553605087765, 7675.692972281102, 1945.785963544009, 2144.1209104267255, 2177.357679484548, 2211.524522227721, 2234.452559123017, 2071.2439959414855, 2077.802608752174, 2078.282992367631, 2079.08520251089, 2089.2583132987797, 2141.1886841422292, 2205.228170140454, 2221.3447033125185, 2222.9888850555726, 2227.2204728345114, 2194.0565556810566, 2233.475133343663, 2234.0505285253867, 2236.7204099487562, 2238.608243557379, 2187.289131032405, 2199.7800219978035, 2208.1608988584235, 2211.1708109458955, 2211.8672879627275, 8149.877751833727, 8209.671613135468, 8231.917680823175, 8237.258646721764, 8245.299149572293, 4943.8516844494725, 5047.293378926953, 5047.369078865142, 5047.7476126193915, 5056.974715126437, 3262.13553408347, 3262.8531716072835, 3279.5736554248033, 3311.6522765109557, 3331.8833840815455, 1098.3849044535086, 1122.685648018556, 1124.5670416889475, 1139.481535901163, 1143.5654451308533, 11553.07575393975, 11563.01714354281, 11583.710407239801, 11593.029185038564, 11630.185886987914, 4357.891052723644, 4384.167008268419, 4429.911401772011, 4441.422615060022, 4464.620507256855, 9658.951705241428, 9672.661456849117, 9676.274279429072, 9682.225421966366, 9689.27330450219, 4373.890652733643, 5022.397312322471, 5081.466446023188, 5081.771320290596, 5089.541941225308, 4382.715123516961, 4460.0633866887665, 4460.30865215892, 4489.842855500042, 4493.146302202636, 3689.1146124929824, 3759.2105657812167, 3772.4529943158636, 3794.6015668354976, 3797.1646237828186, 1179.8289248058984, 1195.7488927325185, 1197.7963746163173, 1197.9221350612183, 1219.4451524556482, 1402.6142810726928, 1415.5894790510843, 1433.8422773494908, 1448.1383576771805, 1462.6050966239056, 7651.120121186023, 7821.335186509096, 7838.294553490213, 7841.333486653584, 7847.1368149503505, 488.16280079663545, 488.8142505847826, 490.46784239100975, 497.830737549235, 510.9821156259513, 5946.672932988728, 5946.821595352147, 5975.4024597540765, 6003.849903752441, 6004.219451471281, 9248.630054797868, 9729.659461918798, 9797.853032204523, 9817.509124543743, 9818.0, 9578.329516933747, 9616.51917404127, 9649.662261820942, 9662.130408263149, 9707.514624268759, 7400.296971787671, 7670.463067585216, 7673.961630191813, 7733.845323093619, 7734.497257678233, 7362.7423040193335, 7465.925340746523, 7468.365188958999, 7489.737859174903, 7491.127218195451, 8704.303655707401, 8777.868331974898, 8892.911070889468, 8929.330300227379, 8968.192862642394, 8840.071792461698, 8998.550072496218, 9005.594748236213, 9030.729078127666, 9153.0, 6321.146645203023, 6801.8639627206185, 6973.093497845248, 7237.131544214728, 7332.853342933005, 7467.253274672489, 7519.473636845369, 7523.247675232652, 7531.698732050657, 7560.773176804704, 6663.8667226654225, 6776.356246156607, 6818.488613353919, 6885.758998435031, 6901.0, 6556.803295901131, 6580.407763301326, 6707.061011458302, 6779.220389655253, 6792.796216113525, 6950.4787140965645, 6995.580265184105, 7036.577805331696, 7044.330788575077, 7198.8920166198595, 6657.900131498128, 6702.36327548882, 6709.228438729609, 6713.597184168965, 6721.294264102395, 6662.766803161866, 6753.831154221184, 6763.763268285783, 6767.695453704693, 6771.3905748482875], "unit": "score", "name": "mootools.html", "value": 4506.913124631971}, {"lowerIsBetter": false, "replicates": [337.20924432206476, 339.4433129667346, 340.2327750921671, 344.962054174041, 351.7326831607979, 6061.515078793697, 6083.817485475437, 6087.4825639820665, 6106.419890110444, 6127.877442451148, 6035.637861728299, 6039.486643635296, 6040.244969378828, 6042.335343112265, 6044.395560443953, 4338.609525142737, 4446.266366049598, 4514.232580461329, 4591.517890621487, 4596.448426188854, 4544.750038747868, 4557.977210113945, 4565.0, 4578.793954272049, 4579.771011449431, 4518.344839998198, 4519.4124763780665, 4527.569880861313, 4532.09358128374, 4543.636509079282, 4395.582419670142, 4485.416895803557, 4553.68124231304, 4560.635149188057, 4561.1789877821975, 3987.760734355948, 3997.3004724173443, 4001.479807625019, 4006.799660017017, 4011.7392369496183, 5828.388019258002, 5840.707964601753, 5841.153032810219, 5842.094475356326, 5846.941530584682, 5366.275552800361, 5369.570434365241, 5374.059539580558, 5377.919331210035, 5381.139017757179, 6382.904256436157, 6419.3259707730485, 6430.807075787734, 6450.870982580369, 6457.547971641987, 4258.6380157686635, 4381.38660587518, 4394.846180383671, 4398.824047038114, 4523.389342438794, 6581.80254592363, 6654.767083152066, 6675.132232809704, 6677.499187560904, 6697.464202863759, 4496.797644106023, 4506.909861802746, 4509.34614480905, 4510.503844577094, 4513.413256276663, 4551.362809206714, 4557.886052848706, 4559.065391594715, 4560.794764235618, 4564.0, 5262.079136151235, 5271.103912334912, 5286.101362768339, 5288.81489147878, 5299.867503312448, 6152.477039451607, 6358.618482891041, 6406.391392817675, 6411.0, 6414.967925160345, 1634.8038235411589, 1645.3254165792207, 1654.2638525855878, 1657.2211060801403, 1661.1196066084995, 1039.4127318065268, 1059.2585190366774, 1098.566066403766, 1101.1411099342527, 1118.5693507999479, 5994.310654274727, 5998.640081595118, 6004.969975150184, 6222.315545290015, 6223.1287619733275, 6653.933460665428, 6654.633995130314, 6660.067590537328, 6675.632840193739, 6681.198256209286, 6239.750409983641, 6251.343608921089, 6256.311805701369, 6258.655773932386, 6264.342244064399, 3550.2544465661986, 3573.6956011055777, 3582.46263060543, 3587.0, 3587.820608969541, 6658.1344425224415, 6894.931050689529, 6922.273161317989, 6934.375906168469, 6944.340287672764, 6789.5586786859685, 6801.931980680229, 6810.693518791666, 6811.1145551079035, 6815.522913396114, 6901.275366086589, 6906.965465172742, 6919.481038922, 6921.204061532888, 6923.411510021705, 6587.505937054644, 6671.0, 6672.366125218096, 6674.098996635586, 6674.365935236145, 6413.807585772248, 6469.77355792545, 6544.640044797582, 6547.083408322744, 6547.836304092436, 6849.1780986281965, 6895.448364130958, 6896.586204827727, 6898.241193468614, 6903.275156108536, 4512.4133862597655, 4543.091381723602, 4548.272276435754, 4555.180067587866, 4557.658175636774, 6666.633335166418, 6667.033280174444, 6678.565893216925, 6681.732730690718, 6682.799516014527, 6410.423061924449, 6498.707558159799, 6530.575512591667, 6554.934450655433, 6558.639274839929, 6420.357964203729, 6452.12896258999, 6456.7740129095255, 6460.903086453801, 6462.224533055875, 6273.96863015682, 6276.1213430118905, 6283.8114856554375, 6288.748450061947, 6298.559100862895, 6487.22153341602, 6497.675116244263, 6500.5449618526245, 6510.0885875976455, 6511.0, 6065.8180254592435, 6211.534134939807, 6319.462845657987, 6325.873482530232, 6370.267419246846], "unit": "score", "name": "prototype.html", "value": 4836.517769166329}, {"lowerIsBetter": false, "replicates": [719.9784006479807, 772.9768106956791, 802.4783890471197, 828.7762304177872, 845.4082142500251, 12834.614961551146, 12964.222146671184, 12970.027247956417, 12985.155964862277, 12989.025823063273, 12379.25724456531, 12645.62063138105, 13286.468541258362, 13368.064235503518, 13412.46350145993, 807.4468988742715, 815.7144999250274, 819.0130892274824, 819.3117781063905, 820.0159808230118, 808.745245247748, 809.4738420026971, 810.4124509730427, 810.7243537197352, 813.1746277528314, 852.5055467828645, 852.846487632229, 853.0573716043775, 853.714005808055, 857.6312185760121, 850.8596081646521, 851.6933903794629, 851.974440766778, 852.5311078906576, 852.7313896122732, 620.5439002333281, 620.6400287833046, 620.906863970408, 621.201755743867, 621.3196549777986, 12404.193727407779, 12418.937905310506, 12428.56500022495, 12445.813312800316, 13521.256330901797, 12274.324912129829, 12363.814542781865, 12433.502659893684, 12448.0, 12628.558000469939, 10500.632477863239, 10572.154227661846, 10931.672049838518, 10978.451077446096, 11010.119190464744, 3689.501917241165, 3739.738218324718, 3766.5103536540073, 3773.0944573302486, 3831.885043448673, 46923.53076469226, 48848.0, 50130.0, 50910.490895090945, 51098.7445062776, 9982.850257246148, 10020.949895250476, 10139.7465063374, 10338.586456541654, 10403.167746580406, 17693.646127077387, 17752.20115094824, 17753.289868405118, 17888.731669024975, 17963.371282005068, 7746.728864489828, 7780.92219077802, 8206.753797386087, 8228.62971166299, 8332.958335208285, 4471.754053527087, 4548.658850586219, 4549.363089167519, 4562.657800664963, 4616.399868017136, 3227.2254658881698, 3314.9005529834144, 3325.085601459618, 3325.9667403325657, 3326.168457885529, 633.4235845380681, 637.4645297949744, 647.1037612906065, 650.6844180572418, 651.7295322441133, 599.6102533353268, 676.3067855448205, 712.4442934511089, 741.7255615422329, 772.907251129868, 8617.267532259702, 8813.294936405073, 8895.24390426808, 9077.818443631091, 9112.179903808557, 619.5786864931799, 643.1380357409546, 716.8387112899555, 734.0933946575974, 746.488655271141, 4258.403823464718, 4302.698811083194, 4443.200223959654, 4492.460904691458, 4497.550244975476, 59998.70000650056, 61191.69404152951, 61318.38681613216, 62918.0, 63041.0, 52678.473215268124, 53206.73396632992, 53831.73084134554, 54256.0, 54836.45163548393, 42668.359974600404, 48661.75669121632, 48829.5117048832, 51549.7422512885, 54656.90686186254, 9275.118863707938, 9283.35016548862, 9341.439513629204, 9892.543113438871, 10022.0, 33242.66757332395, 35279.294414111064, 38068.42897356486, 38516.80741596274, 39562.80218598888, 49750.0, 49839.50160498494, 50164.749176253885, 50370.207426146466, 51211.2318315233, 12096.274223546616, 12185.573504927284, 12233.755324893631, 12427.254364737782, 12437.37813109359, 12750.171238869443, 12903.0, 12978.286194259406, 13025.153365031243, 13166.210027398387, 12371.505139794668, 12463.189892656948, 12501.874981250072, 12943.352832358532, 13242.0, 12930.935345323212, 13018.739625207632, 13227.80158297607, 13497.86502134966, 13713.520026799015, 12445.751084978068, 12502.87497125017, 12854.0, 13031.283279419724, 13133.343332833128, 10741.89258107409, 10829.620963266249, 10842.891571084503, 11182.161337899528, 11485.19603627738, 10516.351461767008, 10586.523606437882, 10757.677269681923, 10820.18848586375, 10832.133429325477], "unit": "score", "name": "yui.html", "value": 6643.107910418318}], "name": "dromaeo_css", "value": 7137.191257327459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 109.0, 111.0, 111.0, 97.0, 108.0, 107.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 152.0, 167.0, 126.0, 164.0, 149.0, 132.0, 187.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 165.0, 161.0, 161.0, 164.0, 162.0, 166.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 99.0, 95.0, 73.0, 72.0, 75.0, 116.0, 101.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 154.0, 93.0, 93.0, 93.0, 146.0, 93.0, 91.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 59.0, 58.0, 56.0, 59.0, 66.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.3}, {"lowerIsBetter": true, "replicates": [77.0, 87.0, 77.0, 78.0, 78.0, 78.0, 77.0, 79.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [114.0, 112.0, 113.0, 116.0, 111.0, 113.0, 110.0, 115.0, 109.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.4}, {"lowerIsBetter": true, "replicates": [143.0, 164.0, 146.0, 154.0, 137.0, 145.0, 145.0, 155.0, 152.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 65.0, 63.0, 67.0, 63.0, 64.0, 62.0, 62.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1494.5}]} 22:16:52 INFO - Return code: 0 22:16:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:52 ERROR - # TBPL SUCCESS # 22:16:52 INFO - Running post-action listener: _resource_record_post_action 22:16:52 INFO - Running post-run listener: _resource_record_post_run 22:16:53 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 20480; Write bytes: 530874368; Read time: 224; Write time: 424760 22:16:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 243195904; Read time: 72; Write time: 203288 22:16:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 287678464; Read time: 152; Write time: 221472 22:16:53 INFO - Running post-run listener: _upload_blobber_files 22:16:53 INFO - Blob upload gear active. 22:16:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:16:53 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:16:53 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:16:53 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:16:53 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:54 INFO - (blobuploader) - INFO - Done attempting. 22:16:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:56 INFO - (blobuploader) - INFO - Done attempting. 22:16:56 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:56 INFO - Return code: 0 22:16:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:16:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/681787c3e6478293af120ab345fd0036188b919205316058e466d0152407a4baaecc16476d0bb197c462eb5b8d08d5eae99b5aa230512ee12deec5b2a22ecd65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c28e3450c84a3229318965fb14c01203ab2448f8b20524923f5c57ad20a7b99b0174c02965ae70f24458d15da971bcce2549fe12b5242cf5581ad80cf48c70fe"} 22:16:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:16:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:16:56 INFO - Contents: 22:16:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/681787c3e6478293af120ab345fd0036188b919205316058e466d0152407a4baaecc16476d0bb197c462eb5b8d08d5eae99b5aa230512ee12deec5b2a22ecd65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c28e3450c84a3229318965fb14c01203ab2448f8b20524923f5c57ad20a7b99b0174c02965ae70f24458d15da971bcce2549fe12b5242cf5581ad80cf48c70fe"} 22:16:56 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:56 INFO - Copying logs to upload dir... 22:16:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:16:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.087909 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-04-03 22:16:56.054531) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:56.058760) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 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/681787c3e6478293af120ab345fd0036188b919205316058e466d0152407a4baaecc16476d0bb197c462eb5b8d08d5eae99b5aa230512ee12deec5b2a22ecd65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c28e3450c84a3229318965fb14c01203ab2448f8b20524923f5c57ad20a7b99b0174c02965ae70f24458d15da971bcce2549fe12b5242cf5581ad80cf48c70fe"} build_url:https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/Qf2_9Of9SAWVRXDDsZy78w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/681787c3e6478293af120ab345fd0036188b919205316058e466d0152407a4baaecc16476d0bb197c462eb5b8d08d5eae99b5aa230512ee12deec5b2a22ecd65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c28e3450c84a3229318965fb14c01203ab2448f8b20524923f5c57ad20a7b99b0174c02965ae70f24458d15da971bcce2549fe12b5242cf5581ad80cf48c70fe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:56.083845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:56.084248) ========= 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=7cf709767345e0a0c5a90e72000001d4-1459741178.980115-438891256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-03 22:16:56.168232) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:16:56.168560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-03 22:16:56.168874) ========= ========= Total master_lag: 0.44 =========