builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1459097471.33 results: success (0) buildid: 20160327073347 builduid: 99d868292d574f158922eb177b1db53d revision: 0996ba84787e3d49289545527b84740066f9805f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.326902) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.327248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.327518) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.391934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.392208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.458383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.458637) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.509942) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.510201) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.510516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.510832) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-27 09:51:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 96.7M=0s 2016-03-27 09:51:13 (96.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164964 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.689147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.689413) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015524 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.737838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:11.738127) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0996ba84787e3d49289545527b84740066f9805f --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 0996ba84787e3d49289545527b84740066f9805f --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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-27 09:51:13,840 truncating revision to first 12 chars 2016-03-27 09:51:13,840 Setting DEBUG logging. 2016-03-27 09:51:13,840 attempt 1/10 2016-03-27 09:51:13,840 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0996ba84787e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-27 09:51:14,299 unpacking tar archive at: mozilla-inbound-0996ba84787e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.776093 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:12.526407) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:12.526707) ========= echo 0996ba84787e3d49289545527b84740066f9805f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0996ba84787e3d49289545527b84740066f9805f'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0996ba84787e3d49289545527b84740066f9805f program finished with exit code 0 elapsedTime=0.004787 script_repo_revision: '0996ba84787e3d49289545527b84740066f9805f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:12.577229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:12.577503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 09:51:12.587254) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-27 09:51:12.587510) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:51:14 INFO - MultiFileLogger online at 20160327 09:51:14 in /builds/slave/test-pgo 09:51:14 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 09:51:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:51:14 INFO - {'append_to_log': False, 09:51:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:51:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:51:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:51:14 INFO - 'branch': 'Mozilla-Inbound', 09:51:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:51:14 INFO - 'config_files': ('talos/linux_config.py',), 09:51:14 INFO - 'default_actions': ('clobber', 09:51:14 INFO - 'read-buildbot-config', 09:51:14 INFO - 'download-and-extract', 09:51:14 INFO - 'populate-webroot', 09:51:14 INFO - 'create-virtualenv', 09:51:14 INFO - 'install', 09:51:14 INFO - 'run-tests'), 09:51:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:51:14 INFO - 'download_minidump_stackwalk': True, 09:51:14 INFO - 'download_symbols': 'ondemand', 09:51:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:51:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:51:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:51:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:51:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:51:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:51:14 INFO - 'installer_path': 'installer.exe', 09:51:14 INFO - 'log_level': 'info', 09:51:14 INFO - 'log_name': 'talos', 09:51:14 INFO - 'log_to_console': True, 09:51:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:51:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:51:14 INFO - 'opt_config_files': (), 09:51:14 INFO - 'pip_index': False, 09:51:14 INFO - 'sps_profile': False, 09:51:14 INFO - 'sps_profile_interval': 0, 09:51:14 INFO - 'suite': 'dromaeojs', 09:51:14 INFO - 'system_bits': '32', 09:51:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:51:14 INFO - 'title': 'talos-linux64-ix-051', 09:51:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:51:14 INFO - 'use_talos_json': True, 09:51:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:51:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:51:14 INFO - 'work_dir': 'build'} 09:51:14 INFO - ##### 09:51:14 INFO - ##### Running clobber step. 09:51:14 INFO - ##### 09:51:14 INFO - Running pre-action listener: _resource_record_pre_action 09:51:14 INFO - Running main action method: clobber 09:51:14 INFO - rmtree: /builds/slave/test-pgo/build 09:51:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:51:15 INFO - Running post-action listener: _resource_record_post_action 09:51:15 INFO - ##### 09:51:15 INFO - ##### Running read-buildbot-config step. 09:51:15 INFO - ##### 09:51:15 INFO - Running pre-action listener: _resource_record_pre_action 09:51:15 INFO - Running main action method: read_buildbot_config 09:51:15 INFO - Using buildbot properties: 09:51:15 INFO - { 09:51:15 INFO - "project": "", 09:51:15 INFO - "product": "firefox", 09:51:15 INFO - "script_repo_revision": "production", 09:51:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:51:15 INFO - "repository": "", 09:51:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:51:15 INFO - "buildid": "20160327073347", 09:51:15 INFO - "pgo_build": "True", 09:51:15 INFO - "basedir": "/builds/slave/test-pgo", 09:51:15 INFO - "buildnumber": 1645, 09:51:15 INFO - "slavename": "talos-linux64-ix-051", 09:51:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:51:15 INFO - "platform": "ubuntu64_hw", 09:51:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:51:15 INFO - "branch": "mozilla-inbound", 09:51:15 INFO - "repo_path": "integration/mozilla-inbound", 09:51:15 INFO - "revision": "0996ba84787e3d49289545527b84740066f9805f", 09:51:15 INFO - "stage_platform": "linux64-pgo", 09:51:15 INFO - "builduid": "99d868292d574f158922eb177b1db53d", 09:51:15 INFO - "slavebuilddir": "test" 09:51:15 INFO - } 09:51:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:51:15 INFO - Running post-action listener: _resource_record_post_action 09:51:15 INFO - ##### 09:51:15 INFO - ##### Running download-and-extract step. 09:51:15 INFO - ##### 09:51:15 INFO - Running pre-action listener: _resource_record_pre_action 09:51:15 INFO - Running main action method: download_and_extract 09:51:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:15 INFO - https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:51:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:51:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:51:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:24 INFO - Downloaded 1361 bytes. 09:51:24 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:51:24 INFO - Using the following test package requirements: 09:51:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:51:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:51:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'jsshell-linux-x86_64.zip'], 09:51:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:51:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:51:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:51:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:51:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:51:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:51:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:51:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:30 INFO - Downloaded 23655789 bytes. 09:51:30 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'] 09:51:30 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 09:51:31 INFO - Return code: 0 09:51:31 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 09:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:31 INFO - https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:51:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:51:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:51:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:34 INFO - Downloaded 23655789 bytes. 09:51:34 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'] 09:51:34 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 09:51:36 INFO - Return code: 0 09:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:36 INFO - https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:37 INFO - Downloaded 10847531 bytes. 09:51: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'] 09:51: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 09:51:37 INFO - Return code: 0 09:51: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')]} 09:51:37 INFO - https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GrHXw0meTaSoAziTFDRmCA/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 09:51:38 INFO - Downloaded 57797122 bytes. 09:51:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:51:38 INFO - mkdir: /builds/slave/test-pgo/properties 09:51:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:51:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:51:38 INFO - Contents: 09:51:38 INFO - build_url:https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:51:39 INFO - Running post-action listener: _resource_record_post_action 09:51:39 INFO - Running post-action listener: set_extra_try_arguments 09:51:39 INFO - ##### 09:51:39 INFO - ##### Running populate-webroot step. 09:51:39 INFO - ##### 09:51:39 INFO - Running pre-action listener: _resource_record_pre_action 09:51:39 INFO - Running main action method: populate_webroot 09:51:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:51:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:51:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:51:39 INFO - '--tppagecycles', 09:51:39 INFO - '7'], 09:51:39 INFO - 'tests': ['tsvgm']}}, 09:51:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:51:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:51:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:51:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:51:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:51:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'tests': ['damp', 'tps']}, 09:51:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['damp', 'tps']}, 09:51:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:51:39 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['dromaeo_dom']}, 09:51:39 INFO - 'other': {'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'other_l64': {'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'other_nol64': {'tests': ['a11yr', 09:51:39 INFO - 'ts_paint', 09:51:39 INFO - 'tpaint', 09:51:39 INFO - 'sessionrestore', 09:51:39 INFO - 'sessionrestore_no_auto_restore', 09:51:39 INFO - 'tabpaint']}, 09:51:39 INFO - 'svgr': {'tests': ['tsvgx', 09:51:39 INFO - 'tsvgr_opacity', 09:51:39 INFO - 'tart', 09:51:39 INFO - 'tscrollx', 09:51:39 INFO - 'cart']}, 09:51:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['tsvgx', 09:51:39 INFO - 'tsvgr_opacity', 09:51:39 INFO - 'tart', 09:51:39 INFO - 'tscrollx', 09:51:39 INFO - 'cart']}, 09:51:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'tests': ['tp5o']}, 09:51:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'talos_options': ['--e10s'], 09:51:39 INFO - 'tests': ['tp5o']}, 09:51:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'talos_options': ['--xperf_path', 09:51:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:39 INFO - 'tests': ['tp5n']}, 09:51:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:51:39 INFO - 'talos_options': ['--e10s', 09:51:39 INFO - '--xperf_path', 09:51:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:51:39 INFO - 'tests': ['tp5n']}}, 09:51:39 INFO - 'talos.zip': {'path': '', 09:51:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:51:39 INFO - Running post-action listener: _resource_record_post_action 09:51:39 INFO - ##### 09:51:39 INFO - ##### Running create-virtualenv step. 09:51:39 INFO - ##### 09:51:39 INFO - Running pre-action listener: _resource_record_pre_action 09:51:39 INFO - Running main action method: create_virtualenv 09:51:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:51: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 09:51:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:51:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:51:40 INFO - Using real prefix '/usr' 09:51:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:51:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:42 INFO - Installing pip.................done. 09:51:42 INFO - Return code: 0 09:51:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:42 INFO - Using env: {'DISPLAY': ':0', 09:51:42 INFO - 'HOME': '/home/cltbld', 09:51:42 INFO - 'LANG': 'en_US.UTF-8', 09:51:42 INFO - 'LANGUAGE': 'en_US:en', 09:51:42 INFO - 'LOGNAME': 'cltbld', 09:51:42 INFO - 'MAIL': '/var/mail/cltbld', 09:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:42 INFO - 'MOZ_NO_REMOTE': '1', 09:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:42 INFO - 'NO_EM_RESTART': '1', 09:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:42 INFO - 'SHELL': '/bin/bash', 09:51:42 INFO - 'SHLVL': '1', 09:51:42 INFO - 'TERM': 'linux', 09:51:42 INFO - 'TMOUT': '86400', 09:51:42 INFO - 'USER': 'cltbld', 09:51:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:42 INFO - '_': '/tools/buildbot/bin/python'} 09:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51: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 09:51:42 INFO - Cleaning up... 09:51:42 INFO - Return code: 0 09:51:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:42 INFO - Using env: {'DISPLAY': ':0', 09:51:42 INFO - 'HOME': '/home/cltbld', 09:51:42 INFO - 'LANG': 'en_US.UTF-8', 09:51:42 INFO - 'LANGUAGE': 'en_US:en', 09:51:42 INFO - 'LOGNAME': 'cltbld', 09:51:42 INFO - 'MAIL': '/var/mail/cltbld', 09:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:42 INFO - 'MOZ_NO_REMOTE': '1', 09:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:42 INFO - 'NO_EM_RESTART': '1', 09:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:42 INFO - 'SHELL': '/bin/bash', 09:51:42 INFO - 'SHLVL': '1', 09:51:42 INFO - 'TERM': 'linux', 09:51:42 INFO - 'TMOUT': '86400', 09:51:42 INFO - 'USER': 'cltbld', 09:51:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:42 INFO - '_': '/tools/buildbot/bin/python'} 09:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:42 INFO - Downloading/unpacking psutil>=0.7.1 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:44 INFO - Installing collected packages: psutil 09:51:44 INFO - Running setup.py install for psutil 09:51:44 INFO - building 'psutil._psutil_linux' extension 09:51: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 09:51:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:51:45 INFO - building 'psutil._psutil_posix' extension 09:51:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:51:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:51:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:45 INFO - Successfully installed psutil 09:51:45 INFO - Cleaning up... 09:51:45 INFO - Return code: 0 09:51:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:45 INFO - Using env: {'DISPLAY': ':0', 09:51:45 INFO - 'HOME': '/home/cltbld', 09:51:45 INFO - 'LANG': 'en_US.UTF-8', 09:51:45 INFO - 'LANGUAGE': 'en_US:en', 09:51:45 INFO - 'LOGNAME': 'cltbld', 09:51:45 INFO - 'MAIL': '/var/mail/cltbld', 09:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:45 INFO - 'MOZ_NO_REMOTE': '1', 09:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:45 INFO - 'NO_EM_RESTART': '1', 09:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:45 INFO - 'SHELL': '/bin/bash', 09:51:45 INFO - 'SHLVL': '1', 09:51:45 INFO - 'TERM': 'linux', 09:51:45 INFO - 'TMOUT': '86400', 09:51:45 INFO - 'USER': 'cltbld', 09:51:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:45 INFO - '_': '/tools/buildbot/bin/python'} 09:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51: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) 09:51:47 INFO - Installing collected packages: mozsystemmonitor 09:51:47 INFO - Running setup.py install for mozsystemmonitor 09:51:47 INFO - Successfully installed mozsystemmonitor 09:51:47 INFO - Cleaning up... 09:51:47 INFO - Return code: 0 09:51:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:47 INFO - Using env: {'DISPLAY': ':0', 09:51:47 INFO - 'HOME': '/home/cltbld', 09:51:47 INFO - 'LANG': 'en_US.UTF-8', 09:51:47 INFO - 'LANGUAGE': 'en_US:en', 09:51:47 INFO - 'LOGNAME': 'cltbld', 09:51:47 INFO - 'MAIL': '/var/mail/cltbld', 09:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:47 INFO - 'MOZ_NO_REMOTE': '1', 09:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:47 INFO - 'NO_EM_RESTART': '1', 09:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:47 INFO - 'SHELL': '/bin/bash', 09:51:47 INFO - 'SHLVL': '1', 09:51:47 INFO - 'TERM': 'linux', 09:51:47 INFO - 'TMOUT': '86400', 09:51:47 INFO - 'USER': 'cltbld', 09:51:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:47 INFO - '_': '/tools/buildbot/bin/python'} 09:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:51:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:50 INFO - Downloading docopt-0.6.1.tar.gz 09:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:50 INFO - Running setup.py install for blobuploader 09:51:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:51:50 INFO - Running setup.py install for requests 09:51:50 INFO - Running setup.py install for docopt 09:51:51 INFO - Successfully installed blobuploader requests docopt 09:51:51 INFO - Cleaning up... 09:51:51 INFO - Return code: 0 09:51:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:51 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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:51:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:51 INFO - Using env: {'DISPLAY': ':0', 09:51:51 INFO - 'HOME': '/home/cltbld', 09:51:51 INFO - 'LANG': 'en_US.UTF-8', 09:51:51 INFO - 'LANGUAGE': 'en_US:en', 09:51:51 INFO - 'LOGNAME': 'cltbld', 09:51:51 INFO - 'MAIL': '/var/mail/cltbld', 09:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:51 INFO - 'MOZ_NO_REMOTE': '1', 09:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:51 INFO - 'NO_EM_RESTART': '1', 09:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:51 INFO - 'SHELL': '/bin/bash', 09:51:51 INFO - 'SHLVL': '1', 09:51:51 INFO - 'TERM': 'linux', 09:51:51 INFO - 'TMOUT': '86400', 09:51:51 INFO - 'USER': 'cltbld', 09:51:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:51 INFO - '_': '/tools/buildbot/bin/python'} 09:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:51 INFO - Running setup.py (path:/tmp/pip-0tRlR8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:51 INFO - Running setup.py (path:/tmp/pip-cD1e8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:51 INFO - Running setup.py (path:/tmp/pip-W71FZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:51 INFO - Running setup.py (path:/tmp/pip-80gMht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:51 INFO - Running setup.py (path:/tmp/pip-GhUWd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:51 INFO - Running setup.py (path:/tmp/pip-wNcnlS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:51 INFO - Running setup.py (path:/tmp/pip-rWU0Zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:51 INFO - Running setup.py (path:/tmp/pip-x1wl_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:51 INFO - Running setup.py (path:/tmp/pip-9sqOB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:51 INFO - Running setup.py (path:/tmp/pip-xgjuk1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:52 INFO - Running setup.py (path:/tmp/pip-YhlAsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:52 INFO - Running setup.py (path:/tmp/pip-zUvnte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:52 INFO - Running setup.py (path:/tmp/pip-peOiws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:52 INFO - Running setup.py (path:/tmp/pip-l_kAbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:52 INFO - Running setup.py (path:/tmp/pip-RYjvAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:52 INFO - Running setup.py (path:/tmp/pip-nwv50m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:52 INFO - Running setup.py (path:/tmp/pip-0yt1VX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:52 INFO - Running setup.py install for manifestparser 09:51:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:51:52 INFO - Running setup.py install for mozcrash 09:51:52 INFO - Running setup.py install for mozdebug 09:51:52 INFO - Running setup.py install for mozdevice 09:51:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:51:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozfile 09:51:53 INFO - Running setup.py install for mozhttpd 09:51:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozinfo 09:51:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozInstall 09:51:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozleak 09:51:53 INFO - Running setup.py install for mozlog 09:51:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for moznetwork 09:51:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozprocess 09:51:53 INFO - Running setup.py install for mozprofile 09:51:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:51:53 INFO - Running setup.py install for mozrunner 09:51:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:51:54 INFO - Running setup.py install for mozscreenshot 09:51:54 INFO - Running setup.py install for moztest 09:51:54 INFO - Running setup.py install for mozversion 09:51:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:51:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:54 INFO - Cleaning up... 09:51:54 INFO - Return code: 0 09:51:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:54 INFO - Using env: {'DISPLAY': ':0', 09:51:54 INFO - 'HOME': '/home/cltbld', 09:51:54 INFO - 'LANG': 'en_US.UTF-8', 09:51:54 INFO - 'LANGUAGE': 'en_US:en', 09:51:54 INFO - 'LOGNAME': 'cltbld', 09:51:54 INFO - 'MAIL': '/var/mail/cltbld', 09:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:54 INFO - 'MOZ_NO_REMOTE': '1', 09:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:54 INFO - 'NO_EM_RESTART': '1', 09:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:54 INFO - 'SHELL': '/bin/bash', 09:51:54 INFO - 'SHLVL': '1', 09:51:54 INFO - 'TERM': 'linux', 09:51:54 INFO - 'TMOUT': '86400', 09:51:54 INFO - 'USER': 'cltbld', 09:51:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:54 INFO - '_': '/tools/buildbot/bin/python'} 09:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51:54 INFO - Running setup.py (path:/tmp/pip-YewY4s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:51: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)) 09:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51:54 INFO - Running setup.py (path:/tmp/pip-FXoP2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:51: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)) 09:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51:54 INFO - Running setup.py (path:/tmp/pip-pWAcls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:51: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)) 09:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51:54 INFO - Running setup.py (path:/tmp/pip-1i9p6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:51: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)) 09:51:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:54 INFO - Running setup.py (path:/tmp/pip-a2OXB7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:55 INFO - Running setup.py (path:/tmp/pip-giTSbK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:55 INFO - Running setup.py (path:/tmp/pip-Ss0Nq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:55 INFO - Running setup.py (path:/tmp/pip-JHodwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:55 INFO - Running setup.py (path:/tmp/pip-OH3T3D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:51:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51:55 INFO - Running setup.py (path:/tmp/pip-uAvdqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51:55 INFO - Running setup.py (path:/tmp/pip-gtYYve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51:55 INFO - Running setup.py (path:/tmp/pip-h2mVx5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51:55 INFO - Running setup.py (path:/tmp/pip-ddSht2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51:55 INFO - Running setup.py (path:/tmp/pip-fEfQkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51:55 INFO - Running setup.py (path:/tmp/pip-Duxva8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:51:55 INFO - Running setup.py (path:/tmp/pip-0DA9SU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:51: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)) 09:51:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51:55 INFO - Running setup.py (path:/tmp/pip-J3J0OP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51:57 INFO - Downloading blessings-1.6.tar.gz 09:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:57 INFO - Installing collected packages: blessings 09:51:57 INFO - Running setup.py install for blessings 09:51:57 INFO - Successfully installed blessings 09:51:57 INFO - Cleaning up... 09:51:58 INFO - Return code: 0 09:51:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:51:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:51:58 INFO - Reading from file tmpfile_stdout 09:51:58 INFO - Current package versions: 09:51:58 INFO - argparse == 1.2.1 09:51:58 INFO - blessings == 1.6 09:51:58 INFO - blobuploader == 1.2.4 09:51:58 INFO - docopt == 0.6.1 09:51:58 INFO - manifestparser == 1.1 09:51:58 INFO - mozInstall == 1.12 09:51:58 INFO - mozcrash == 0.17 09:51:58 INFO - mozdebug == 0.1 09:51:58 INFO - mozdevice == 0.48 09:51:58 INFO - mozfile == 1.2 09:51:58 INFO - mozhttpd == 0.7 09:51:58 INFO - mozinfo == 0.9 09:51:58 INFO - mozleak == 0.1 09:51:58 INFO - mozlog == 3.1 09:51:58 INFO - moznetwork == 0.27 09:51:58 INFO - mozprocess == 0.22 09:51:58 INFO - mozprofile == 0.28 09:51:58 INFO - mozrunner == 6.11 09:51:58 INFO - mozscreenshot == 0.1 09:51:58 INFO - mozsystemmonitor == 0.0 09:51:58 INFO - moztest == 0.7 09:51:58 INFO - mozversion == 1.4 09:51:58 INFO - psutil == 3.1.1 09:51:58 INFO - requests == 1.2.3 09:51:58 INFO - wsgiref == 0.1.2 09:51:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:58 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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:51:58 INFO - Using env: {'DISPLAY': ':0', 09:51:58 INFO - 'HOME': '/home/cltbld', 09:51:58 INFO - 'LANG': 'en_US.UTF-8', 09:51:58 INFO - 'LANGUAGE': 'en_US:en', 09:51:58 INFO - 'LOGNAME': 'cltbld', 09:51:58 INFO - 'MAIL': '/var/mail/cltbld', 09:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:58 INFO - 'MOZ_NO_REMOTE': '1', 09:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:58 INFO - 'NO_EM_RESTART': '1', 09:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:58 INFO - 'SHELL': '/bin/bash', 09:51:58 INFO - 'SHLVL': '1', 09:51:58 INFO - 'TERM': 'linux', 09:51:58 INFO - 'TMOUT': '86400', 09:51:58 INFO - 'USER': 'cltbld', 09:51:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:58 INFO - '_': '/tools/buildbot/bin/python'} 09:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51: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)) 09:51:58 INFO - Cleaning up... 09:51:58 INFO - Return code: 0 09:51:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:51: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')]} 09:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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')]} 09:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:51: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 09:51: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 09:51:58 INFO - Using env: {'DISPLAY': ':0', 09:51:58 INFO - 'HOME': '/home/cltbld', 09:51:58 INFO - 'LANG': 'en_US.UTF-8', 09:51:58 INFO - 'LANGUAGE': 'en_US:en', 09:51:58 INFO - 'LOGNAME': 'cltbld', 09:51:58 INFO - 'MAIL': '/var/mail/cltbld', 09:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:58 INFO - 'MOZ_NO_REMOTE': '1', 09:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:51:58 INFO - 'NO_EM_RESTART': '1', 09:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:51:58 INFO - 'SHELL': '/bin/bash', 09:51:58 INFO - 'SHLVL': '1', 09:51:58 INFO - 'TERM': 'linux', 09:51:58 INFO - 'TMOUT': '86400', 09:51:58 INFO - 'USER': 'cltbld', 09:51:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:58 INFO - '_': '/tools/buildbot/bin/python'} 09:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:58 INFO - Downloading/unpacking jsonschema 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:51: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 09:52:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:00 INFO - Downloading/unpacking functools32 (from jsonschema) 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:00 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:00 INFO - warning: no files found matching '*.txt' 09:52:00 INFO - no previously-included directories found matching 'build' 09:52:00 INFO - no previously-included directories found matching 'dist' 09:52:00 INFO - no previously-included directories found matching '.git*' 09:52:00 INFO - Installing collected packages: jsonschema, functools32 09:52:00 INFO - Running setup.py install for functools32 09:52:00 INFO - warning: no files found matching '*.txt' 09:52:00 INFO - no previously-included directories found matching 'build' 09:52:00 INFO - no previously-included directories found matching 'dist' 09:52:00 INFO - no previously-included directories found matching '.git*' 09:52:00 INFO - Successfully installed jsonschema functools32 09:52:00 INFO - Cleaning up... 09:52:00 INFO - Return code: 0 09:52:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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 0x7fb1c0811f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x123d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13098d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:52: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 09:52: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 09:52:00 INFO - Using env: {'DISPLAY': ':0', 09:52:00 INFO - 'HOME': '/home/cltbld', 09:52:00 INFO - 'LANG': 'en_US.UTF-8', 09:52:00 INFO - 'LANGUAGE': 'en_US:en', 09:52:00 INFO - 'LOGNAME': 'cltbld', 09:52:00 INFO - 'MAIL': '/var/mail/cltbld', 09:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:00 INFO - 'MOZ_NO_REMOTE': '1', 09:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:00 INFO - 'NO_EM_RESTART': '1', 09:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:00 INFO - 'SHELL': '/bin/bash', 09:52:00 INFO - 'SHLVL': '1', 09:52:00 INFO - 'TERM': 'linux', 09:52:00 INFO - 'TMOUT': '86400', 09:52:00 INFO - 'USER': 'cltbld', 09:52:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:00 INFO - '_': '/tools/buildbot/bin/python'} 09:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:01 INFO - Downloading/unpacking flake8 09:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:52:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:52:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52: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 09:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:52:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:03 INFO - no previously-included directories found matching 'docs/_build' 09:52:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:52:03 INFO - Running setup.py install for pep8 09:52:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:03 INFO - no previously-included directories found matching 'docs/_build' 09:52:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:52:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:52:03 INFO - Cleaning up... 09:52:03 INFO - Return code: 0 09:52:03 INFO - Running post-action listener: _resource_record_post_action 09:52:03 INFO - Running post-action listener: _start_resource_monitoring 09:52:04 INFO - Starting resource monitoring. 09:52:04 INFO - ##### 09:52:04 INFO - ##### Running install step. 09:52:04 INFO - ##### 09:52:04 INFO - Running pre-action listener: _resource_record_pre_action 09:52:04 INFO - Running main action method: install 09:52:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:04 INFO - Reading from file tmpfile_stdout 09:52:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:52:04 INFO - Reading from file tmpfile_stdout 09:52:04 INFO - Output received: 09:52:04 INFO - Usage: mozinstall [options] installer 09:52:04 INFO - Options: 09:52:04 INFO - -h, --help show this help message and exit 09:52:04 INFO - -d DEST, --destination=DEST 09:52:04 INFO - Directory to install application into. [default: 09:52:04 INFO - "/builds/slave/test-pgo"] 09:52:04 INFO - --app=APP Application being installed. [default: firefox] 09:52:04 INFO - mkdir: /builds/slave/test-pgo/build/application 09:52:04 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'] 09:52:04 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 09:52:20 INFO - Reading from file tmpfile_stdout 09:52:20 INFO - Output received: 09:52:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:52:20 INFO - Running post-action listener: _resource_record_post_action 09:52:20 INFO - ##### 09:52:20 INFO - ##### Running run-tests step. 09:52:20 INFO - ##### 09:52:20 INFO - Running pre-action listener: _resource_record_pre_action 09:52:20 INFO - Running main action method: run_tests 09:52:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:52:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:52:20 INFO - Python 2.7.3 09:52:20 INFO - Return code: 0 09:52:20 INFO - grabbing minidump binary from tooltool 09:52: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')]} 09:52: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 0x13988b0>, '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 0x13997b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1399c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:52: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 09:52: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 09:52:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:20 INFO - Return code: 0 09:52:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:52:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:52:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:52:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:52:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:52:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:52:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:52:21 INFO - Return code: 0 09:52: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/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:52: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/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 09:52:21 INFO - Using env: {'DISPLAY': ':0', 09:52:21 INFO - 'HOME': '/home/cltbld', 09:52:21 INFO - 'LANG': 'en_US.UTF-8', 09:52:21 INFO - 'LANGUAGE': 'en_US:en', 09:52:21 INFO - 'LOGNAME': 'cltbld', 09:52:21 INFO - 'MAIL': '/var/mail/cltbld', 09:52:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:52:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:21 INFO - 'MOZ_NO_REMOTE': '1', 09:52:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:21 INFO - 'NO_EM_RESTART': '1', 09:52:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:52:21 INFO - 'SHELL': '/bin/bash', 09:52:21 INFO - 'SHLVL': '1', 09:52:21 INFO - 'TERM': 'linux', 09:52:21 INFO - 'TMOUT': '86400', 09:52:21 INFO - 'USER': 'cltbld', 09:52:21 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946', 09:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:21 INFO - '_': '/tools/buildbot/bin/python'} 09:52: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/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 09:52:22 INFO - mozversion application_buildid: 20160327073347 09:52:22 INFO - mozversion application_changeset: 0996ba84787e3d49289545527b84740066f9805f 09:52:22 INFO - mozversion application_display_name: Nightly 09:52:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:22 INFO - mozversion application_name: Firefox 09:52:22 INFO - mozversion application_remotingname: firefox 09:52:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:52:22 INFO - mozversion application_vendor: Mozilla 09:52:22 INFO - mozversion application_version: 48.0a1 09:52:22 INFO - mozversion platform_buildid: 20160327073347 09:52:22 INFO - mozversion platform_changeset: 0996ba84787e3d49289545527b84740066f9805f 09:52:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:52:22 INFO - mozversion platform_version: 48.0a1 09:52:22 INFO - using testdate: 1459097542 09:52:22 INFO - actual date: 1459097542 09:52:22 INFO - starting webserver on 'localhost:50687' 09:52:22 INFO - SUITE-START | Running 2 tests 09:52:22 INFO - TEST-START | dromaeo_css 09:52:22 INFO - operating with platform_type : linux_ 09:52:22 INFO - Initialising browser for dromaeo_css test... 09:52:22 INFO - TEST-INFO | started process 2327 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptSr4lg/profile http://localhost:50687/getInfo.html) 09:52:26 INFO - PROCESS | 2327 | __metrics Screen width/height:1600/1200 09:52:26 INFO - PROCESS | 2327 | colorDepth:24 09:52:26 INFO - PROCESS | 2327 | Browser inner width/height: 1024/697 09:52:26 INFO - PROCESS | 2327 | __metrics 09:52:26 ERROR - PROCESS | 2327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:52:27 INFO - TEST-INFO | 2327: exit 0 09:52:27 INFO - Browser initialized. 09:52:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:27 INFO - TEST-INFO | started process 2497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptSr4lg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:39 INFO - PROCESS | 2497 | RSS: Main: 152723456 09:52:39 INFO - PROCESS | 2497 | 09:53:30 INFO - PROCESS | 2497 | 1459097610280 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:55:37 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50687/tests/dromaeo/cssquery-ext.html) 09:55:38 INFO - PROCESS | 2497 | RSS: Main: 252583936 09:55:38 INFO - PROCESS | 2497 | 09:58:40 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-ext.html (next: http://localhost:50687/tests/dromaeo/cssquery-jquery.html) 09:58:41 INFO - PROCESS | 2497 | RSS: Main: 239808512 09:58:41 INFO - PROCESS | 2497 | 10:01:43 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50687/tests/dromaeo/cssquery-mootools.html) 10:01:43 INFO - PROCESS | 2497 | RSS: Main: 239534080 10:01:43 INFO - PROCESS | 2497 | 10:04:45 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50687/tests/dromaeo/cssquery-prototype.html) 10:04:46 INFO - PROCESS | 2497 | RSS: Main: 219262976 10:04:46 INFO - PROCESS | 2497 | 10:07:48 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50687/tests/dromaeo/cssquery-yui.html) 10:07:49 INFO - PROCESS | 2497 | RSS: Main: 220581888 10:07:49 INFO - PROCESS | 2497 | 10:10:51 INFO - PROCESS | 2497 | Cycle 1(1): loaded http://localhost:50687/tests/dromaeo/cssquery-yui.html (next: http://localhost:50687/tests/dromaeo/cssquery-dojo.html) 10:10:52 INFO - PROCESS | 2497 | RSS: Main: 263757824 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | __start_tp_report 10:10:52 INFO - PROCESS | 2497 | _x_x_mozilla_page_load 10:10:52 INFO - PROCESS | 2497 | _x_x_mozilla_page_load_details 10:10:52 INFO - PROCESS | 2497 | |i|pagename|runs| 10:10:52 INFO - PROCESS | 2497 | |0;dojo.html;3069.155982104921;3089.752819774418;3127.2025633463477;3128.827914464705;3162.810231386117;5115.258287548312;5125.718085505296;5168.948310516894;5173.637845350827;5243.606729495284;5231.503007214318;5237.292965449663;5323.467653234675;5329.626926115174;5331;4651.232546629802;4736.502667219936;4772.188727916246;4775.164346239411;4821.035792841428;4650.604698600623;4730.195866702668;4755.429348478187;4780.713157210561;4818.614510839142;4818.229083346665;4856.15017371962;4856.538628830255;4881.804727810883;4887.193613053842;4667.323238130486;4669;4675.812967481296;4684.859454216379;4718.363020992157;4621.23749581322;4640.489546149921;4649.535046495357;4720.409948756405;4735.526447355237;5226.268322434862;5228.451012643655;5232.502912223333;5236.6857988520815;5250.212468129773;5628.690422026787;5638.605297629168;5640.802571910004;5642.294713160855;5662.122371032456;5478.726063696839;5588.636738611977;5690.516306113986;5707.571932105067;5710.486056254916;5174.4825517448335;5174.4825517448335;5177.19753438214;5199.402068762065;5224;5618.269624948731;5622.522085622686;5626.240457538262;5628.099504079328;5638.464345887134;5372.785088596413;5417.729113544307;5444.346678398618;5519.834404967857;5607.579431542651;5436.7281635918835;5448.482394172547;5449.64577302474;5452.591055670761;5512.91730624041;5434.103372943499;5437.429069947678;5442.972785136049;5445.646033007842;5488.91766623501;5376.569874410038;5474.288342515448;5480.671159730429;5556.333240011225;5578.888422231533;4252.362145678173;4256.255155347863;4266.232078225887;4272.786360681954;4302.591253830881;3822.522184726909;3828.8659896903473;3830.3105441020884;3857.8263978121054;3858.2090671412293;5101.464346243665;5288.81489147878;5339.172428273624;5384.6499977501335;5392.110301800238;5635.605507614509;5653.265075540154;5675.3757086720425;5692.8861422771315;5696.772129114872;5102.795888164506;5355.277037599874;5379.960322417822;5380.838574842761;5419.485148910847;4838.371011768448;4880.072786170687;4883.194272944925;4919.212925931905;4929.605631549467;5640.210370548127;5647.124695672177;5649;5663;5691.601587888891;5370.731463426735;5452.100403433547;5454.400015998316;5492.505674489315;5521.917171242515;5776.249087618751;5812.389699081536;5813.738381772746;5843.824685259279;5863.560232982458;5461.890762184814;5501.284832971688;5518.2826232589505;5518.779248830002;5524.033294173423;5329.546988505866;5521.033819081725;5604;5622.718864056863;5631.1271752878365;5385.030694475032;5392.191171324333;5395.217693434509;5426.023315803035;5442.4557544246845;5346.144616861284;5347.919781203207;5353.946460535345;5373.865653358697;5394.811181608625;5188.988147311389;5195.116830138961;5258.710770907637;5267.07826130418;5297.258383826191;5489.4236105209975;5492.148716948879;5493.313335833021;5493.807716729895;5494.395616482104;5326.840194794162;5374.785008599612;5374.811881584125;5376.73116344189;5388.865278368072 10:10:52 INFO - PROCESS | 2497 | |1;ext.html;560.9465482664104;574.4255744255744;575.0282023380487;601.4737105033095;624.2851934534957;28953;29377.559336609967;37992.99999999996;38683.22633547327;38743.031424214336;41503;41871.790641046755;41957.58042419575;42022.36966445498;42112.57887421125;8894.110588941103;9015;9085.818283634324;9109.863352049691;9113.863292050624;7440.702371905118;10634.36193828369;10846.457677116152;10880;10886.455677216147;10570.735731606694;10682.305650132717;10685;10689.037986581206;10694.946525267402;10721.517531711053;10785.083267922237;10819.404932728736;10819.83770243447;10822.080123189538;10620.097291730135;10734.892651073467;10742.3017503862;10744.838827417596;10760.40817755023;38376;38419.42370864439;38616.80691596552;38675.61324386748;38700.41949370762;3446.052335607703;3685.68671662909;3895.4935858338517;3931.8820435386983;4331.956680433187;31364.686353136403;31836.20409489758;31976.200594985312;32102;32236;3398.8810391636175;3478.617352091268;3502.282032183422;3540.061883600848;3590.5152804371596;255670;258066;258235;259400;260032;49056;49761.50238497568;60302.396976030555;60691.69654151701;60700.69649651812;46963.29555056677;46974.53025469701;47079;47106;47376.28935565969;13535.05254632186;13537.729245415037;13544.255065971467;13544.729105417837;13561.796573051412;10104.292699510963;12492.312922789151;12508.81236781449;12613.936930315289;12668.49326026967;16008.919955400148;16033.358665653477;16124.435644752377;16163.272652730655;16584.6683066338;6122.602030868068;6150.323464418911;6278.434940855345;6291.1192433059405;6308.653024083627;1005.5525291245472;1071.6249312740479;1089.8964598363143;1133.3539882267194;1152.2567943676281;32588.701694696298;32692.806803889114;32788;32995.505067424005;33056;1101.1466113761899;1123.4270522033821;1174.5947648061406;1177.5996161305197;1217.4825699077855;16874.240659170366;16924.153792310335;16950.40673576419;16962.66074678524;16963.575910602332;400827;405123;405750;406652;406888;57271;57820.71089644525;58230.417695823344;58258.417415826145;58287.70856145692;1220.3776074202221;1365.3378111616057;1400.2578633324354;1411.9364628591738;1436.7141408439388;28403.431931360843;30894.22764430907;31947.520787188674;32478.188045298113;33022.17444563905;45325;45687.771561141984;45732.31401528913;45760;45781.54218457773;266107;266959;268391;268761;269706;37640.43539346857;38820;38914.4162837552;39297.80351098226;39349.60650393459;47457;47463;47837;48250;48708.269375960095;40011;40283.79858100691;41072.1785564293;41303.38044929269;42329.365059524745;38937;39408.6059139405;39815.80092099521;40319.3952090713;40478.190436190525;40706.796466017484;41599.37600936049;41748;42069.36895946624;42217.78891105648;34524.82737586296;35413.82293088518;36161.45757813582;36172.81913590415;36490.27019459649;27989.86005070043;28091.578626320214;28486.715132848407;28522.57216141801;28610.570841437813 10:10:52 INFO - PROCESS | 2497 | |2;jquery.html;352.82535145103196;365.15831009523055;367.94296883982986;367.96320367963193;371.62465909431484;17428.825711742895;18013.549661258476;18292.176852041655;18685.159167837446;18717;17246.482605521855;17994.730079048826;18674.346397876077;18682.25270989159;18692.626147477044;5519.172124181385;5685.488306052454;5710.457506536873;5712.771489140429;5714.571407144481;4015.217032678629;5642.858928526799;5898.233229680157;6144.84637884052;6175.382461753834;6097.420745029215;6113.6943152842405;6121;6140.35526269742;6144.44699977002;6016.608920420181;6025;6090.421409966046;6185.072239164161;6191.349908259613;3639.290338384016;5191.091558977201;5385.78456861725;5388.030154572176;5440.265564148829;21512.494125411227;21572;21667.783322166735;22728.318150455514;22810.31569052931;2374.7743964323363;2663.5738281874806;2684.7181045990087;2711.159540542438;2736.7126451722484;13861.099028563212;13863.722725545533;14048.71902561943;14056.437742490289;14404.63988400288;1894.2801735340483;1930.3533316338903;1945.4163750874682;1965.8132477414622;1985.6525108106023;68275;69414.30585694179;69764.6511767443;70675.29324706738;71376;9466.1953733932;9767.316287859781;10112.59549618007;10188.134008609202;10204.38773673582;13690.794638080437;13790.172589644653;13813.102148360324;13853.16880987144;13862.376193071335;8055.194480551898;8102.270795628304;8169;8252.05101413345;8304.252617264476;8195.754127376189;8215.712450064339;8245.381596380295;8268.793280167924;8292.626831792462;6031.698415079229;6159.19930409044;6228.34602366754;6231.40801623845;6259.530535209878;1656.21329868314;1715.5882588178747;1734.3149455965076;1797.748315235868;1800.5526349915688;963.7735132243918;1057.2704833664748;1105.2815669814524;1158.3744777820052;1167.5154810753443;17340.219690113976;18116.184771685304;18770.13670655188;18956.24175032983;19139.808601914083;1009.8939611340851;1016.898310168992;1024.3904876598413;1048.2557384257111;1091.7216109892086;9751.707448776548;11008.724781880517;11017.228793984505;11029.22795404314;11052.171087168495;422703;427320;435198;437090;484957;71361.2863871365;71845.28154718385;72325.6383718078;73509;73637;1072.5334479501441;1083.4961742789799;1097.533548241994;1111.90548803351;1112.1158678850334;16728.665426691154;16735.74896376531;16738.07940563281;16769.580760481087;16920.31785664729;34223.657763422045;34441.311173776885;34792.82603586966;35264.11839704028;35481.1129721759;47317.526824731314;47688;47895.88497768964;47943.760281198374;49605;8340.207680270365;8425.747227583182;8449.831003379775;8482.066972632882;8531.488110713377;12576.74846503083;13265.535706250235;13396.598102056954;13457.394417251444;13549.661258468223;11353.829692554784;11585.246958947642;11876.643700688994;11889.762204756029;12013.399330033639;11365.31808091517;11571.6528504145;11706.239094458833;11757.76484470323;11956.701082473008;11867.58463453775;11996.580119696118;12046.939765301116;12054.457549410474;12177.208481448677;8263.95868020656;8289.295409889986;8340.249377556049;8376.916230837614;8407.789805254917;11672;12035.45840437165;12051.75896482083;12067.034637228826;12081.275123492618 10:10:52 INFO - PROCESS | 2497 | |3;mootools.html;1352.1008529327996;1500.4073391010552;1505.194720824359;1679.2611251049536;1825.625746721923;7698.191689872567;7887.21127887211;7887.447878648497;7920.762377128681;7936.285734283913;7741.148473667906;7921.366290696745;7924.524528528293;7925.643346049427;7927.088384835745;1926.6050459655737;2213.8339624528144;2275.7951784339407;2275.8862056897174;2289.050044231642;2220.555888822234;2236.944076398095;2251.549690061986;2252.7747225277503;2254.5716313900307;2169.2841362350464;2231.85492942959;2235.7093577834858;2237.7538470768204;2241.551689662066;2239.899204535792;2241.6413373860187;2249.8200143988443;2295.01314434793;2295.036084844353;2248.325502349289;2280.3159052284414;2282.5320809234067;2301.0910690277415;2301.2866011536476;8165.061017982948;8214.712485062993;8227.218414250696;8238.50568965864;8252;4793.880152996168;4911.214205727102;4916.926246106311;4917.40991081069;4928;3193.2176616728816;3206.8556914938886;3234.7897386669792;3250.2686895448574;3255.397751415972;1043.228011271661;1055.8996895294936;1058.8782290036668;1081.5133190064503;1089.3355053417408;11389.943050284779;11431.371274579895;11433.656990290305;11433.885661143366;11448.141389395745;4194.3918131870705;4200.663946884242;4209.663226941837;4218.135282267128;4238.321868501025;9617.759556011015;9623.759406014906;9676.854847177297;9712.22302215821;9715.46564938921;4265.1469706058915;4878.43897951733;4881.780319885614;4920;4921.655484116078;4468.285074388083;4494;4514.052049069732;4521.389612402284;4567.794449249792;3655.1593133579427;3710.109573702292;3722.9813850931114;3735.6824669902817;3791.639794219545;1168.567629976897;1168.8363629091934;1172.1853311948114;1173.372245848484;1190.5118901250446;1369.6931827761764;1387.8057072009926;1390.506370238571;1434.5552878607666;1435.6410897275682;7797.610119494116;7977.7207797726805;7978.082520510099;7979.640916158787;7983.321417679446;434.1165727744026;439.54726631569537;441.6731618602211;442.63703762914747;464.61901240982746;6037.63774173551;6072.7570897164505;6089.238845144357;6130.5402094842175;6132.6933653317155;9548.1884039856;10198.878123406419;10331.535080921227;10334.431606261727;10336.741581460374;10022.699319020441;10115.443650599287;10133.341332813343;10155.441450720282;10213.489325533843;7477.327040566375;7568.053993250844;7589.620518974029;7674.309312161932;7694.461387702919;7477.289657482531;7479.102507699111;7621.123570789208;7626.847463050819;7629.7329593463965;8663.39356245082;8794.472331659865;8898;8950.910490895008;9029.051949545466;8900.332475064526;9009.594568244314;9113.77215569616;9139.63441462334;9158.129977652112;6437.130987316839;6595.637239951849;6601.471882249504;7243.3843123333;7368.4842061055215;7513.661885215288;7632.503887247533;7635.961820190863;7643.770686879402;7648.65581048843;6721.865562688621;6903.723851045902;6958.756443524655;6963.1296087989;7058.188308344606;6860.656967151723;6867.278935711878;6925.411340035952;6973.407260382722;7060.223375428596;7127.287271273039;7200.063991681048;7231.963840180976;7249.420046396381;7301.890471642823;6785.287544807724;6804.251532331341;6831.59010459374;6878.484113691393;6893.448524118159;6728.394444500019;6748.291429399842;6760.053592496956;6808.727650894107;6810.897836532356 10:10:52 INFO - PROCESS | 2497 | |4;prototype.html;284.82910253847695;292.1513004721284;297.15163209038195;297.9806312589683;304.8445292900621;5994.8801023979495;6003.189569408129;6048.062550304699;6052.031674932017;6064.241969753781;5974.253218347707;5990.760369585222;5993.520518358532;5996.430339117787;6006.669633170185;4249.80875860587;4417.315316126005;4523.592876641102;4527.185106680796;4540.682152249344;4502.77486125694;4517;4527.849271595982;4539.568740969603;4545.704529205607;4236.110416812473;4466.464024317086;4474.530174331697;4479.8432054878085;4484;4349.369341445488;4435.711678740888;4436.73379597222;4453.554644535553;4466.486354069259;3868.5551161616213;3870.9225815483815;3875.670568001723;3879.3792993120965;3890.0858298299877;5770.336411312669;5782.190493330937;5791.710414479259;5792.333881603628;5799.18811366409;5155.66488178271;5162.483751624845;5163.66436181647;5166.948330516722;5172.405173405069;6265.0915617235705;6272.717727702218;6274.278457977345;6277.843053923642;6280.466160376373;4014.859479918218;4116.876493705194;4117.114820313647;4120.134771697947;4260.44614200152;6524.380183882524;6569.967150164266;6653.002049692536;6664.900026499607;6667.733290668416;4255.1915136124035;4256.4679415073115;4257.254980378421;4260.382244574519;4268.722533035343;4297.097609501977;4299.097189590158;4302.913941721211;4304;4308.698391112592;5056.292119103328;5104.438511763703;5105.617078719111;5116.872078198075;5121.564667003347;6240.563160578807;6367.108604795332;6382.6170429774365;6387.201599800025;6388.329225431356;1477.253986736691;1488.9553313400615;1496.8773419935048;1499.5426394949645;1501.872340851018;910.1762904571374;959.2326139088701;971.1599466461602;991.2565575818137;996.3822430093388;6030.849228769316;6035.6076855004285;6045.6070355426755;6048.395160484004;6088.726007329681;6472.93196622552;6517.543771935919;6552.443042341454;6554.80335589933;6555.3772391622715;6103.908441373383;6109.694515274218;6116.816495505142;6118.265808103056;6120.234970628671;3470.27124303899;3495.5106285120105;3501.964980350215;3502.1419752160373;3505.018594793462;6625.536212465081;6764.458843292623;6779.35596118368;6874.175098988154;6879;6665.266820649725;6717.227518835299;6734.56225345351;6765.898511522331;6768.323167683291;6872.244053154149;6878.793636190922;6881.277465866012;6888.207856096613;6888.621125838127;6645.435138013323;6660;6663.333666633298;6672.032555279555;6677.198736151498;6317.842053948688;6497.382748638872;6535.477161826947;6540.345965403421;6561.40947314744;6795.830104247433;6821.727130914906;6863.931360686529;6871.5189936703955;6884.036234927014;4400.097979914046;4439.667024973075;4450.799714012942;4457.04173602677;4460.888477788081;6539.051837483634;6540.967295163684;6548.639824809491;6554.442872355903;6554.967225163844;6281.497480201664;6399.136116624382;6401;6401.3598640135615;6411.871762564816;6376.87246255063;6414.198225221848;6423.068655044899;6429.067785171217;6429.9678501607195;6329.556931014785;6376.87246255063;6377.330380310186;6380.330065343072;6385.233771947396;6434.227892652724;6443.67781610927;6455.128557644658;6458.354164583692;6466.159399278064;6014.578979471395;6179.567430280017;6304.621722696653;6309.589876658002;6387.744490220339 10:10:52 INFO - PROCESS | 2497 | |5;yui.html;751.4362047514956;816.734561267588;829.3613917283692;845.556083056395;883.1742320929927;14453.638659033517;14506.492272770454;14561;14561.708765824691;14610.196439195866;12842.486300547967;12910;12919.289439080847;12949.287789171616;12961.157524760883;654.6595770199493;819.4100247821559;833.2500749325595;833.6165363932598;834.1366685480529;827.3050637464529;832.76682528892;833.2459124492344;833.5915401453275;833.9416240863142;697.979060628182;874.3660845886714;874.995625021874;875.8642410426362;876.8071024374627;702.0171759536664;872.0973792125152;883.726044926075;884.9646014159458;885.5926273914007;642.7011439680524;643.2506130358128;643.3437893348759;643.3566433566433;643.7231990244193;14095.78856317156;14112.85887141136;14149.08030977983;14154.575362739135;14158.646033849132;13462.663433414145;14065.507707230197;14099.78850317246;14111.647208819759;14736.336864841109;11578.073754099736;11679.591214307458;11681.649550513499;11698;11699.122565807598;3849.3648547989546;3857.498525191707;3911.3546264866263;3941.8029098544957;4011.0373510357595;54009.189862152096;54118.729406352715;54529.1820622687;54763.17855232175;54932.450675493135;11393.145514086476;11411.942940285246;11460.541578336773;11513.539458421737;11810.055195584333;20380.490487737927;20455.97720113988;20468.69296960547;20468.69296960547;20497.180112795322;8554.14458554152;8674;8679.783005424788;8824.426412283181;8891.955540222258;4337.60961513459;4709.905801883943;4717.056033028346;4759.286107083896;4782.33047373368;3293.7859039162377;3309.6028476582483;3316.7512436567354;3318.7013168814924;3332.150301673058;585.2596465471182;601.9067044608092;607.9361118043424;609.4210500024994;610.7740136149653;627.9811605651838;634.1027446163719;704.3977399323607;761.9238076192337;798.636620337745;8505.574721263913;8573.74278771638;8736.956315218384;8819.647214111492;9171;742.2206682982846;746.932776050158;756.1228974389682;784.8077221080757;789.9763007109796;4122.56713045132;4181.979090104591;4227.154569086134;4227.450431443893;4277;61873.690631547455;62066.37933620696;64647.35352646507;65292.347076528626;65414;54424.45575544273;56169.43830561642;56453;56640.43359566352;56656;49574.50425495771;49663.75168124136;50501.49498505115;51172.92962422266;51275.743621281654;8373.62318695648;8543.359248056297;8563.100874408097;8568.271696905584;8712.172343627346;36598;37070.44394334141;37563.436548452344;37892.810535947145;39024.80487597544;46835.76582117067;47453.762731187504;47621.52378476171;48911;49361.753191233816;12063.733308002533;12156.696082598006;12614.180078294881;12668.366581670694;13039.739205215652;11896.345700986529;12946.417411216706;14031.438742450187;14438.133711977314;14446.494372696905;13111.147775394951;13161.934190328988;13348.93325533366;13535.79696304576;13651;11670.591529296435;11775.882241177478;11810;12802.48790048425;13106.344682766014;12688.809667854805;12729.29988850622;12811.679708007374;12991.220526768424;13074.411651475517;10892.074173695008;11296.49165787558;11395.772084558428;11405.828912566483;11546.422678865854;10170.491475426052;10253.692389228336;10379.169666426818;10399.428031458343;10415.895841041493 10:10:52 INFO - PROCESS | 2497 | __end_tp_report 10:10:52 INFO - PROCESS | 2497 | __start_cc_report 10:10:52 INFO - PROCESS | 2497 | _x_x_mozilla_cycle_collect,782 10:10:52 INFO - PROCESS | 2497 | __end_cc_report 10:10:52 INFO - PROCESS | 2497 | __startTimestamp1459098652061__endTimestamp 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | ------- Summary: start ------- 10:10:52 INFO - PROCESS | 2497 | Number of tests: 6 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#0] dojo.html Cycles:165 Average:5171.20 Median:5373.87 stddev:564.57 (10.5%) stddev-sans-first:541.68 10:10:52 INFO - PROCESS | 2497 | Values: 3069.2 3089.8 3127.2 3128.8 3162.8 5115.3 5125.7 5168.9 5173.6 5243.6 5231.5 5237.3 5323.5 5329.6 5331.0 4651.2 4736.5 4772.2 4775.2 4821.0 4650.6 4730.2 4755.4 4780.7 4818.6 4818.2 4856.2 4856.5 4881.8 4887.2 4667.3 4669.0 4675.8 4684.9 4718.4 4621.2 4640.5 4649.5 4720.4 4735.5 5226.3 5228.5 5232.5 5236.7 5250.2 5628.7 5638.6 5640.8 5642.3 5662.1 5478.7 5588.6 5690.5 5707.6 5710.5 5174.5 5174.5 5177.2 5199.4 5224.0 5618.3 5622.5 5626.2 5628.1 5638.5 5372.8 5417.7 5444.3 5519.8 5607.6 5436.7 5448.5 5449.6 5452.6 5512.9 5434.1 5437.4 5443.0 5445.6 5488.9 5376.6 5474.3 5480.7 5556.3 5578.9 4252.4 4256.3 4266.2 4272.8 4302.6 3822.5 3828.9 3830.3 3857.8 3858.2 5101.5 5288.8 5339.2 5384.6 5392.1 5635.6 5653.3 5675.4 5692.9 5696.8 5102.8 5355.3 5380.0 5380.8 5419.5 4838.4 4880.1 4883.2 4919.2 4929.6 5640.2 5647.1 5649.0 5663.0 5691.6 5370.7 5452.1 5454.4 5492.5 5521.9 5776.2 5812.4 5813.7 5843.8 5863.6 5461.9 5501.3 5518.3 5518.8 5524.0 5329.5 5521.0 5604.0 5622.7 5631.1 5385.0 5392.2 5395.2 5426.0 5442.5 5346.1 5347.9 5353.9 5373.9 5394.8 5189.0 5195.1 5258.7 5267.1 5297.3 5489.4 5492.1 5493.3 5493.8 5494.4 5326.8 5374.8 5374.8 5376.7 5388.9 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#1] ext.html Cycles:180 Average:48628.29 Median:3521.17 stddev:83269.54 (2364.8%) stddev-sans-first:83424.92 10:10:52 INFO - PROCESS | 2497 | Values: 560.9 574.4 575.0 601.5 624.3 28953.0 29377.6 37993.0 38683.2 38743.0 41503.0 41871.8 41957.6 42022.4 42112.6 8894.1 9015.0 9085.8 9109.9 9113.9 7440.7 10634.4 10846.5 10880.0 10886.5 10570.7 10682.3 10685.0 10689.0 10694.9 10721.5 10785.1 10819.4 10819.8 10822.1 10620.1 10734.9 10742.3 10744.8 10760.4 38376.0 38419.4 38616.8 38675.6 38700.4 3446.1 3685.7 3895.5 3931.9 4332.0 31364.7 31836.2 31976.2 32102.0 32236.0 3398.9 3478.6 3502.3 3540.1 3590.5 255670.0 258066.0 258235.0 259400.0 260032.0 49056.0 49761.5 60302.4 60691.7 60700.7 46963.3 46974.5 47079.0 47106.0 47376.3 13535.1 13537.7 13544.3 13544.7 13561.8 10104.3 12492.3 12508.8 12613.9 12668.5 16008.9 16033.4 16124.4 16163.3 16584.7 6122.6 6150.3 6278.4 6291.1 6308.7 1005.6 1071.6 1089.9 1133.4 1152.3 32588.7 32692.8 32788.0 32995.5 33056.0 1101.1 1123.4 1174.6 1177.6 1217.5 16874.2 16924.2 16950.4 16962.7 16963.6 400827.0 405123.0 405750.0 406652.0 406888.0 57271.0 57820.7 58230.4 58258.4 58287.7 1220.4 1365.3 1400.3 1411.9 1436.7 28403.4 30894.2 31947.5 32478.2 33022.2 45325.0 45687.8 45732.3 45760.0 45781.5 266107.0 266959.0 268391.0 268761.0 269706.0 37640.4 38820.0 38914.4 39297.8 39349.6 47457.0 47463.0 47837.0 48250.0 48708.3 40011.0 40283.8 41072.2 41303.4 42329.4 38937.0 39408.6 39815.8 40319.4 40478.2 40706.8 41599.4 41748.0 42069.4 42217.8 34524.8 35413.8 36161.5 36172.8 36490.3 27989.9 28091.6 28486.7 28522.6 28610.6 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#2] jquery.html Cycles:180 Average:26322.80 Median:12592.55 stddev:72413.94 (575.1%) stddev-sans-first:72590.83 10:10:52 INFO - PROCESS | 2497 | Values: 352.8 365.2 367.9 368.0 371.6 17428.8 18013.5 18292.2 18685.2 18717.0 17246.5 17994.7 18674.3 18682.3 18692.6 5519.2 5685.5 5710.5 5712.8 5714.6 4015.2 5642.9 5898.2 6144.8 6175.4 6097.4 6113.7 6121.0 6140.4 6144.4 6016.6 6025.0 6090.4 6185.1 6191.3 3639.3 5191.1 5385.8 5388.0 5440.3 21512.5 21572.0 21667.8 22728.3 22810.3 2374.8 2663.6 2684.7 2711.2 2736.7 13861.1 13863.7 14048.7 14056.4 14404.6 1894.3 1930.4 1945.4 1965.8 1985.7 68275.0 69414.3 69764.7 70675.3 71376.0 9466.2 9767.3 10112.6 10188.1 10204.4 13690.8 13790.2 13813.1 13853.2 13862.4 8055.2 8102.3 8169.0 8252.1 8304.3 8195.8 8215.7 8245.4 8268.8 8292.6 6031.7 6159.2 6228.3 6231.4 6259.5 1656.2 1715.6 1734.3 1797.7 1800.6 963.8 1057.3 1105.3 1158.4 1167.5 17340.2 18116.2 18770.1 18956.2 19139.8 1009.9 1016.9 1024.4 1048.3 1091.7 9751.7 11008.7 11017.2 11029.2 11052.2 422703.0 427320.0 435198.0 437090.0 484957.0 71361.3 71845.3 72325.6 73509.0 73637.0 1072.5 1083.5 1097.5 1111.9 1112.1 16728.7 16735.7 16738.1 16769.6 16920.3 34223.7 34441.3 34792.8 35264.1 35481.1 47317.5 47688.0 47895.9 47943.8 49605.0 8340.2 8425.7 8449.8 8482.1 8531.5 12576.7 13265.5 13396.6 13457.4 13549.7 11353.8 11585.2 11876.6 11889.8 12013.4 11365.3 11571.7 11706.2 11757.8 11956.7 11867.6 11996.6 12046.9 12054.5 12177.2 8264.0 8289.3 8340.2 8376.9 8407.8 11672.0 12035.5 12051.8 12067.0 12081.3 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#3] mootools.html Cycles:180 Average:5662.55 Median:4918.70 stddev:3038.90 (61.8%) stddev-sans-first:3030.15 10:10:52 INFO - PROCESS | 2497 | Values: 1352.1 1500.4 1505.2 1679.3 1825.6 7698.2 7887.2 7887.4 7920.8 7936.3 7741.1 7921.4 7924.5 7925.6 7927.1 1926.6 2213.8 2275.8 2275.9 2289.1 2220.6 2236.9 2251.5 2252.8 2254.6 2169.3 2231.9 2235.7 2237.8 2241.6 2239.9 2241.6 2249.8 2295.0 2295.0 2248.3 2280.3 2282.5 2301.1 2301.3 8165.1 8214.7 8227.2 8238.5 8252.0 4793.9 4911.2 4916.9 4917.4 4928.0 3193.2 3206.9 3234.8 3250.3 3255.4 1043.2 1055.9 1058.9 1081.5 1089.3 11389.9 11431.4 11433.7 11433.9 11448.1 4194.4 4200.7 4209.7 4218.1 4238.3 9617.8 9623.8 9676.9 9712.2 9715.5 4265.1 4878.4 4881.8 4920.0 4921.7 4468.3 4494.0 4514.1 4521.4 4567.8 3655.2 3710.1 3723.0 3735.7 3791.6 1168.6 1168.8 1172.2 1173.4 1190.5 1369.7 1387.8 1390.5 1434.6 1435.6 7797.6 7977.7 7978.1 7979.6 7983.3 434.1 439.5 441.7 442.6 464.6 6037.6 6072.8 6089.2 6130.5 6132.7 9548.2 10198.9 10331.5 10334.4 10336.7 10022.7 10115.4 10133.3 10155.4 10213.5 7477.3 7568.1 7589.6 7674.3 7694.5 7477.3 7479.1 7621.1 7626.8 7629.7 8663.4 8794.5 8898.0 8950.9 9029.1 8900.3 9009.6 9113.8 9139.6 9158.1 6437.1 6595.6 6601.5 7243.4 7368.5 7513.7 7632.5 7636.0 7643.8 7648.7 6721.9 6903.7 6958.8 6963.1 7058.2 6860.7 6867.3 6925.4 6973.4 7060.2 7127.3 7200.1 7232.0 7249.4 7301.9 6785.3 6804.3 6831.6 6878.5 6893.4 6728.4 6748.3 6760.1 6808.7 6810.9 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#4] prototype.html Cycles:180 Average:5275.13 Median:6096.32 stddev:1656.86 (27.2%) stddev-sans-first:1618.61 10:10:52 INFO - PROCESS | 2497 | Values: 284.8 292.2 297.2 298.0 304.8 5994.9 6003.2 6048.1 6052.0 6064.2 5974.3 5990.8 5993.5 5996.4 6006.7 4249.8 4417.3 4523.6 4527.2 4540.7 4502.8 4517.0 4527.8 4539.6 4545.7 4236.1 4466.5 4474.5 4479.8 4484.0 4349.4 4435.7 4436.7 4453.6 4466.5 3868.6 3870.9 3875.7 3879.4 3890.1 5770.3 5782.2 5791.7 5792.3 5799.2 5155.7 5162.5 5163.7 5166.9 5172.4 6265.1 6272.7 6274.3 6277.8 6280.5 4014.9 4116.9 4117.1 4120.1 4260.4 6524.4 6570.0 6653.0 6664.9 6667.7 4255.2 4256.5 4257.3 4260.4 4268.7 4297.1 4299.1 4302.9 4304.0 4308.7 5056.3 5104.4 5105.6 5116.9 5121.6 6240.6 6367.1 6382.6 6387.2 6388.3 1477.3 1489.0 1496.9 1499.5 1501.9 910.2 959.2 971.2 991.3 996.4 6030.8 6035.6 6045.6 6048.4 6088.7 6472.9 6517.5 6552.4 6554.8 6555.4 6103.9 6109.7 6116.8 6118.3 6120.2 3470.3 3495.5 3502.0 3502.1 3505.0 6625.5 6764.5 6779.4 6874.2 6879.0 6665.3 6717.2 6734.6 6765.9 6768.3 6872.2 6878.8 6881.3 6888.2 6888.6 6645.4 6660.0 6663.3 6672.0 6677.2 6317.8 6497.4 6535.5 6540.3 6561.4 6795.8 6821.7 6863.9 6871.5 6884.0 4400.1 4439.7 4450.8 4457.0 4460.9 6539.1 6541.0 6548.6 6554.4 6555.0 6281.5 6399.1 6401.0 6401.4 6411.9 6376.9 6414.2 6423.1 6429.1 6430.0 6329.6 6376.9 6377.3 6380.3 6385.2 6434.2 6443.7 6455.1 6458.4 6466.2 6014.6 6179.6 6304.6 6309.6 6387.7 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - PROCESS | 2497 | [#5] yui.html Cycles:180 Average:15137.79 Median:25586.69 stddev:17563.08 (68.6%) stddev-sans-first:17579.12 10:10:52 INFO - PROCESS | 2497 | Values: 751.4 816.7 829.4 845.6 883.2 14453.6 14506.5 14561.0 14561.7 14610.2 12842.5 12910.0 12919.3 12949.3 12961.2 654.7 819.4 833.3 833.6 834.1 827.3 832.8 833.2 833.6 833.9 698.0 874.4 875.0 875.9 876.8 702.0 872.1 883.7 885.0 885.6 642.7 643.3 643.3 643.4 643.7 14095.8 14112.9 14149.1 14154.6 14158.6 13462.7 14065.5 14099.8 14111.6 14736.3 11578.1 11679.6 11681.6 11698.0 11699.1 3849.4 3857.5 3911.4 3941.8 4011.0 54009.2 54118.7 54529.2 54763.2 54932.5 11393.1 11411.9 11460.5 11513.5 11810.1 20380.5 20456.0 20468.7 20468.7 20497.2 8554.1 8674.0 8679.8 8824.4 8892.0 4337.6 4709.9 4717.1 4759.3 4782.3 3293.8 3309.6 3316.8 3318.7 3332.2 585.3 601.9 607.9 609.4 610.8 628.0 634.1 704.4 761.9 798.6 8505.6 8573.7 8737.0 8819.6 9171.0 742.2 746.9 756.1 784.8 790.0 4122.6 4182.0 4227.2 4227.5 4277.0 61873.7 62066.4 64647.4 65292.3 65414.0 54424.5 56169.4 56453.0 56640.4 56656.0 49574.5 49663.8 50501.5 51172.9 51275.7 8373.6 8543.4 8563.1 8568.3 8712.2 36598.0 37070.4 37563.4 37892.8 39024.8 46835.8 47453.8 47621.5 48911.0 49361.8 12063.7 12156.7 12614.2 12668.4 13039.7 11896.3 12946.4 14031.4 14438.1 14446.5 13111.1 13161.9 13348.9 13535.8 13651.0 11670.6 11775.9 11810.0 12802.5 13106.3 12688.8 12729.3 12811.7 12991.2 13074.4 10892.1 11296.5 11395.8 11405.8 11546.4 10170.5 10253.7 10379.2 10399.4 10415.9 10:10:52 INFO - PROCESS | 2497 | -------- Summary: end -------- 10:10:52 INFO - PROCESS | 2497 | 10:10:52 INFO - TEST-INFO | 2497: exit 0 10:10:52 INFO - TEST-OK | dromaeo_css | took 1110748ms 10:10:52 INFO - TEST-START | kraken 10:10:52 INFO - operating with platform_type : linux_ 10:10:52 INFO - Initialising browser for kraken test... 10:10:52 INFO - TEST-INFO | started process 2702 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp07mWsG/profile http://localhost:50687/getInfo.html) 10:10:56 INFO - PROCESS | 2702 | __metrics Screen width/height:1600/1200 10:10:56 INFO - PROCESS | 2702 | colorDepth:24 10:10:56 INFO - PROCESS | 2702 | Browser inner width/height: 1024/697 10:10:56 INFO - PROCESS | 2702 | __metrics 10:10:57 ERROR - PROCESS | 2702 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:10:57 INFO - PROCESS | 2702 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:10:58 INFO - TEST-INFO | 2702: exit 0 10:10:58 INFO - Browser initialized. 10:10:58 INFO - Running cycle 1/1 for kraken test... 10:10:58 INFO - TEST-INFO | started process 2868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp07mWsG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:11:10 INFO - PROCESS | 2868 | RSS: Main: 153419776 10:11:10 INFO - PROCESS | 2868 | 10:11:12 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:13 INFO - PROCESS | 2868 | RSS: Main: 194715648 10:11:13 INFO - PROCESS | 2868 | 10:11:15 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-dft) 10:11:16 INFO - PROCESS | 2868 | RSS: Main: 183967744 10:11:16 INFO - PROCESS | 2868 | 10:11:19 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-fft) 10:11:20 INFO - PROCESS | 2868 | RSS: Main: 168513536 10:11:20 INFO - PROCESS | 2868 | 10:11:22 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50687/tests/kraken/driver.html?testName=audio-oscillator) 10:11:22 INFO - PROCESS | 2868 | RSS: Main: 171442176 10:11:22 INFO - PROCESS | 2868 | 10:11:24 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:25 INFO - PROCESS | 2868 | RSS: Main: 172843008 10:11:25 INFO - PROCESS | 2868 | 10:11:28 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:29 INFO - PROCESS | 2868 | RSS: Main: 173813760 10:11:29 INFO - PROCESS | 2868 | 10:11:32 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50687/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:33 INFO - PROCESS | 2868 | RSS: Main: 173748224 10:11:33 INFO - PROCESS | 2868 | 10:11:35 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50687/tests/kraken/driver.html?testName=json-parse-financial) 10:11:36 INFO - PROCESS | 2868 | RSS: Main: 173621248 10:11:36 INFO - PROCESS | 2868 | 10:11:37 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:38 INFO - PROCESS | 2868 | RSS: Main: 183574528 10:11:38 INFO - PROCESS | 2868 | 10:11:40 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:40 INFO - PROCESS | 2868 | RSS: Main: 182673408 10:11:40 INFO - PROCESS | 2868 | 10:11:42 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:43 INFO - PROCESS | 2868 | RSS: Main: 194289664 10:11:43 INFO - PROCESS | 2868 | 10:11:45 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:46 INFO - PROCESS | 2868 | RSS: Main: 200835072 10:11:46 INFO - PROCESS | 2868 | 10:11:48 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:49 INFO - PROCESS | 2868 | RSS: Main: 198983680 10:11:49 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | Cycle 1(1): loaded http://localhost:50687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50687/tests/kraken/driver.html?testName=ai-astar) 10:11:51 INFO - PROCESS | 2868 | RSS: Main: 261283840 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | __start_tp_report 10:11:51 INFO - PROCESS | 2868 | _x_x_mozilla_page_load 10:11:51 INFO - PROCESS | 2868 | _x_x_mozilla_page_load_details 10:11:51 INFO - PROCESS | 2868 | |i|pagename|runs| 10:11:51 INFO - PROCESS | 2868 | |0;ai-astar;110;112;105;111;111;110;100;111;110;111 10:11:51 INFO - PROCESS | 2868 | |1;audio-beat-detection;162;127;153;177;127;163;152;136;193;130 10:11:51 INFO - PROCESS | 2868 | |2;audio-dft;163;162;162;162;160;160;160;165;160;162 10:11:51 INFO - PROCESS | 2868 | |3;audio-fft;75;76;115;104;76;72;71;134;105;72 10:11:51 INFO - PROCESS | 2868 | |4;audio-oscillator;93;91;136;92;93;92;139;92;91;150 10:11:51 INFO - PROCESS | 2868 | |5;imaging-gaussian-blur;118;117;117;116;117;116;116;116;117;116 10:11:51 INFO - PROCESS | 2868 | |6;imaging-darkroom;146;146;147;146;147;146;147;147;147;145 10:11:51 INFO - PROCESS | 2868 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 10:11:51 INFO - PROCESS | 2868 | |8;json-parse-financial;58;58;56;57;56;57;56;67;57;57 10:11:51 INFO - PROCESS | 2868 | |9;json-stringify-tinderbox;60;61;60;60;60;60;60;60;61;61 10:11:51 INFO - PROCESS | 2868 | |10;stanford-crypto-aes;78;79;79;78;78;78;79;79;78;79 10:11:51 INFO - PROCESS | 2868 | |11;stanford-crypto-ccm;124;111;111;114;113;109;109;109;112;111 10:11:51 INFO - PROCESS | 2868 | |12;stanford-crypto-pbkdf2;144;148;145;143;145;144;143;145;147;145 10:11:51 INFO - PROCESS | 2868 | |13;stanford-crypto-sha256-iterative;63;63;65;63;63;61;61;64;62;61 10:11:51 INFO - PROCESS | 2868 | __end_tp_report 10:11:51 INFO - PROCESS | 2868 | __start_cc_report 10:11:51 INFO - PROCESS | 2868 | _x_x_mozilla_cycle_collect,1079 10:11:51 INFO - PROCESS | 2868 | __end_cc_report 10:11:51 INFO - PROCESS | 2868 | __startTimestamp1459098711334__endTimestamp 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | ------- Summary: start ------- 10:11:51 INFO - PROCESS | 2868 | Number of tests: 14 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.73 (3.4%) stddev-sans-first:3.94 10:11:51 INFO - PROCESS | 2868 | Values: 110.0 112.0 105.0 111.0 111.0 110.0 100.0 111.0 110.0 111.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:157.50 stddev:22.41 (14.2%) stddev-sans-first:23.47 10:11:51 INFO - PROCESS | 2868 | Values: 162.0 127.0 153.0 177.0 127.0 163.0 152.0 136.0 193.0 130.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.67 10:11:51 INFO - PROCESS | 2868 | Values: 163.0 162.0 162.0 162.0 160.0 160.0 160.0 165.0 160.0 162.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#3] audio-fft Cycles:10 Average:90.00 Median:72.00 stddev:22.63 (31.4%) stddev-sans-first:23.34 10:11:51 INFO - PROCESS | 2868 | Values: 75.0 76.0 115.0 104.0 76.0 72.0 71.0 134.0 105.0 72.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:24.25 (26.4%) stddev-sans-first:25.19 10:11:51 INFO - PROCESS | 2868 | Values: 93.0 91.0 136.0 92.0 93.0 92.0 139.0 92.0 91.0 150.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 10:11:51 INFO - PROCESS | 2868 | Values: 118.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:11:51 INFO - PROCESS | 2868 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 145.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:11:51 INFO - PROCESS | 2868 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.00 stddev:3.28 (5.8%) stddev-sans-first:3.48 10:11:51 INFO - PROCESS | 2868 | Values: 58.0 58.0 56.0 57.0 56.0 57.0 56.0 67.0 57.0 57.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:11:51 INFO - PROCESS | 2868 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:79.00 stddev:0.53 (0.7%) stddev-sans-first:0.53 10:11:51 INFO - PROCESS | 2868 | Values: 78.0 79.0 79.0 78.0 78.0 78.0 79.0 79.0 78.0 79.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:111.50 stddev:4.45 (4.0%) stddev-sans-first:1.80 10:11:51 INFO - PROCESS | 2868 | Values: 124.0 111.0 111.0 114.0 113.0 109.0 109.0 109.0 112.0 111.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:145.00 stddev:1.60 (1.1%) stddev-sans-first:1.66 10:11:51 INFO - PROCESS | 2868 | Values: 144.0 148.0 145.0 143.0 145.0 144.0 143.0 145.0 147.0 145.0 10:11:51 INFO - PROCESS | 2868 | 10:11:51 INFO - PROCESS | 2868 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 10:11:51 INFO - PROCESS | 2868 | Values: 63.0 63.0 65.0 63.0 63.0 61.0 61.0 64.0 62.0 61.0 10:11:51 INFO - PROCESS | 2868 | -------- Summary: end -------- 10:11:51 INFO - PROCESS | 2868 | 10:11:52 INFO - TEST-INFO | 2868: exit 0 10:11:52 INFO - TEST-OK | kraken | took 59432ms 10:11:52 INFO - SUITE-END | took 1170s 10:11:52 INFO - Completed test suite (00:19:30) 10:11:52 INFO - javascript benchmark 10:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3069.155982104921, 3089.752819774418, 3127.2025633463477, 3128.827914464705, 3162.810231386117, 5115.258287548312, 5125.718085505296, 5168.948310516894, 5173.637845350827, 5243.606729495284, 5231.503007214318, 5237.292965449663, 5323.467653234675, 5329.626926115174, 5331.0, 4651.232546629802, 4736.502667219936, 4772.188727916246, 4775.164346239411, 4821.035792841428, 4650.604698600623, 4730.195866702668, 4755.429348478187, 4780.713157210561, 4818.614510839142, 4818.229083346665, 4856.15017371962, 4856.538628830255, 4881.804727810883, 4887.193613053842, 4667.323238130486, 4669.0, 4675.812967481296, 4684.859454216379, 4718.363020992157, 4621.23749581322, 4640.489546149921, 4649.535046495357, 4720.409948756405, 4735.526447355237, 5226.268322434862, 5228.451012643655, 5232.502912223333, 5236.6857988520815, 5250.212468129773, 5628.690422026787, 5638.605297629168, 5640.802571910004, 5642.294713160855, 5662.122371032456, 5478.726063696839, 5588.636738611977, 5690.516306113986, 5707.571932105067, 5710.486056254916, 5174.4825517448335, 5174.4825517448335, 5177.19753438214, 5199.402068762065, 5224.0, 5618.269624948731, 5622.522085622686, 5626.240457538262, 5628.099504079328, 5638.464345887134, 5372.785088596413, 5417.729113544307, 5444.346678398618, 5519.834404967857, 5607.579431542651, 5436.7281635918835, 5448.482394172547, 5449.64577302474, 5452.591055670761, 5512.91730624041, 5434.103372943499, 5437.429069947678, 5442.972785136049, 5445.646033007842, 5488.91766623501, 5376.569874410038, 5474.288342515448, 5480.671159730429, 5556.333240011225, 5578.888422231533, 4252.362145678173, 4256.255155347863, 4266.232078225887, 4272.786360681954, 4302.591253830881, 3822.522184726909, 3828.8659896903473, 3830.3105441020884, 3857.8263978121054, 3858.2090671412293, 5101.464346243665, 5288.81489147878, 5339.172428273624, 5384.6499977501335, 5392.110301800238, 5635.605507614509, 5653.265075540154, 5675.3757086720425, 5692.8861422771315, 5696.772129114872, 5102.795888164506, 5355.277037599874, 5379.960322417822, 5380.838574842761, 5419.485148910847, 4838.371011768448, 4880.072786170687, 4883.194272944925, 4919.212925931905, 4929.605631549467, 5640.210370548127, 5647.124695672177, 5649.0, 5663.0, 5691.601587888891, 5370.731463426735, 5452.100403433547, 5454.400015998316, 5492.505674489315, 5521.917171242515, 5776.249087618751, 5812.389699081536, 5813.738381772746, 5843.824685259279, 5863.560232982458, 5461.890762184814, 5501.284832971688, 5518.2826232589505, 5518.779248830002, 5524.033294173423, 5329.546988505866, 5521.033819081725, 5604.0, 5622.718864056863, 5631.1271752878365, 5385.030694475032, 5392.191171324333, 5395.217693434509, 5426.023315803035, 5442.4557544246845, 5346.144616861284, 5347.919781203207, 5353.946460535345, 5373.865653358697, 5394.811181608625, 5188.988147311389, 5195.116830138961, 5258.710770907637, 5267.07826130418, 5297.258383826191, 5489.4236105209975, 5492.148716948879, 5493.313335833021, 5493.807716729895, 5494.395616482104, 5326.840194794162, 5374.785008599612, 5374.811881584125, 5376.73116344189, 5388.865278368072], "unit": "score", "name": "dojo.html", "value": 5135.003691890595}, {"lowerIsBetter": false, "replicates": [560.9465482664104, 574.4255744255744, 575.0282023380487, 601.4737105033095, 624.2851934534957, 28953.0, 29377.559336609967, 37992.99999999996, 38683.22633547327, 38743.031424214336, 41503.0, 41871.790641046755, 41957.58042419575, 42022.36966445498, 42112.57887421125, 8894.110588941103, 9015.0, 9085.818283634324, 9109.863352049691, 9113.863292050624, 7440.702371905118, 10634.36193828369, 10846.457677116152, 10880.0, 10886.455677216147, 10570.735731606694, 10682.305650132717, 10685.0, 10689.037986581206, 10694.946525267402, 10721.517531711053, 10785.083267922237, 10819.404932728736, 10819.83770243447, 10822.080123189538, 10620.097291730135, 10734.892651073467, 10742.3017503862, 10744.838827417596, 10760.40817755023, 38376.0, 38419.42370864439, 38616.80691596552, 38675.61324386748, 38700.41949370762, 3446.052335607703, 3685.68671662909, 3895.4935858338517, 3931.8820435386983, 4331.956680433187, 31364.686353136403, 31836.20409489758, 31976.200594985312, 32102.0, 32236.0, 3398.8810391636175, 3478.617352091268, 3502.282032183422, 3540.061883600848, 3590.5152804371596, 255670.0, 258066.0, 258235.0, 259400.0, 260032.0, 49056.0, 49761.50238497568, 60302.396976030555, 60691.69654151701, 60700.69649651812, 46963.29555056677, 46974.53025469701, 47079.0, 47106.0, 47376.28935565969, 13535.05254632186, 13537.729245415037, 13544.255065971467, 13544.729105417837, 13561.796573051412, 10104.292699510963, 12492.312922789151, 12508.81236781449, 12613.936930315289, 12668.49326026967, 16008.919955400148, 16033.358665653477, 16124.435644752377, 16163.272652730655, 16584.6683066338, 6122.602030868068, 6150.323464418911, 6278.434940855345, 6291.1192433059405, 6308.653024083627, 1005.5525291245472, 1071.6249312740479, 1089.8964598363143, 1133.3539882267194, 1152.2567943676281, 32588.701694696298, 32692.806803889114, 32788.0, 32995.505067424005, 33056.0, 1101.1466113761899, 1123.4270522033821, 1174.5947648061406, 1177.5996161305197, 1217.4825699077855, 16874.240659170366, 16924.153792310335, 16950.40673576419, 16962.66074678524, 16963.575910602332, 400827.0, 405123.0, 405750.0, 406652.0, 406888.0, 57271.0, 57820.71089644525, 58230.417695823344, 58258.417415826145, 58287.70856145692, 1220.3776074202221, 1365.3378111616057, 1400.2578633324354, 1411.9364628591738, 1436.7141408439388, 28403.431931360843, 30894.22764430907, 31947.520787188674, 32478.188045298113, 33022.17444563905, 45325.0, 45687.771561141984, 45732.31401528913, 45760.0, 45781.54218457773, 266107.0, 266959.0, 268391.0, 268761.0, 269706.0, 37640.43539346857, 38820.0, 38914.4162837552, 39297.80351098226, 39349.60650393459, 47457.0, 47463.0, 47837.0, 48250.0, 48708.269375960095, 40011.0, 40283.79858100691, 41072.1785564293, 41303.38044929269, 42329.365059524745, 38937.0, 39408.6059139405, 39815.80092099521, 40319.3952090713, 40478.190436190525, 40706.796466017484, 41599.37600936049, 41748.0, 42069.36895946624, 42217.78891105648, 34524.82737586296, 35413.82293088518, 36161.45757813582, 36172.81913590415, 36490.27019459649, 27989.86005070043, 28091.578626320214, 28486.715132848407, 28522.57216141801, 28610.570841437813], "unit": "score", "name": "ext.html", "value": 19329.69007944036}, {"lowerIsBetter": false, "replicates": [352.82535145103196, 365.15831009523055, 367.94296883982986, 367.96320367963193, 371.62465909431484, 17428.825711742895, 18013.549661258476, 18292.176852041655, 18685.159167837446, 18717.0, 17246.482605521855, 17994.730079048826, 18674.346397876077, 18682.25270989159, 18692.626147477044, 5519.172124181385, 5685.488306052454, 5710.457506536873, 5712.771489140429, 5714.571407144481, 4015.217032678629, 5642.858928526799, 5898.233229680157, 6144.84637884052, 6175.382461753834, 6097.420745029215, 6113.6943152842405, 6121.0, 6140.35526269742, 6144.44699977002, 6016.608920420181, 6025.0, 6090.421409966046, 6185.072239164161, 6191.349908259613, 3639.290338384016, 5191.091558977201, 5385.78456861725, 5388.030154572176, 5440.265564148829, 21512.494125411227, 21572.0, 21667.783322166735, 22728.318150455514, 22810.31569052931, 2374.7743964323363, 2663.5738281874806, 2684.7181045990087, 2711.159540542438, 2736.7126451722484, 13861.099028563212, 13863.722725545533, 14048.71902561943, 14056.437742490289, 14404.63988400288, 1894.2801735340483, 1930.3533316338903, 1945.4163750874682, 1965.8132477414622, 1985.6525108106023, 68275.0, 69414.30585694179, 69764.6511767443, 70675.29324706738, 71376.0, 9466.1953733932, 9767.316287859781, 10112.59549618007, 10188.134008609202, 10204.38773673582, 13690.794638080437, 13790.172589644653, 13813.102148360324, 13853.16880987144, 13862.376193071335, 8055.194480551898, 8102.270795628304, 8169.0, 8252.05101413345, 8304.252617264476, 8195.754127376189, 8215.712450064339, 8245.381596380295, 8268.793280167924, 8292.626831792462, 6031.698415079229, 6159.19930409044, 6228.34602366754, 6231.40801623845, 6259.530535209878, 1656.21329868314, 1715.5882588178747, 1734.3149455965076, 1797.748315235868, 1800.5526349915688, 963.7735132243918, 1057.2704833664748, 1105.2815669814524, 1158.3744777820052, 1167.5154810753443, 17340.219690113976, 18116.184771685304, 18770.13670655188, 18956.24175032983, 19139.808601914083, 1009.8939611340851, 1016.898310168992, 1024.3904876598413, 1048.2557384257111, 1091.7216109892086, 9751.707448776548, 11008.724781880517, 11017.228793984505, 11029.22795404314, 11052.171087168495, 422703.0, 427320.0, 435198.0, 437090.0, 484957.0, 71361.2863871365, 71845.28154718385, 72325.6383718078, 73509.0, 73637.0, 1072.5334479501441, 1083.4961742789799, 1097.533548241994, 1111.90548803351, 1112.1158678850334, 16728.665426691154, 16735.74896376531, 16738.07940563281, 16769.580760481087, 16920.31785664729, 34223.657763422045, 34441.311173776885, 34792.82603586966, 35264.11839704028, 35481.1129721759, 47317.526824731314, 47688.0, 47895.88497768964, 47943.760281198374, 49605.0, 8340.207680270365, 8425.747227583182, 8449.831003379775, 8482.066972632882, 8531.488110713377, 12576.74846503083, 13265.535706250235, 13396.598102056954, 13457.394417251444, 13549.661258468223, 11353.829692554784, 11585.246958947642, 11876.643700688994, 11889.762204756029, 12013.399330033639, 11365.31808091517, 11571.6528504145, 11706.239094458833, 11757.76484470323, 11956.701082473008, 11867.58463453775, 11996.580119696118, 12046.939765301116, 12054.457549410474, 12177.208481448677, 8263.95868020656, 8289.295409889986, 8340.249377556049, 8376.916230837614, 8407.789805254917, 11672.0, 12035.45840437165, 12051.75896482083, 12067.034637228826, 12081.275123492618], "unit": "score", "name": "jquery.html", "value": 9093.418536524177}, {"lowerIsBetter": false, "replicates": [1352.1008529327996, 1500.4073391010552, 1505.194720824359, 1679.2611251049536, 1825.625746721923, 7698.191689872567, 7887.21127887211, 7887.447878648497, 7920.762377128681, 7936.285734283913, 7741.148473667906, 7921.366290696745, 7924.524528528293, 7925.643346049427, 7927.088384835745, 1926.6050459655737, 2213.8339624528144, 2275.7951784339407, 2275.8862056897174, 2289.050044231642, 2220.555888822234, 2236.944076398095, 2251.549690061986, 2252.7747225277503, 2254.5716313900307, 2169.2841362350464, 2231.85492942959, 2235.7093577834858, 2237.7538470768204, 2241.551689662066, 2239.899204535792, 2241.6413373860187, 2249.8200143988443, 2295.01314434793, 2295.036084844353, 2248.325502349289, 2280.3159052284414, 2282.5320809234067, 2301.0910690277415, 2301.2866011536476, 8165.061017982948, 8214.712485062993, 8227.218414250696, 8238.50568965864, 8252.0, 4793.880152996168, 4911.214205727102, 4916.926246106311, 4917.40991081069, 4928.0, 3193.2176616728816, 3206.8556914938886, 3234.7897386669792, 3250.2686895448574, 3255.397751415972, 1043.228011271661, 1055.8996895294936, 1058.8782290036668, 1081.5133190064503, 1089.3355053417408, 11389.943050284779, 11431.371274579895, 11433.656990290305, 11433.885661143366, 11448.141389395745, 4194.3918131870705, 4200.663946884242, 4209.663226941837, 4218.135282267128, 4238.321868501025, 9617.759556011015, 9623.759406014906, 9676.854847177297, 9712.22302215821, 9715.46564938921, 4265.1469706058915, 4878.43897951733, 4881.780319885614, 4920.0, 4921.655484116078, 4468.285074388083, 4494.0, 4514.052049069732, 4521.389612402284, 4567.794449249792, 3655.1593133579427, 3710.109573702292, 3722.9813850931114, 3735.6824669902817, 3791.639794219545, 1168.567629976897, 1168.8363629091934, 1172.1853311948114, 1173.372245848484, 1190.5118901250446, 1369.6931827761764, 1387.8057072009926, 1390.506370238571, 1434.5552878607666, 1435.6410897275682, 7797.610119494116, 7977.7207797726805, 7978.082520510099, 7979.640916158787, 7983.321417679446, 434.1165727744026, 439.54726631569537, 441.6731618602211, 442.63703762914747, 464.61901240982746, 6037.63774173551, 6072.7570897164505, 6089.238845144357, 6130.5402094842175, 6132.6933653317155, 9548.1884039856, 10198.878123406419, 10331.535080921227, 10334.431606261727, 10336.741581460374, 10022.699319020441, 10115.443650599287, 10133.341332813343, 10155.441450720282, 10213.489325533843, 7477.327040566375, 7568.053993250844, 7589.620518974029, 7674.309312161932, 7694.461387702919, 7477.289657482531, 7479.102507699111, 7621.123570789208, 7626.847463050819, 7629.7329593463965, 8663.39356245082, 8794.472331659865, 8898.0, 8950.910490895008, 9029.051949545466, 8900.332475064526, 9009.594568244314, 9113.77215569616, 9139.63441462334, 9158.129977652112, 6437.130987316839, 6595.637239951849, 6601.471882249504, 7243.3843123333, 7368.4842061055215, 7513.661885215288, 7632.503887247533, 7635.961820190863, 7643.770686879402, 7648.65581048843, 6721.865562688621, 6903.723851045902, 6958.756443524655, 6963.1296087989, 7058.188308344606, 6860.656967151723, 6867.278935711878, 6925.411340035952, 6973.407260382722, 7060.223375428596, 7127.287271273039, 7200.063991681048, 7231.963840180976, 7249.420046396381, 7301.890471642823, 6785.287544807724, 6804.251532331341, 6831.59010459374, 6878.484113691393, 6893.448524118159, 6728.394444500019, 6748.291429399842, 6760.053592496956, 6808.727650894107, 6810.897836532356], "unit": "score", "name": "mootools.html", "value": 4526.2817651854975}, {"lowerIsBetter": false, "replicates": [284.82910253847695, 292.1513004721284, 297.15163209038195, 297.9806312589683, 304.8445292900621, 5994.8801023979495, 6003.189569408129, 6048.062550304699, 6052.031674932017, 6064.241969753781, 5974.253218347707, 5990.760369585222, 5993.520518358532, 5996.430339117787, 6006.669633170185, 4249.80875860587, 4417.315316126005, 4523.592876641102, 4527.185106680796, 4540.682152249344, 4502.77486125694, 4517.0, 4527.849271595982, 4539.568740969603, 4545.704529205607, 4236.110416812473, 4466.464024317086, 4474.530174331697, 4479.8432054878085, 4484.0, 4349.369341445488, 4435.711678740888, 4436.73379597222, 4453.554644535553, 4466.486354069259, 3868.5551161616213, 3870.9225815483815, 3875.670568001723, 3879.3792993120965, 3890.0858298299877, 5770.336411312669, 5782.190493330937, 5791.710414479259, 5792.333881603628, 5799.18811366409, 5155.66488178271, 5162.483751624845, 5163.66436181647, 5166.948330516722, 5172.405173405069, 6265.0915617235705, 6272.717727702218, 6274.278457977345, 6277.843053923642, 6280.466160376373, 4014.859479918218, 4116.876493705194, 4117.114820313647, 4120.134771697947, 4260.44614200152, 6524.380183882524, 6569.967150164266, 6653.002049692536, 6664.900026499607, 6667.733290668416, 4255.1915136124035, 4256.4679415073115, 4257.254980378421, 4260.382244574519, 4268.722533035343, 4297.097609501977, 4299.097189590158, 4302.913941721211, 4304.0, 4308.698391112592, 5056.292119103328, 5104.438511763703, 5105.617078719111, 5116.872078198075, 5121.564667003347, 6240.563160578807, 6367.108604795332, 6382.6170429774365, 6387.201599800025, 6388.329225431356, 1477.253986736691, 1488.9553313400615, 1496.8773419935048, 1499.5426394949645, 1501.872340851018, 910.1762904571374, 959.2326139088701, 971.1599466461602, 991.2565575818137, 996.3822430093388, 6030.849228769316, 6035.6076855004285, 6045.6070355426755, 6048.395160484004, 6088.726007329681, 6472.93196622552, 6517.543771935919, 6552.443042341454, 6554.80335589933, 6555.3772391622715, 6103.908441373383, 6109.694515274218, 6116.816495505142, 6118.265808103056, 6120.234970628671, 3470.27124303899, 3495.5106285120105, 3501.964980350215, 3502.1419752160373, 3505.018594793462, 6625.536212465081, 6764.458843292623, 6779.35596118368, 6874.175098988154, 6879.0, 6665.266820649725, 6717.227518835299, 6734.56225345351, 6765.898511522331, 6768.323167683291, 6872.244053154149, 6878.793636190922, 6881.277465866012, 6888.207856096613, 6888.621125838127, 6645.435138013323, 6660.0, 6663.333666633298, 6672.032555279555, 6677.198736151498, 6317.842053948688, 6497.382748638872, 6535.477161826947, 6540.345965403421, 6561.40947314744, 6795.830104247433, 6821.727130914906, 6863.931360686529, 6871.5189936703955, 6884.036234927014, 4400.097979914046, 4439.667024973075, 4450.799714012942, 4457.04173602677, 4460.888477788081, 6539.051837483634, 6540.967295163684, 6548.639824809491, 6554.442872355903, 6554.967225163844, 6281.497480201664, 6399.136116624382, 6401.0, 6401.3598640135615, 6411.871762564816, 6376.87246255063, 6414.198225221848, 6423.068655044899, 6429.067785171217, 6429.9678501607195, 6329.556931014785, 6376.87246255063, 6377.330380310186, 6380.330065343072, 6385.233771947396, 6434.227892652724, 6443.67781610927, 6455.128557644658, 6458.354164583692, 6466.159399278064, 6014.578979471395, 6179.567430280017, 6304.621722696653, 6309.589876658002, 6387.744490220339], "unit": "score", "name": "prototype.html", "value": 4712.381642695264}, {"lowerIsBetter": false, "replicates": [751.4362047514956, 816.734561267588, 829.3613917283692, 845.556083056395, 883.1742320929927, 14453.638659033517, 14506.492272770454, 14561.0, 14561.708765824691, 14610.196439195866, 12842.486300547967, 12910.0, 12919.289439080847, 12949.287789171616, 12961.157524760883, 654.6595770199493, 819.4100247821559, 833.2500749325595, 833.6165363932598, 834.1366685480529, 827.3050637464529, 832.76682528892, 833.2459124492344, 833.5915401453275, 833.9416240863142, 697.979060628182, 874.3660845886714, 874.995625021874, 875.8642410426362, 876.8071024374627, 702.0171759536664, 872.0973792125152, 883.726044926075, 884.9646014159458, 885.5926273914007, 642.7011439680524, 643.2506130358128, 643.3437893348759, 643.3566433566433, 643.7231990244193, 14095.78856317156, 14112.85887141136, 14149.08030977983, 14154.575362739135, 14158.646033849132, 13462.663433414145, 14065.507707230197, 14099.78850317246, 14111.647208819759, 14736.336864841109, 11578.073754099736, 11679.591214307458, 11681.649550513499, 11698.0, 11699.122565807598, 3849.3648547989546, 3857.498525191707, 3911.3546264866263, 3941.8029098544957, 4011.0373510357595, 54009.189862152096, 54118.729406352715, 54529.1820622687, 54763.17855232175, 54932.450675493135, 11393.145514086476, 11411.942940285246, 11460.541578336773, 11513.539458421737, 11810.055195584333, 20380.490487737927, 20455.97720113988, 20468.69296960547, 20468.69296960547, 20497.180112795322, 8554.14458554152, 8674.0, 8679.783005424788, 8824.426412283181, 8891.955540222258, 4337.60961513459, 4709.905801883943, 4717.056033028346, 4759.286107083896, 4782.33047373368, 3293.7859039162377, 3309.6028476582483, 3316.7512436567354, 3318.7013168814924, 3332.150301673058, 585.2596465471182, 601.9067044608092, 607.9361118043424, 609.4210500024994, 610.7740136149653, 627.9811605651838, 634.1027446163719, 704.3977399323607, 761.9238076192337, 798.636620337745, 8505.574721263913, 8573.74278771638, 8736.956315218384, 8819.647214111492, 9171.0, 742.2206682982846, 746.932776050158, 756.1228974389682, 784.8077221080757, 789.9763007109796, 4122.56713045132, 4181.979090104591, 4227.154569086134, 4227.450431443893, 4277.0, 61873.690631547455, 62066.37933620696, 64647.35352646507, 65292.347076528626, 65414.0, 54424.45575544273, 56169.43830561642, 56453.0, 56640.43359566352, 56656.0, 49574.50425495771, 49663.75168124136, 50501.49498505115, 51172.92962422266, 51275.743621281654, 8373.62318695648, 8543.359248056297, 8563.100874408097, 8568.271696905584, 8712.172343627346, 36598.0, 37070.44394334141, 37563.436548452344, 37892.810535947145, 39024.80487597544, 46835.76582117067, 47453.762731187504, 47621.52378476171, 48911.0, 49361.753191233816, 12063.733308002533, 12156.696082598006, 12614.180078294881, 12668.366581670694, 13039.739205215652, 11896.345700986529, 12946.417411216706, 14031.438742450187, 14438.133711977314, 14446.494372696905, 13111.147775394951, 13161.934190328988, 13348.93325533366, 13535.79696304576, 13651.0, 11670.591529296435, 11775.882241177478, 11810.0, 12802.48790048425, 13106.344682766014, 12688.809667854805, 12729.29988850622, 12811.679708007374, 12991.220526768424, 13074.411651475517, 10892.074173695008, 11296.49165787558, 11395.772084558428, 11405.828912566483, 11546.422678865854, 10170.491475426052, 10253.692389228336, 10379.169666426818, 10399.428031458343, 10415.895841041493], "unit": "score", "name": "yui.html", "value": 6819.462526129628}], "name": "dromaeo_css", "value": 7129.25830832677}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 111.0, 110.0, 100.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [162.0, 127.0, 153.0, 177.0, 127.0, 163.0, 152.0, 136.0, 193.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 160.0, 160.0, 160.0, 165.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 115.0, 104.0, 76.0, 72.0, 71.0, 134.0, 105.0, 72.0], "unit": "score", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 136.0, 92.0, 93.0, 92.0, 139.0, 92.0, 91.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 57.0, 56.0, 57.0, 56.0, 67.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 60.3}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0, 79.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [124.0, 111.0, 111.0, 114.0, 113.0, 109.0, 109.0, 109.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 112.3}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 145.0, 143.0, 145.0, 144.0, 143.0, 145.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 65.0, 63.0, 63.0, 61.0, 61.0, 64.0, 62.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1494.3}]} 10:11:52 INFO - Return code: 0 10:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:11:52 ERROR - # TBPL SUCCESS # 10:11:52 INFO - Running post-action listener: _resource_record_post_action 10:11:52 INFO - Running post-run listener: _resource_record_post_run 10:11:53 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539160576; Read time: 8; Write time: 452288 10:11:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243236864; Read time: 0; Write time: 253756 10:11:53 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295923712; Read time: 8; Write time: 198532 10:11:53 INFO - Running post-run listener: _upload_blobber_files 10:11:53 INFO - Blob upload gear active. 10:11:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:11: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 10:11: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'] 10:11: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 10:11:54 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:54 INFO - (blobuploader) - INFO - Done attempting. 10:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:56 INFO - (blobuploader) - INFO - Done attempting. 10:11:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:56 INFO - Return code: 0 10:11:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:11:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39abd747a9578973f8734fe4be28200ffc3b66375f8e5f7ce7f22df3ebf839cdc77231abb55980d28b5f63a43906530b72d0086a1a7d44550223f92988741a47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ba02817822adcaa63aac7bb5b984d060d43e38dbe1e4efc08b3e3457db497b46b46ad0c6af78e687239fe2bee9529f6ed738d5da128dd53f046225213b2389"} 10:11:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:11:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:11:56 INFO - Contents: 10:11:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39abd747a9578973f8734fe4be28200ffc3b66375f8e5f7ce7f22df3ebf839cdc77231abb55980d28b5f63a43906530b72d0086a1a7d44550223f92988741a47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ba02817822adcaa63aac7bb5b984d060d43e38dbe1e4efc08b3e3457db497b46b46ad0c6af78e687239fe2bee9529f6ed738d5da128dd53f046225213b2389"} 10:11:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:56 INFO - Copying logs to upload dir... 10:11:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:11:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.449724 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-03-27 10:11:54.058567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 10:11:54.063114) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 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/39abd747a9578973f8734fe4be28200ffc3b66375f8e5f7ce7f22df3ebf839cdc77231abb55980d28b5f63a43906530b72d0086a1a7d44550223f92988741a47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ba02817822adcaa63aac7bb5b984d060d43e38dbe1e4efc08b3e3457db497b46b46ad0c6af78e687239fe2bee9529f6ed738d5da128dd53f046225213b2389"} build_url:https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/GrHXw0meTaSoAziTFDRmCA/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/39abd747a9578973f8734fe4be28200ffc3b66375f8e5f7ce7f22df3ebf839cdc77231abb55980d28b5f63a43906530b72d0086a1a7d44550223f92988741a47", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ba02817822adcaa63aac7bb5b984d060d43e38dbe1e4efc08b3e3457db497b46b46ad0c6af78e687239fe2bee9529f6ed738d5da128dd53f046225213b2389"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 10:11:54.087527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 10:11:54.091088) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1459075796.383639-563234946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 10:11:54.173525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 10:11:54.174257) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 10:11:54.174931) ========= ========= Total master_lag: 0.32 =========