builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1458413284.51 results: success (0) buildid: 20160319091831 builduid: ffe86da1d5d64e09995546bd01f8de61 revision: 07ffad91cb33df1d72fd3d08ef6af24dd1554607 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.505662) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.506175) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.506555) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006249 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.530744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.531072) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.557876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.558187) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052307 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.635357) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.635663) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.636076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.636412) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-19 11:48:04-- 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% 19.6M=0.001s 2016-03-19 11:48:04 (19.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.824473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.824803) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.145565 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.988987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:04.989372) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 07ffad91cb33df1d72fd3d08ef6af24dd1554607 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 07ffad91cb33df1d72fd3d08ef6af24dd1554607 --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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-19 11:48:05,007 truncating revision to first 12 chars 2016-03-19 11:48:05,007 Setting DEBUG logging. 2016-03-19 11:48:05,007 attempt 1/10 2016-03-19 11:48:05,007 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/07ffad91cb33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-19 11:48:05,271 unpacking tar archive at: mozilla-aurora-07ffad91cb33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:05.552124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:05.552532) ========= echo 07ffad91cb33df1d72fd3d08ef6af24dd1554607 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'07ffad91cb33df1d72fd3d08ef6af24dd1554607'] 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07ffad91cb33df1d72fd3d08ef6af24dd1554607 program finished with exit code 0 elapsedTime=0.003760 script_repo_revision: '07ffad91cb33df1d72fd3d08ef6af24dd1554607' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:05.602893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:05.603261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-19 11:48:05.618180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-19 11:48:05.618535) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:05 INFO - MultiFileLogger online at 20160319 11:48:05 in /builds/slave/test-pgo 11:48:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:48:05 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:48:05 INFO - {'append_to_log': False, 11:48:05 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:48:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:48:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:48:05 INFO - 'branch': 'Mozilla-Aurora', 11:48:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:05 INFO - 'config_files': ('talos/linux_config.py',), 11:48:05 INFO - 'default_actions': ('clobber', 11:48:05 INFO - 'read-buildbot-config', 11:48:05 INFO - 'download-and-extract', 11:48:05 INFO - 'populate-webroot', 11:48:05 INFO - 'create-virtualenv', 11:48:05 INFO - 'install', 11:48:05 INFO - 'run-tests'), 11:48:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:05 INFO - 'download_minidump_stackwalk': True, 11:48:05 INFO - 'download_symbols': 'ondemand', 11:48:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:05 INFO - 'installer_path': 'installer.exe', 11:48:05 INFO - 'log_level': 'info', 11:48:05 INFO - 'log_name': 'talos', 11:48:05 INFO - 'log_to_console': True, 11:48:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:05 INFO - 'opt_config_files': (), 11:48:05 INFO - 'pip_index': False, 11:48:05 INFO - 'sps_profile': False, 11:48:05 INFO - 'sps_profile_interval': 0, 11:48:05 INFO - 'suite': 'dromaeojs-e10s', 11:48:05 INFO - 'system_bits': '32', 11:48:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:05 INFO - 'title': 'talos-linux64-ix-038', 11:48:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:05 INFO - 'use_talos_json': True, 11:48:05 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:48:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:05 INFO - 'work_dir': 'build'} 11:48:05 INFO - ##### 11:48:05 INFO - ##### Running clobber step. 11:48:05 INFO - ##### 11:48:05 INFO - Running pre-action listener: _resource_record_pre_action 11:48:05 INFO - Running main action method: clobber 11:48:05 INFO - rmtree: /builds/slave/test-pgo/build 11:48:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - ##### 11:48:07 INFO - ##### Running read-buildbot-config step. 11:48:07 INFO - ##### 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: read_buildbot_config 11:48:07 INFO - Using buildbot properties: 11:48:07 INFO - { 11:48:07 INFO - "project": "", 11:48:07 INFO - "product": "firefox", 11:48:07 INFO - "script_repo_revision": "production", 11:48:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:48:07 INFO - "repository": "", 11:48:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:48:07 INFO - "buildid": "20160319091831", 11:48:07 INFO - "pgo_build": "True", 11:48:07 INFO - "basedir": "/builds/slave/test-pgo", 11:48:07 INFO - "buildnumber": 144, 11:48:07 INFO - "slavename": "talos-linux64-ix-038", 11:48:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:48:07 INFO - "platform": "ubuntu64_hw", 11:48:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:48:07 INFO - "branch": "mozilla-aurora", 11:48:07 INFO - "repo_path": "releases/mozilla-aurora", 11:48:07 INFO - "revision": "07ffad91cb33df1d72fd3d08ef6af24dd1554607", 11:48:07 INFO - "stage_platform": "linux64-pgo", 11:48:07 INFO - "builduid": "ffe86da1d5d64e09995546bd01f8de61", 11:48:07 INFO - "slavebuilddir": "test" 11:48:07 INFO - } 11:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - ##### 11:48:07 INFO - ##### Running download-and-extract step. 11:48:07 INFO - ##### 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: download_and_extract 11:48:07 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:48:07 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')]} 11:48:07 INFO - https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:48:16 INFO - Downloaded 1448 bytes. 11:48:16 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 11:48:16 INFO - Using the following test package requirements: 11:48:16 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 11:48:16 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:48:16 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:48:16 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'jsshell-linux-x86_64.zip'], 11:48:16 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:48:16 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 11:48:16 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:48:16 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:48:16 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:48:16 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 11:48:16 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 11:48:16 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:48:16 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:48:16 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')]} 11:48:16 INFO - https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:48:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:25 INFO - Downloaded 23310137 bytes. 11:48:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:48:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:48:26 INFO - Return code: 0 11:48:26 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:26 INFO - https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 11:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:28 INFO - Downloaded 23310137 bytes. 11:48:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:48:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 11:48:29 INFO - Return code: 0 11:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:29 INFO - https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 11:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 11:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 11:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:48:30 INFO - Downloaded 10845161 bytes. 11:48:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:48:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:48:31 INFO - Return code: 0 11:48: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')]} 11:48:31 INFO - https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 11:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 11:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 11:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:48:32 INFO - Downloaded 60444099 bytes. 11:48:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 11:48:32 INFO - mkdir: /builds/slave/test-pgo/properties 11:48:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:48:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:48:32 INFO - Contents: 11:48:32 INFO - build_url:https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 11:48:33 INFO - Running post-action listener: _resource_record_post_action 11:48:33 INFO - Running post-action listener: set_extra_try_arguments 11:48:33 INFO - ##### 11:48:33 INFO - ##### Running populate-webroot step. 11:48:33 INFO - ##### 11:48:33 INFO - Running pre-action listener: _resource_record_pre_action 11:48:33 INFO - Running main action method: populate_webroot 11:48:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:33 INFO - '--tppagecycles', 11:48:33 INFO - '7'], 11:48:33 INFO - 'tests': ['tsvgm']}}, 11:48:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:48:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:48:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'tests': ['damp', 'tps']}, 11:48:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['damp', 'tps']}, 11:48:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:48:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:33 INFO - 'other': {'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'other_l64': {'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'other_nol64': {'tests': ['a11yr', 11:48:33 INFO - 'ts_paint', 11:48:33 INFO - 'tpaint', 11:48:33 INFO - 'sessionrestore', 11:48:33 INFO - 'sessionrestore_no_auto_restore', 11:48:33 INFO - 'tabpaint']}, 11:48:33 INFO - 'svgr': {'tests': ['tsvgx', 11:48:33 INFO - 'tsvgr_opacity', 11:48:33 INFO - 'tart', 11:48:33 INFO - 'tscrollx', 11:48:33 INFO - 'cart']}, 11:48:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['tsvgx', 11:48:33 INFO - 'tsvgr_opacity', 11:48:33 INFO - 'tart', 11:48:33 INFO - 'tscrollx', 11:48:33 INFO - 'cart']}, 11:48:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'tests': ['tp5o']}, 11:48:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'talos_options': ['--e10s'], 11:48:33 INFO - 'tests': ['tp5o']}, 11:48:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'talos_options': ['--xperf_path', 11:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:33 INFO - 'tests': ['tp5n']}, 11:48:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:33 INFO - 'talos_options': ['--e10s', 11:48:33 INFO - '--xperf_path', 11:48:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:33 INFO - 'tests': ['tp5n']}}, 11:48:33 INFO - 'talos.zip': {'path': '', 11:48:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:33 INFO - Running post-action listener: _resource_record_post_action 11:48:33 INFO - ##### 11:48:33 INFO - ##### Running create-virtualenv step. 11:48:33 INFO - ##### 11:48:33 INFO - Running pre-action listener: _resource_record_pre_action 11:48:33 INFO - Running main action method: create_virtualenv 11:48:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:48:33 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 11:48:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:48:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:33 INFO - Using real prefix '/usr' 11:48:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:37 INFO - Installing pip.................done. 11:48:37 INFO - Return code: 0 11:48:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:48: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')]} 11:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:48:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:48:37 INFO - Using env: {'DISPLAY': ':0', 11:48:37 INFO - 'HOME': '/home/cltbld', 11:48:37 INFO - 'LANG': 'en_US.UTF-8', 11:48:37 INFO - 'LANGUAGE': 'en_US:en', 11:48:37 INFO - 'LOGNAME': 'cltbld', 11:48:37 INFO - 'MAIL': '/var/mail/cltbld', 11:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:37 INFO - 'MOZ_NO_REMOTE': '1', 11:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:37 INFO - 'NO_EM_RESTART': '1', 11:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:37 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:37 INFO - 'SHELL': '/bin/bash', 11:48:37 INFO - 'SHLVL': '1', 11:48:37 INFO - 'TERM': 'linux', 11:48:37 INFO - 'TMOUT': '86400', 11:48:37 INFO - 'USER': 'cltbld', 11:48:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:37 INFO - '_': '/tools/buildbot/bin/python'} 11:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:38 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 11:48:38 INFO - Cleaning up... 11:48:38 INFO - Return code: 0 11:48:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:48:38 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')]} 11:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 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')]} 11:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:38 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 11:48:38 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 11:48:38 INFO - Using env: {'DISPLAY': ':0', 11:48:38 INFO - 'HOME': '/home/cltbld', 11:48:38 INFO - 'LANG': 'en_US.UTF-8', 11:48:38 INFO - 'LANGUAGE': 'en_US:en', 11:48:38 INFO - 'LOGNAME': 'cltbld', 11:48:38 INFO - 'MAIL': '/var/mail/cltbld', 11:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:38 INFO - 'MOZ_NO_REMOTE': '1', 11:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:38 INFO - 'NO_EM_RESTART': '1', 11:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:38 INFO - 'SHELL': '/bin/bash', 11:48:38 INFO - 'SHLVL': '1', 11:48:38 INFO - 'TERM': 'linux', 11:48:38 INFO - 'TMOUT': '86400', 11:48:38 INFO - 'USER': 'cltbld', 11:48:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:38 INFO - '_': '/tools/buildbot/bin/python'} 11:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:38 INFO - Downloading/unpacking psutil>=0.7.1 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:38 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 11:48:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:40 INFO - Installing collected packages: psutil 11:48:40 INFO - Running setup.py install for psutil 11:48:40 INFO - building 'psutil._psutil_linux' extension 11:48:40 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 11:48:40 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 11:48:40 INFO - building 'psutil._psutil_posix' extension 11:48:40 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 11:48:40 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 11:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:41 INFO - Successfully installed psutil 11:48:41 INFO - Cleaning up... 11:48:41 INFO - Return code: 0 11:48:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:41 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:41 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 11:48:41 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 11:48:41 INFO - Using env: {'DISPLAY': ':0', 11:48:41 INFO - 'HOME': '/home/cltbld', 11:48:41 INFO - 'LANG': 'en_US.UTF-8', 11:48:41 INFO - 'LANGUAGE': 'en_US:en', 11:48:41 INFO - 'LOGNAME': 'cltbld', 11:48:41 INFO - 'MAIL': '/var/mail/cltbld', 11:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:41 INFO - 'MOZ_NO_REMOTE': '1', 11:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:41 INFO - 'NO_EM_RESTART': '1', 11:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:41 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:41 INFO - 'SHELL': '/bin/bash', 11:48:41 INFO - 'SHLVL': '1', 11:48:41 INFO - 'TERM': 'linux', 11:48:41 INFO - 'TMOUT': '86400', 11:48:41 INFO - 'USER': 'cltbld', 11:48:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:41 INFO - '_': '/tools/buildbot/bin/python'} 11:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:48:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:48:43 INFO - Installing collected packages: mozsystemmonitor 11:48:43 INFO - Running setup.py install for mozsystemmonitor 11:48:43 INFO - Successfully installed mozsystemmonitor 11:48:43 INFO - Cleaning up... 11:48:43 INFO - Return code: 0 11:48:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:48:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:48:43 INFO - Using env: {'DISPLAY': ':0', 11:48:43 INFO - 'HOME': '/home/cltbld', 11:48:43 INFO - 'LANG': 'en_US.UTF-8', 11:48:43 INFO - 'LANGUAGE': 'en_US:en', 11:48:43 INFO - 'LOGNAME': 'cltbld', 11:48:43 INFO - 'MAIL': '/var/mail/cltbld', 11:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:43 INFO - 'MOZ_NO_REMOTE': '1', 11:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:43 INFO - 'NO_EM_RESTART': '1', 11:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:43 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:43 INFO - 'SHELL': '/bin/bash', 11:48:43 INFO - 'SHLVL': '1', 11:48:43 INFO - 'TERM': 'linux', 11:48:43 INFO - 'TMOUT': '86400', 11:48:43 INFO - 'USER': 'cltbld', 11:48:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:43 INFO - '_': '/tools/buildbot/bin/python'} 11:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48: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 11:48:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:48:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:53 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 11:48:53 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 11:48:53 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 11:48:53 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 11:48:53 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 11:48:53 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 11:48:53 INFO - Downloading docopt-0.6.1.tar.gz 11:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:53 INFO - Running setup.py install for blobuploader 11:48:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:48:53 INFO - Running setup.py install for requests 11:48:54 INFO - Running setup.py install for docopt 11:48:54 INFO - Successfully installed blobuploader requests docopt 11:48:54 INFO - Cleaning up... 11:48:54 INFO - Return code: 0 11:48:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:48: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')]} 11:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:54 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:54 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 11:48:54 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 11:48:54 INFO - Using env: {'DISPLAY': ':0', 11:48:54 INFO - 'HOME': '/home/cltbld', 11:48:54 INFO - 'LANG': 'en_US.UTF-8', 11:48:54 INFO - 'LANGUAGE': 'en_US:en', 11:48:54 INFO - 'LOGNAME': 'cltbld', 11:48:54 INFO - 'MAIL': '/var/mail/cltbld', 11:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:54 INFO - 'MOZ_NO_REMOTE': '1', 11:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:54 INFO - 'NO_EM_RESTART': '1', 11:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:54 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:54 INFO - 'SHELL': '/bin/bash', 11:48:54 INFO - 'SHLVL': '1', 11:48:54 INFO - 'TERM': 'linux', 11:48:54 INFO - 'TMOUT': '86400', 11:48:54 INFO - 'USER': 'cltbld', 11:48:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:54 INFO - '_': '/tools/buildbot/bin/python'} 11:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:48:54 INFO - Running setup.py (path:/tmp/pip-Z8Q8CG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:48:54 INFO - Running setup.py (path:/tmp/pip-rVwVwT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:48:54 INFO - Running setup.py (path:/tmp/pip-0HrtVS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:48:54 INFO - Running setup.py (path:/tmp/pip-iGaEwh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:48:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:48:54 INFO - Running setup.py (path:/tmp/pip-f4PICm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:48:55 INFO - Running setup.py (path:/tmp/pip-p1RGdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:48:55 INFO - Running setup.py (path:/tmp/pip-MVsBdN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:48:55 INFO - Running setup.py (path:/tmp/pip-IDN4gJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:48:55 INFO - Running setup.py (path:/tmp/pip-LFW2wR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:48:55 INFO - Running setup.py (path:/tmp/pip-2MN908-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:48:55 INFO - Running setup.py (path:/tmp/pip-rQE5fX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:48:55 INFO - Running setup.py (path:/tmp/pip-_LJtJv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:48:55 INFO - Running setup.py (path:/tmp/pip-tciRdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:48:55 INFO - Running setup.py (path:/tmp/pip-Cl6DtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:48:55 INFO - Running setup.py (path:/tmp/pip-jVtVUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:48:55 INFO - Running setup.py (path:/tmp/pip-boDhgF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:48:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:48:55 INFO - Running setup.py (path:/tmp/pip-nsZuGy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:48:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:55 INFO - Running setup.py install for manifestparser 11:48:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for mozcrash 11:48:56 INFO - Running setup.py install for mozdebug 11:48:56 INFO - Running setup.py install for mozdevice 11:48:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for mozfile 11:48:56 INFO - Running setup.py install for mozhttpd 11:48:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for mozinfo 11:48:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for mozInstall 11:48:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for mozleak 11:48:56 INFO - Running setup.py install for mozlog 11:48:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:48:56 INFO - Running setup.py install for moznetwork 11:48:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Running setup.py install for mozprocess 11:48:57 INFO - Running setup.py install for mozprofile 11:48:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Running setup.py install for mozrunner 11:48:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Running setup.py install for mozscreenshot 11:48:57 INFO - Running setup.py install for moztest 11:48:57 INFO - Running setup.py install for mozversion 11:48:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:48:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:57 INFO - Cleaning up... 11:48:57 INFO - Return code: 0 11:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:48:57 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 11:48:57 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 11:48:57 INFO - Using env: {'DISPLAY': ':0', 11:48:57 INFO - 'HOME': '/home/cltbld', 11:48:57 INFO - 'LANG': 'en_US.UTF-8', 11:48:57 INFO - 'LANGUAGE': 'en_US:en', 11:48:57 INFO - 'LOGNAME': 'cltbld', 11:48:57 INFO - 'MAIL': '/var/mail/cltbld', 11:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:57 INFO - 'MOZ_NO_REMOTE': '1', 11:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:57 INFO - 'NO_EM_RESTART': '1', 11:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:48:57 INFO - 'SHELL': '/bin/bash', 11:48:57 INFO - 'SHLVL': '1', 11:48:57 INFO - 'TERM': 'linux', 11:48:57 INFO - 'TMOUT': '86400', 11:48:57 INFO - 'USER': 'cltbld', 11:48:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:57 INFO - '_': '/tools/buildbot/bin/python'} 11:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:48:57 INFO - Running setup.py (path:/tmp/pip-2LNlNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:48:57 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)) 11:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:48:57 INFO - Running setup.py (path:/tmp/pip-C8v63R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:48:58 INFO - Running setup.py (path:/tmp/pip-IOGfOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:48:58 INFO - Running setup.py (path:/tmp/pip-ZW77Ub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:48:58 INFO - Running setup.py (path:/tmp/pip-SIAThn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:48:58 INFO - Running setup.py (path:/tmp/pip-yAkcXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:48:58 INFO - Running setup.py (path:/tmp/pip-MMVU8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:48:58 INFO - Running setup.py (path:/tmp/pip-zIIFHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:48:58 INFO - Running setup.py (path:/tmp/pip-57BzaF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:48:58 INFO - Running setup.py (path:/tmp/pip-TGW7fg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:48:58 INFO - Running setup.py (path:/tmp/pip-aKxuF0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:48:58 INFO - Running setup.py (path:/tmp/pip-AhfCjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:48:58 INFO - Running setup.py (path:/tmp/pip-G92tad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:48:58 INFO - Running setup.py (path:/tmp/pip-g5aJJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:48:58 INFO - Running setup.py (path:/tmp/pip-iXBYOU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:48:59 INFO - Running setup.py (path:/tmp/pip-szHFLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:48:59 INFO - Running setup.py (path:/tmp/pip-Km3uKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:48:59 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)) 11:48:59 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)) 11:48:59 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)) 11:48:59 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)) 11:48:59 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)) 11:48:59 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)) 11:48:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:01 INFO - Downloading blessings-1.6.tar.gz 11:49:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:01 INFO - Installing collected packages: blessings 11:49:01 INFO - Running setup.py install for blessings 11:49:01 INFO - Successfully installed blessings 11:49:01 INFO - Cleaning up... 11:49:01 INFO - Return code: 0 11:49:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:49:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:49:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:49:01 INFO - Reading from file tmpfile_stdout 11:49:01 INFO - Current package versions: 11:49:01 INFO - argparse == 1.2.1 11:49:01 INFO - blessings == 1.6 11:49:01 INFO - blobuploader == 1.2.4 11:49:01 INFO - docopt == 0.6.1 11:49:01 INFO - manifestparser == 1.1 11:49:01 INFO - mozInstall == 1.12 11:49:01 INFO - mozcrash == 0.17 11:49:01 INFO - mozdebug == 0.1 11:49:01 INFO - mozdevice == 0.48 11:49:01 INFO - mozfile == 1.2 11:49:01 INFO - mozhttpd == 0.7 11:49:01 INFO - mozinfo == 0.9 11:49:01 INFO - mozleak == 0.1 11:49:01 INFO - mozlog == 3.1 11:49:01 INFO - moznetwork == 0.27 11:49:01 INFO - mozprocess == 0.22 11:49:01 INFO - mozprofile == 0.28 11:49:01 INFO - mozrunner == 6.11 11:49:01 INFO - mozscreenshot == 0.1 11:49:01 INFO - mozsystemmonitor == 0.0 11:49:01 INFO - moztest == 0.7 11:49:01 INFO - mozversion == 1.4 11:49:01 INFO - psutil == 3.1.1 11:49:01 INFO - requests == 1.2.3 11:49:01 INFO - wsgiref == 0.1.2 11:49:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:49:01 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')]} 11:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 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')]} 11:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:49:01 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 11:49:01 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 11:49:01 INFO - Using env: {'DISPLAY': ':0', 11:49:01 INFO - 'HOME': '/home/cltbld', 11:49:01 INFO - 'LANG': 'en_US.UTF-8', 11:49:01 INFO - 'LANGUAGE': 'en_US:en', 11:49:01 INFO - 'LOGNAME': 'cltbld', 11:49:01 INFO - 'MAIL': '/var/mail/cltbld', 11:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:01 INFO - 'MOZ_NO_REMOTE': '1', 11:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:01 INFO - 'NO_EM_RESTART': '1', 11:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:49:01 INFO - 'SHELL': '/bin/bash', 11:49:01 INFO - 'SHLVL': '1', 11:49:01 INFO - 'TERM': 'linux', 11:49:01 INFO - 'TMOUT': '86400', 11:49:01 INFO - 'USER': 'cltbld', 11:49:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:01 INFO - '_': '/tools/buildbot/bin/python'} 11:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 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)) 11:49:01 INFO - Cleaning up... 11:49:01 INFO - Return code: 0 11:49:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:49:01 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')]} 11:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 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')]} 11:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:01 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:49:01 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 11:49:01 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 11:49:01 INFO - Using env: {'DISPLAY': ':0', 11:49:01 INFO - 'HOME': '/home/cltbld', 11:49:01 INFO - 'LANG': 'en_US.UTF-8', 11:49:01 INFO - 'LANGUAGE': 'en_US:en', 11:49:01 INFO - 'LOGNAME': 'cltbld', 11:49:01 INFO - 'MAIL': '/var/mail/cltbld', 11:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:01 INFO - 'MOZ_NO_REMOTE': '1', 11:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:01 INFO - 'NO_EM_RESTART': '1', 11:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:49:01 INFO - 'SHELL': '/bin/bash', 11:49:01 INFO - 'SHLVL': '1', 11:49:01 INFO - 'TERM': 'linux', 11:49:01 INFO - 'TMOUT': '86400', 11:49:01 INFO - 'USER': 'cltbld', 11:49:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:01 INFO - '_': '/tools/buildbot/bin/python'} 11:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:01 INFO - Downloading/unpacking jsonschema 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:03 INFO - Downloading/unpacking functools32 (from jsonschema) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:04 INFO - warning: no files found matching '*.txt' 11:49:04 INFO - no previously-included directories found matching 'build' 11:49:04 INFO - no previously-included directories found matching 'dist' 11:49:04 INFO - no previously-included directories found matching '.git*' 11:49:04 INFO - Installing collected packages: jsonschema, functools32 11:49:04 INFO - Running setup.py install for functools32 11:49:04 INFO - warning: no files found matching '*.txt' 11:49:04 INFO - no previously-included directories found matching 'build' 11:49:04 INFO - no previously-included directories found matching 'dist' 11:49:04 INFO - no previously-included directories found matching '.git*' 11:49:04 INFO - Successfully installed jsonschema functools32 11:49:04 INFO - Cleaning up... 11:49:04 INFO - Return code: 0 11:49:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:49:04 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')]} 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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')]} 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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 0x7f4867c58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ef6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, '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': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', '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 11:49:04 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 11:49:04 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 11:49:04 INFO - Using env: {'DISPLAY': ':0', 11:49:04 INFO - 'HOME': '/home/cltbld', 11:49:04 INFO - 'LANG': 'en_US.UTF-8', 11:49:04 INFO - 'LANGUAGE': 'en_US:en', 11:49:04 INFO - 'LOGNAME': 'cltbld', 11:49:04 INFO - 'MAIL': '/var/mail/cltbld', 11:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:04 INFO - 'MOZ_NO_REMOTE': '1', 11:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:04 INFO - 'NO_EM_RESTART': '1', 11:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:49:04 INFO - 'SHELL': '/bin/bash', 11:49:04 INFO - 'SHLVL': '1', 11:49:04 INFO - 'TERM': 'linux', 11:49:04 INFO - 'TMOUT': '86400', 11:49:04 INFO - 'USER': 'cltbld', 11:49:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:04 INFO - '_': '/tools/buildbot/bin/python'} 11:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:04 INFO - Downloading/unpacking flake8 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:49:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:49:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 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 11:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:49:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:49:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:49:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:49:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:49:07 INFO - no previously-included directories found matching 'docs/_build' 11:49:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:49:07 INFO - Running setup.py install for pep8 11:49:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:49:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:49:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:49:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:49:07 INFO - no previously-included directories found matching 'docs/_build' 11:49:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:49:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:49:07 INFO - Cleaning up... 11:49:07 INFO - Return code: 0 11:49:07 INFO - Running post-action listener: _resource_record_post_action 11:49:07 INFO - Running post-action listener: _start_resource_monitoring 11:49:07 INFO - Starting resource monitoring. 11:49:07 INFO - ##### 11:49:07 INFO - ##### Running install step. 11:49:07 INFO - ##### 11:49:07 INFO - Running pre-action listener: _resource_record_pre_action 11:49:07 INFO - Running main action method: install 11:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:49:07 INFO - Reading from file tmpfile_stdout 11:49:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:49:07 INFO - Reading from file tmpfile_stdout 11:49:07 INFO - Output received: 11:49:07 INFO - Usage: mozinstall [options] installer 11:49:07 INFO - Options: 11:49:07 INFO - -h, --help show this help message and exit 11:49:07 INFO - -d DEST, --destination=DEST 11:49:07 INFO - Directory to install application into. [default: 11:49:07 INFO - "/builds/slave/test-pgo"] 11:49:07 INFO - --app=APP Application being installed. [default: firefox] 11:49:07 INFO - mkdir: /builds/slave/test-pgo/build/application 11:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:49:22 INFO - Reading from file tmpfile_stdout 11:49:22 INFO - Output received: 11:49:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:49:22 INFO - Running post-action listener: _resource_record_post_action 11:49:22 INFO - ##### 11:49:22 INFO - ##### Running run-tests step. 11:49:22 INFO - ##### 11:49:22 INFO - Running pre-action listener: _resource_record_pre_action 11:49:22 INFO - Running main action method: run_tests 11:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:49:22 INFO - Python 2.7.3 11:49:22 INFO - Return code: 0 11:49:22 INFO - grabbing minidump binary from tooltool 11:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237e920>, '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 0x237f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x237fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:49:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 11:49:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:49:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:22 INFO - Return code: 0 11:49:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:49:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:49:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:49:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:49:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:49:23 INFO - Return code: 0 11:49:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 11:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:49:23 INFO - Using env: {'DISPLAY': ':0', 11:49:23 INFO - 'HOME': '/home/cltbld', 11:49:23 INFO - 'LANG': 'en_US.UTF-8', 11:49:23 INFO - 'LANGUAGE': 'en_US:en', 11:49:23 INFO - 'LOGNAME': 'cltbld', 11:49:23 INFO - 'MAIL': '/var/mail/cltbld', 11:49:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:49:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:23 INFO - 'MOZ_NO_REMOTE': '1', 11:49:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:23 INFO - 'NO_EM_RESTART': '1', 11:49:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:49:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:49:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:49:23 INFO - 'SHELL': '/bin/bash', 11:49:23 INFO - 'SHLVL': '1', 11:49:23 INFO - 'TERM': 'linux', 11:49:23 INFO - 'TMOUT': '86400', 11:49:23 INFO - 'USER': 'cltbld', 11:49:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245', 11:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:23 INFO - '_': '/tools/buildbot/bin/python'} 11:49:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:49:24 INFO - mozversion application_buildid: 20160319091831 11:49:24 INFO - mozversion application_changeset: 07ffad91cb33df1d72fd3d08ef6af24dd1554607 11:49:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:49:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:24 INFO - mozversion application_name: Firefox 11:49:24 INFO - mozversion application_remotingname: firefox-dev 11:49:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:49:24 INFO - mozversion application_vendor: Mozilla 11:49:24 INFO - mozversion application_version: 47.0a2 11:49:24 INFO - mozversion platform_buildid: 20160319091831 11:49:24 INFO - mozversion platform_changeset: 07ffad91cb33df1d72fd3d08ef6af24dd1554607 11:49:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:49:24 INFO - mozversion platform_version: 47.0a2 11:49:24 INFO - using testdate: 1458413364 11:49:24 INFO - actual date: 1458413364 11:49:24 INFO - starting webserver on 'localhost:50407' 11:49:24 INFO - SUITE-START | Running 2 tests 11:49:24 INFO - TEST-START | dromaeo_css 11:49:24 INFO - operating with platform_type : linux_ 11:49:24 INFO - Initialising browser for dromaeo_css test... 11:49:24 INFO - TEST-INFO | started process 3892 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ZiJKF/profile http://localhost:50407/getInfo.html) 11:49:29 INFO - PROCESS | 3892 | 11:49:29 INFO - PROCESS | 3892 | (process:3968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:49:30 INFO - PROCESS | 3892 | __metrics Screen width/height:1600/1200 11:49:30 INFO - PROCESS | 3892 | colorDepth:24 11:49:30 INFO - PROCESS | 3892 | Browser inner width/height: 1024/697 11:49:30 INFO - PROCESS | 3892 | __metrics 11:49:31 ERROR - PROCESS | 3892 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:49:32 INFO - TEST-INFO | 3892: exit 0 11:49:32 INFO - Browser initialized. 11:49:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:32 INFO - TEST-INFO | started process 4019 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_ZiJKF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:34 INFO - PROCESS | 4019 | 11:49:34 INFO - PROCESS | 4019 | (process:4088): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:49:44 INFO - PROCESS | 4019 | RSS: Main: 153870336 11:49:44 INFO - PROCESS | 4019 | 11:50:33 INFO - PROCESS | 4019 | 1458413433720 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] 11:52:41 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50407/tests/dromaeo/cssquery-ext.html) 11:52:42 INFO - PROCESS | 4019 | RSS: Main: 158326784 11:52:42 INFO - PROCESS | 4019 | 11:55:44 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-ext.html (next: http://localhost:50407/tests/dromaeo/cssquery-jquery.html) 11:55:44 INFO - PROCESS | 4019 | RSS: Main: 155615232 11:55:44 INFO - PROCESS | 4019 | 11:58:46 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50407/tests/dromaeo/cssquery-mootools.html) 11:58:47 INFO - PROCESS | 4019 | RSS: Main: 155611136 11:58:47 INFO - PROCESS | 4019 | 12:01:48 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50407/tests/dromaeo/cssquery-prototype.html) 12:01:49 INFO - PROCESS | 4019 | RSS: Main: 156065792 12:01:49 INFO - PROCESS | 4019 | 12:04:51 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50407/tests/dromaeo/cssquery-yui.html) 12:04:52 INFO - PROCESS | 4019 | RSS: Main: 155181056 12:04:52 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | Cycle 1(1): loaded http://localhost:50407/tests/dromaeo/cssquery-yui.html (next: http://localhost:50407/tests/dromaeo/cssquery-dojo.html) 12:07:54 INFO - PROCESS | 4019 | RSS: Main: 158507008 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | __start_tp_report 12:07:54 INFO - PROCESS | 4019 | _x_x_mozilla_page_load 12:07:54 INFO - PROCESS | 4019 | _x_x_mozilla_page_load_details 12:07:54 INFO - PROCESS | 4019 | |i|pagename|runs| 12:07:54 INFO - PROCESS | 4019 | |0;dojo.html;3266.052844675044;3302.5046243063543;3336.2493438976217;3364.6130694970084;3372.291818718069;5388.245645609618;5412.323459567554;5438.129899216126;5439.864003399917;5456.127019676853;5422.728863556817;5454.754536045877;5456.508914197721;5457.399686034533;5488.067028605136;4953.058918805434;4986.152354099793;5044.9747751261375;5057.721825299607;5147.099257629919;4818.759062046901;4976.4774698656665;5128.05131050755;5140.974295128519;5149.510796474329;5006.874828129289;5023.572996295301;5071.56891664209;5131.61512886535;5173.922391164117;5094.184930411135;5099.898002039957;5108.233764935252;5114.897702045938;5148.3564554430695;4859.757012149378;4947.82682606107;5073.061483625541;5084.720340381277;5102.158143906288;5316.813911513117;5322.627416080876;5326.866828329284;5345.224942383372;5347.7058761768085;5863;5883.17635531026;5897.174395584621;5906.704664766788;5913.2608423947;5791.333996590404;5872.765089396419;5878.118282257653;5905.261842269716;5942.168096466498;5412.5940554458175;5440.755166017539;5445.455454454563;5460.099083651193;5463.289772329612;5926.555508336892;5935.643861368331;5945.554083443759;5963.701814909237;6013.45878870895;5716.742746576414;5739.741711622987;5746.224259724967;5766;5785.71071446426;5840.561957853178;5841.153032810304;5858.238429004287;5864.530837532987;5864.912026319608;5731.140328950607;5807.709614519257;5839.766409343579;5844.503217226498;5880.676562789087;5804.9419505805245;5837.503812175928;5838.153467747238;5839.0949402842625;5846.6784326862435;4463.486699029589;4483.663725220622;4488.64090872736;4488.730676159441;4504.707194032443;3966.8016599170505;4005.919881602352;4014.2774300625583;4029.0330320722815;4030.395440683862;5350.197470379474;5400.351957765015;5403.297571315782;5432.049391356497;5511.448855114537;5879.206307148565;5889.322727886348;5892.027815410495;5893.440123188376;5903.527717782653;5411.594130440233;5536.501714845684;5544.528715059185;5546.195801608744;5556.472135147154;5010.398752149766;5044.596432285409;5090.185570308733;5095.668781529263;5136.075506408808;6041.788537401258;6057.091436284504;6100.206973093469;6101.786437474756;6123.755049798047;5771.68255745938;5903.970480147572;5906;5916.319623243382;5928.347881733006;6027.336992930862;6090.2996155440915;6095.512359011357;6109.053096770008;6116.694165291807;5728.484436400744;5770.942290577041;5771.163181338767;5772.971135144466;5775.8556036099435;5760.135979603093;5855.736491857791;5858.736356864037;5859;5867.911981320198;5705.144228365778;5738.397468265772;5741.13882917549;5742.08126699726;5753.510951569164;5683.573731970201;5691.117876729114;5726.284214473191;5726.742296596746;5730.5129064030025;5566.4990150886615;5632.887342253214;5638.379778224474;5640.097584386478;5740.540756739368;5722.542196624343;5780.479756821906;5800.738966746591;5818.912716309174;5828.795992140254;5651.265335506358;5655.773769049192;5663.518600918968;5694.544436444991;5696.886062278814 12:07:54 INFO - PROCESS | 4019 | |1;ext.html;539.1328625548159;572.5047833623917;589.7493565234777;609.3540846702497;626.5989766549408;38854.61145388545;39466.408003879966;39549.60450395495;39555.2088958221;39583.802080989626;42404;42880.356794648105;42905;42938.57061429385;42953;8743.300535957109;8979.640814367418;8990.68532601359;9003.324750643695;9013.54932253388;8776.780580485507;8934.73195804127;8976.506292153961;8995.235404990584;8996.325275604357;9225.261979041694;9232.030636783142;9239.399439036475;9245.260379169684;9303.534823258844;9116.316276279273;9145.862812057825;9164.541772911327;9200.953995230047;9235.907640923571;8951.41815781972;9011.27909767217;9063.909360906438;9104.226140778042;9108.772280692969;42855.14289714219;43006.13987720228;43320.566794332284;43369;43477;3624.2751449710163;3682.4476328550663;3691.151035261878;3758.586555478895;4177;32307.19232019195;32337.029889103364;32432.513512297333;32502.18744531382;33494.16264593405;4370.562943705636;4434.423524941769;4435.467743870724;4460.085682435093;4473.910521789546;293769;294978;296104;298271;299134;45194;45666.77166614146;45743;62032.68983655143;62349.68825155845;42893.57106428958;42963;42966.785166074595;43048.13903721908;43119.78440107779;15211.239438028275;15302.158381289137;15366.154861482502;15370.231488425758;15396.384144634314;12425.31660758667;12506.687332816753;12521.311327876872;12521.812172817416;12533.561325353568;15212.391504339703;15228.46700365482;15279.083255004734;15404.92297538505;15475.458358957383;6109.541784366191;6173.8456538586;6273.780417685359;6318.08387783778;6353.618782873043;1075.1452595186688;1096.627146770102;1104.7845670094255;1118.9425992437232;1153.7231064544449;30101.849490752407;30143.547846782316;30184.24539386489;30406.391872162432;30587.2353191172;1181.3915833345834;1191.1780871198846;1191.9046476281876;1200.4357951762659;1341.7316536692701;14993;15361.692766144615;15414.614634634223;15574.065556066673;15629.531114066369;349367;519456;527112;527521;540511;57358.7132064337;57504;57943.71028144832;58142.41857581455;58208.12687809686;1496.2593516209547;1497.6147063966005;1504.7872791590034;1507.5402002389158;1514.9848501515064;28354.432911341246;28748.856255718587;29509.409811803213;29732.256693582833;29879.022598419015;48423.5157648419;48787.75606122088;48824;48938.26592601185;48983;304838;305032;307330;308223;309978;34320.313593727486;34434.31131377409;34598.30803383868;34708;34717.65282347144;48384.516154838;48880;48914.75542622264;49781.50218497769;49787;38247.42628860514;38480.80759596184;38896.6110338893;39016.804915976376;39116.6088339113;37098;37159.442608360354;37807.43288850615;38727;38740.6125938737;37542.2491550162;37764;37860.432093518066;38417.84746457611;38822.4176637345;34599.308013840084;35631.643683562834;36517.26965460729;36917.815410922776;37054.44418333781;26353.341166470993;26572;26953.0566430174;27161.86419067892;27244.863775680995 12:07:54 INFO - PROCESS | 4019 | |2;jquery.html;373.47526724951433;376.12926076133755;380.3249232612115;383.7735735915809;385.58934734507767;17671.469855904328;18087.547811304725;18377.173027213776;18426;18567.978761168146;17284.654306913853;17684.11579421027;17822.821771782277;17907;17926.282948682037;5552.805651802188;5768.855778605526;5786.218860453848;5816.389279125694;5820.708964551776;5510.724463776795;5677.886442271152;5744.511716504102;5749.965006298865;5750.079987202049;5546.805861794838;5608.355039170487;5636.577256705743;5644.153376993463;5665.660060396369;5365.704886231256;5540.833774986757;5555.777768889239;5558.333000039981;5589.385167631537;5050.696958182484;5080.110980578384;5086.949130508685;5100.795968161269;5126.948730512684;22397.328080157622;22409.32772016842;22527.774722252732;23060.654090188662;23266.3020109397;2357.210334537932;2427.211156374168;2549.5920652695663;2637.9604305935427;3025.3949210158057;14159.575212743634;14526.564203073818;14588.27058647074;14677.339519721638;14747.188904610242;1927.469945764912;1990.3630838131803;2023.0592774359845;2038.908249128778;2053.404512691318;65161.674191628736;66595.66702166555;68008.6599566999;68252;69019;10252.58989640406;10482.63310784119;10687.25189236746;10792.514336854703;10866.07638350749;13487.595372138852;13532.120412173177;13550.796738048937;13571.253581052939;13746.175229486264;7751;7914.327282180964;7953.642086106023;8021.679132834622;8055.315298199602;7908.920910790934;7937.484063535851;7988.400869934778;8043.879341809878;8112.918870811334;6171.876562468726;6262;6270.372962703693;6293.779717709858;6335.651539165298;1851.1114664960626;1862.5436767991657;1889.6409682160345;1912.8182822631827;1918.9520261993562;990.3760630802549;996.3025881882711;1073.1575713065206;1102.7684186320803;1176.3882780953857;18094.457166285032;18190.5452363692;18246.178921948544;18338.449846504627;18767.718484222747;994.6319861651091;1039.095986491757;1075.6772968109535;1082.9928166804789;1090.0571006079683;10795.40625265618;10876.72808179786;10923.672289831318;10946.671599851858;11007.229493935507;450596;454516;454682;464798;467552;68606.65696671585;70663;71234.64382678054;72401;72562.63718681372;1104.928179668319;1111.261011427408;1129.2095533126844;1157.560127151694;1159.066951104369;15956;16001.919990399974;16035.438759643823;16160.11119388445;16324.183790810175;27002.324941875824;35294.82352588221;35550.64449355473;36444.088897777765;36481.452778207815;51887;51935.2209716847;52028;52063.73968130287;52854.73572632112;8209.917900820916;8236.464629799044;8286;8378.748637540884;8476.745697629081;6927.134108236471;8522.74431767048;8996;13164.210147391188;13410.32948352559;10989.230753847154;11210.271332363696;11360.1479889007;11373.54505819758;11385.089192864716;11106.389148596905;11432.199746018032;11594.246373985665;11614.361210133186;11908.345041022827;11371.886281137413;11507.539698412305;11581.478833452684;11593;11866.169368144492;7856.7250146244605;7941.324987376138;8080.353571714131;8322.958385208036;8491.448055876348;9597.616095356108;11367.715807104889;11417.31496110236;11478.713032174262;11531.942340288246 12:07:54 INFO - PROCESS | 4019 | |3;mootools.html;1585.3658536585365;1586.373382513907;1784.705523588608;1876.0432179588422;1917.1277068933628;7737.883931741028;8193.631286592103;8555.572221388937;8783.824323513525;8795.076516965722;8182.222688844565;8241.052278987918;8276.131006244348;8291.792705182374;8295.087540370554;2357.787799098081;2399.2562305685206;2402.6396040593963;2404.627282771173;2405.603075492542;2365.0894405653776;2392.055138220402;2405.1101092595763;2407.8555286682767;2411;2416.758324167578;2419.3104965084954;2433.1605596069326;2441.401856545149;2445.682061332024;2422.685050943384;2423.4547226873988;2426.7573242675767;2431.671724317221;2462.778349948513;2392.186656536786;2395.616701327797;2395.6286775549816;2395.988020059906;2411.3127758588894;8505.61724722389;8525.658973641046;8528.488290702579;8577.785555361104;8630.611622477003;5175;5292.311999440087;5295.814646487354;5314.760835762361;5324.41431442541;3293.917652058694;3333.8833140839956;3386.9661303386897;3420.743444241667;3434.6221915589267;1081.551156270147;1131.7000994736402;1131.9151063670176;1142.7771584541017;1145.9484323205477;12073.335966521838;12179.39103044853;12270.877291227063;12271;12280.324582147978;4820.9517904821205;4825.1555977703765;4844.903101937942;4865.343178670905;4898.4121905371585;10350.948245258725;10402.531886065146;10419.374837509773;10450.372977621368;10465.84301235482;5338.065838478328;5342.385625653022;5367.302250707383;5395.568354531628;5410.026195284808;4156.231097247019;4734.526547345306;4825.348577942003;4843.07981483517;4904.362432883774;4010.7593544386846;4067.9796601016806;4093.16090201508;4099.2416402964955;4114.382842573578;1224.9020078393708;1233.0813543909844;1237.0969192489533;1241.757857217852;1247.8502579690496;1434.5266062199448;1445.2340259662396;1451.2453524167374;1454.941802327895;1479.4452080469823;8315.750527484186;8323.1260717625;8332.625031873458;8334.791630209293;8344.874826877602;493.83950216179886;499.6028157614705;501.77420160927727;509.7425799970991;511.0647515047454;6170.598911070856;6212.875742485125;6249.78125765596;6269.686515674198;6301.779437719658;10129.64546240878;10319.277650564389;10330.431826249478;10335.379877207391;10337.793244135075;10108.292419530562;10235.334703244265;10298.227632927561;10318.122959548373;10334.379937203792;8151.551664658501;8156.34749220061;8167.632456539352;8187;8238.917610823935;7768.805779855549;7798.727044553413;7841.647125879464;8060;8214.301784348398;9117.08829117083;9270.165685088105;9295.76760580991;9324.580393882427;9384.530773461163;9406.717798466058;9496.287778416508;9670.951645241728;9685.757856053373;9712.417254964725;6766.357196066366;7283.126024877049;7405.7778266652085;7462.403007759258;7498.7000519980775;8264.793380165544;8323.875141872997;8326.084130745492;8364;8373.832523349622;7394.445416593884;7540.811479713051;7641.044869391326;7670.846583068419;7772.805679858049;7441.1070671519765;7459.738909138154;7475.476716629783;7585.241475852371;7606.9619651901385;7783.299503044753;7835.37317014626;7868.763937081897;7907.48601340911;7914.802129946797;7069.081019467436;7160.212376638461;7213.71145154188;7291.963540182265;7332.633368331669;7330.486865919548;7369.226231245856;7379;7381.483296169216;7387 12:07:54 INFO - PROCESS | 4019 | |4;prototype.html;346.0483669907754;350.43929712460067;352.2215902854691;355.32488272282677;357.05024634472306;6395.488360931126;6413.454856337211;6418.518611104162;6432.935670643292;6481;6372.139761132245;6375.649339286338;6375.713092910819;6376.043593460983;6379.011253255753;4678.064387122572;4784.904301913977;4790.473047964721;4812.783424745895;4887.584555312794;4759.4764575896625;4778.235482322829;4778.307145463923;4787.40157480315;4796.808127674889;4730.408698912636;4730.739809310487;4740.620750339982;4745.715257084568;4747.976260118695;4743.857684269477;4745.501722319142;4751.453582837983;4754.928676069844;4764.0948219838465;4080.6735461163034;4082.4692789937417;4084.305668036441;4086.0397806515443;4089.0390758171807;6033.909491357633;6053.667048312341;6094;6095.725692343855;6118.60229085108;5421.132618780976;5546.084895992157;5546.750396232179;5552.7223638818305;5612.635178713371;6674.899876501856;6676.13210282665;6682.665866706645;6714.563553369016;6727.730890764364;4622.6301895848255;4632.583067523905;4634.72191668501;4637.605803506706;4641.744704041276;6957.478189135835;6985.615791131486;6985.82535436613;7009.579425234502;7019.438444924444;4655.162070827284;4732.976335118371;4733.171694953438;4740.336352910595;4744.833930812405;4797.95202047982;4800.303955926371;4802;4803.807847686124;4819.2530157825595;5514.310711161105;5576;5576.693281869455;5579.246801681721;5614.07367784311;6800.965995169992;6806.76176333826;6821.658917054227;6835.1114355134505;6840.794776156723;1676.1116608197674;1698.4395149600603;1699.9320027199021;1700.1839117223801;1703.6848183085922;1070.1706177712178;1095.5617752898745;1097.2977294531506;1102.5755084292446;1105.1876870500175;6461.19235095613;6474.1907261592305;6492.545521813522;6503.447206987365;6531.771388001397;7001.894971575431;7018.017477553147;7034.40207582351;7060.611666358297;7070.292970702992;6357.554971152067;6470.676466176672;6471.870562588721;6478.514111441661;6499.805005849832;3767.2842159989514;3792.715546334036;3816.5610954740005;3839.2705385976574;3868.7678739275734;7319.158296795937;7378.003969464161;7388.852222955618;7395.4083673306;7399.741009064657;7259.528130671595;7309.780706578811;7310.268973102754;7312.890306645405;7337.779866604011;7164.140303163549;7362.226966168475;7428.480006399608;7448.888266676005;7452.627368631547;7111.751088711871;7163.785086447415;7168.498205125591;7223.530470519399;7248.637568121468;6996.545224560387;7021.473389495706;7031.085958825524;7040.155181378267;7058.6470676467;7361.079865016873;7375.594342311224;7414.777556673308;7422;7424.851502970018;4623.791929363119;4693.319468677091;4695.107929493385;4723.126221649006;4728.479867214535;7059.894101588377;7109.857802844018;7110.822229444305;7138.535995160298;7183.389411900047;6884.380405763505;6927.68825402848;6937.340952609696;6939;6948.374646281859;6901.137357830271;6903.0680858083515;6935.167779866449;6948.305169483011;6956.9216771400515;6712.093867327848;6804.523683342119;6835.863282734417;6846.3495967884965;6849.897251541331;6942;6952.930470695228;7002.8949565757575;7004.754833580801;7043.542169758949;6765.594064356154;6788.626625535643;6791.796246112624;6793.150856142982;6798 12:07:54 INFO - PROCESS | 4019 | |5;yui.html;836.8619177835658;897.1342654338566;903.4263242840798;910.899801021887;920.6915683246115;14531.854681453182;14779.482718104882;14795.556133315991;14816.629584260372;14836.109833409975;14184.929075354634;14211.147331160138;14216.218108004055;14232.074915130535;14239.92880035601;753.638253638254;892.7723430525207;907.7639813648433;909.231699214163;915.3318077803208;909.7998440343114;910.7814124610112;913.9131782480687;917.1699611851285;919.9264058875308;958.515949445529;959.7456673981366;960.6205548808216;961.0149596663406;963.8361478548663;949.7388218240005;952.5951470624991;958.1951161024703;960.8943016268205;960.9711708648751;698.4970821008866;706.6996526476279;707.6143501791536;709.6168069242602;711.1999001123736;14421.78367324491;14578.708425831424;14627.414903403851;14629.122252664874;14688;14291;14469.855301446956;14470.855291447162;14642.04826686262;14642.853571464362;11504.194706370557;11545.595904143314;11601.76796464066;11673.124515661359;11734.589289374831;3938.9015274618077;3980.7611543307494;4058.7767672777986;4081.4898137732785;4091.85678501254;51052.74473627608;51349.74325128388;51385;51431;51717.74141129308;10362.585496580203;10592.311499752492;10610.490367862683;10748.94625526883;10817.891821081847;19802.20791168366;19989.700154497696;20027.49931251701;20064.89967550182;20135.798642013393;8164.142765009708;8194.09864914859;8329.208725171098;8407.41148119638;8530.14698530142;4816.54242846929;4854.417469903564;4878.902421951541;4884.67968784882;4885.877853053702;3398.3882901078046;3418.9487157692656;3425.811580363054;3435.0725304167736;3444.534987776618;598.2014011294883;604.9062395328731;605.6335916770379;605.6668832142304;612.4304396910827;602.9366916473707;615.833724894285;725.4305370284302;729.8941653460219;754.7735679296189;9274;9548.61805527785;9602.423854568748;9791.853122203172;9845.80308393828;664.219542038113;727.098397986493;729.493002363363;731.7146312937958;736.7531876821217;4323.351497275371;4402.3836662867225;4437;4450.621697155713;4467.620252278528;63915.36084639094;64166.358336416975;64255;64845;71861.28138718546;57412;58348.12477812836;58934.70532647309;59905;60254.69872650696;53429.465705343224;54265.45734542683;54390;54610.45389546133;55223.44776552183;9569.234461242944;9629.374090684083;9743.707688769347;9773.706788796348;9855.11303982645;36799.816000919825;37504.62495375011;39047.02382440462;39852.2029559413;41624;47373.763131184125;47620.6189690521;52288.477115229885;52818;53305.37666616806;11721.335470138642;11927.582534611247;11985.760284794082;12730.299833509245;12730.809037864254;13466.259355735529;14224;14229.217393043067;14256.287185640884;14428.495002674856;12398.5660501882;12552.184108032949;13042.478300867859;13065.804012939623;13405.262710551013;11613.187076904536;12150.57472988441;12192.390380480763;12374.81437778416;12743;11961.940190298992;12321.260724356567;12409.75180496367;12573.371331433575;12958.546450874173;9727.173190278623;9985.051420115078;11003.33979961205;11147.609833655782;11260.436978151223;11019.550493379353;11175.608853690082;11297.830532541853;11323.547058117583;11363.659090227306 12:07:54 INFO - PROCESS | 4019 | __end_tp_report 12:07:54 INFO - PROCESS | 4019 | __start_cc_report 12:07:54 INFO - PROCESS | 4019 | _x_x_mozilla_cycle_collect,339 12:07:54 INFO - PROCESS | 4019 | __end_cc_report 12:07:54 INFO - PROCESS | 4019 | __startTimestamp1458414474552__endTimestamp 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | ------- Summary: start ------- 12:07:54 INFO - PROCESS | 4019 | Number of tests: 6 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#0] dojo.html Cycles:165 Average:5450.89 Median:5683.57 stddev:591.63 (10.4%) stddev-sans-first:568.07 12:07:54 INFO - PROCESS | 4019 | Values: 3266.1 3302.5 3336.2 3364.6 3372.3 5388.2 5412.3 5438.1 5439.9 5456.1 5422.7 5454.8 5456.5 5457.4 5488.1 4953.1 4986.2 5045.0 5057.7 5147.1 4818.8 4976.5 5128.1 5141.0 5149.5 5006.9 5023.6 5071.6 5131.6 5173.9 5094.2 5099.9 5108.2 5114.9 5148.4 4859.8 4947.8 5073.1 5084.7 5102.2 5316.8 5322.6 5326.9 5345.2 5347.7 5863.0 5883.2 5897.2 5906.7 5913.3 5791.3 5872.8 5878.1 5905.3 5942.2 5412.6 5440.8 5445.5 5460.1 5463.3 5926.6 5935.6 5945.6 5963.7 6013.5 5716.7 5739.7 5746.2 5766.0 5785.7 5840.6 5841.2 5858.2 5864.5 5864.9 5731.1 5807.7 5839.8 5844.5 5880.7 5804.9 5837.5 5838.2 5839.1 5846.7 4463.5 4483.7 4488.6 4488.7 4504.7 3966.8 4005.9 4014.3 4029.0 4030.4 5350.2 5400.4 5403.3 5432.0 5511.4 5879.2 5889.3 5892.0 5893.4 5903.5 5411.6 5536.5 5544.5 5546.2 5556.5 5010.4 5044.6 5090.2 5095.7 5136.1 6041.8 6057.1 6100.2 6101.8 6123.8 5771.7 5904.0 5906.0 5916.3 5928.3 6027.3 6090.3 6095.5 6109.1 6116.7 5728.5 5770.9 5771.2 5773.0 5775.9 5760.1 5855.7 5858.7 5859.0 5867.9 5705.1 5738.4 5741.1 5742.1 5753.5 5683.6 5691.1 5726.3 5726.7 5730.5 5566.5 5632.9 5638.4 5640.1 5740.5 5722.5 5780.5 5800.7 5818.9 5828.8 5651.3 5655.8 5663.5 5694.5 5696.9 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#1] ext.html Cycles:180 Average:52776.23 Median:38781.52 stddev:100249.31 (258.5%) stddev-sans-first:100453.81 12:07:54 INFO - PROCESS | 4019 | Values: 539.1 572.5 589.7 609.4 626.6 38854.6 39466.4 39549.6 39555.2 39583.8 42404.0 42880.4 42905.0 42938.6 42953.0 8743.3 8979.6 8990.7 9003.3 9013.5 8776.8 8934.7 8976.5 8995.2 8996.3 9225.3 9232.0 9239.4 9245.3 9303.5 9116.3 9145.9 9164.5 9201.0 9235.9 8951.4 9011.3 9063.9 9104.2 9108.8 42855.1 43006.1 43320.6 43369.0 43477.0 3624.3 3682.4 3691.2 3758.6 4177.0 32307.2 32337.0 32432.5 32502.2 33494.2 4370.6 4434.4 4435.5 4460.1 4473.9 293769.0 294978.0 296104.0 298271.0 299134.0 45194.0 45666.8 45743.0 62032.7 62349.7 42893.6 42963.0 42966.8 43048.1 43119.8 15211.2 15302.2 15366.2 15370.2 15396.4 12425.3 12506.7 12521.3 12521.8 12533.6 15212.4 15228.5 15279.1 15404.9 15475.5 6109.5 6173.8 6273.8 6318.1 6353.6 1075.1 1096.6 1104.8 1118.9 1153.7 30101.8 30143.5 30184.2 30406.4 30587.2 1181.4 1191.2 1191.9 1200.4 1341.7 14993.0 15361.7 15414.6 15574.1 15629.5 349367.0 519456.0 527112.0 527521.0 540511.0 57358.7 57504.0 57943.7 58142.4 58208.1 1496.3 1497.6 1504.8 1507.5 1515.0 28354.4 28748.9 29509.4 29732.3 29879.0 48423.5 48787.8 48824.0 48938.3 48983.0 304838.0 305032.0 307330.0 308223.0 309978.0 34320.3 34434.3 34598.3 34708.0 34717.7 48384.5 48880.0 48914.8 49781.5 49787.0 38247.4 38480.8 38896.6 39016.8 39116.6 37098.0 37159.4 37807.4 38727.0 38740.6 37542.2 37764.0 37860.4 38417.8 38822.4 34599.3 35631.6 36517.3 36917.8 37054.4 26353.3 26572.0 26953.1 27161.9 27244.9 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#2] jquery.html Cycles:180 Average:26614.07 Median:2593.78 stddev:75058.65 (2893.8%) stddev-sans-first:75243.35 12:07:54 INFO - PROCESS | 4019 | Values: 373.5 376.1 380.3 383.8 385.6 17671.5 18087.5 18377.2 18426.0 18568.0 17284.7 17684.1 17822.8 17907.0 17926.3 5552.8 5768.9 5786.2 5816.4 5820.7 5510.7 5677.9 5744.5 5750.0 5750.1 5546.8 5608.4 5636.6 5644.2 5665.7 5365.7 5540.8 5555.8 5558.3 5589.4 5050.7 5080.1 5086.9 5100.8 5126.9 22397.3 22409.3 22527.8 23060.7 23266.3 2357.2 2427.2 2549.6 2638.0 3025.4 14159.6 14526.6 14588.3 14677.3 14747.2 1927.5 1990.4 2023.1 2038.9 2053.4 65161.7 66595.7 68008.7 68252.0 69019.0 10252.6 10482.6 10687.3 10792.5 10866.1 13487.6 13532.1 13550.8 13571.3 13746.2 7751.0 7914.3 7953.6 8021.7 8055.3 7908.9 7937.5 7988.4 8043.9 8112.9 6171.9 6262.0 6270.4 6293.8 6335.7 1851.1 1862.5 1889.6 1912.8 1919.0 990.4 996.3 1073.2 1102.8 1176.4 18094.5 18190.5 18246.2 18338.4 18767.7 994.6 1039.1 1075.7 1083.0 1090.1 10795.4 10876.7 10923.7 10946.7 11007.2 450596.0 454516.0 454682.0 464798.0 467552.0 68606.7 70663.0 71234.6 72401.0 72562.6 1104.9 1111.3 1129.2 1157.6 1159.1 15956.0 16001.9 16035.4 16160.1 16324.2 27002.3 35294.8 35550.6 36444.1 36481.5 51887.0 51935.2 52028.0 52063.7 52854.7 8209.9 8236.5 8286.0 8378.7 8476.7 6927.1 8522.7 8996.0 13164.2 13410.3 10989.2 11210.3 11360.1 11373.5 11385.1 11106.4 11432.2 11594.2 11614.4 11908.3 11371.9 11507.5 11581.5 11593.0 11866.2 7856.7 7941.3 8080.4 8323.0 8491.4 9597.6 11367.7 11417.3 11478.7 11531.9 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#3] mootools.html Cycles:180 Average:6025.35 Median:5233.66 stddev:3185.69 (60.9%) stddev-sans-first:3177.15 12:07:54 INFO - PROCESS | 4019 | Values: 1585.4 1586.4 1784.7 1876.0 1917.1 7737.9 8193.6 8555.6 8783.8 8795.1 8182.2 8241.1 8276.1 8291.8 8295.1 2357.8 2399.3 2402.6 2404.6 2405.6 2365.1 2392.1 2405.1 2407.9 2411.0 2416.8 2419.3 2433.2 2441.4 2445.7 2422.7 2423.5 2426.8 2431.7 2462.8 2392.2 2395.6 2395.6 2396.0 2411.3 8505.6 8525.7 8528.5 8577.8 8630.6 5175.0 5292.3 5295.8 5314.8 5324.4 3293.9 3333.9 3387.0 3420.7 3434.6 1081.6 1131.7 1131.9 1142.8 1145.9 12073.3 12179.4 12270.9 12271.0 12280.3 4821.0 4825.2 4844.9 4865.3 4898.4 10350.9 10402.5 10419.4 10450.4 10465.8 5338.1 5342.4 5367.3 5395.6 5410.0 4156.2 4734.5 4825.3 4843.1 4904.4 4010.8 4068.0 4093.2 4099.2 4114.4 1224.9 1233.1 1237.1 1241.8 1247.9 1434.5 1445.2 1451.2 1454.9 1479.4 8315.8 8323.1 8332.6 8334.8 8344.9 493.8 499.6 501.8 509.7 511.1 6170.6 6212.9 6249.8 6269.7 6301.8 10129.6 10319.3 10330.4 10335.4 10337.8 10108.3 10235.3 10298.2 10318.1 10334.4 8151.6 8156.3 8167.6 8187.0 8238.9 7768.8 7798.7 7841.6 8060.0 8214.3 9117.1 9270.2 9295.8 9324.6 9384.5 9406.7 9496.3 9671.0 9685.8 9712.4 6766.4 7283.1 7405.8 7462.4 7498.7 8264.8 8323.9 8326.1 8364.0 8373.8 7394.4 7540.8 7641.0 7670.8 7772.8 7441.1 7459.7 7475.5 7585.2 7607.0 7783.3 7835.4 7868.8 7907.5 7914.8 7069.1 7160.2 7213.7 7292.0 7332.6 7330.5 7369.2 7379.0 7381.5 7387.0 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#4] prototype.html Cycles:180 Average:5685.32 Median:6465.93 stddev:1766.16 (27.3%) stddev-sans-first:1725.05 12:07:54 INFO - PROCESS | 4019 | Values: 346.0 350.4 352.2 355.3 357.1 6395.5 6413.5 6418.5 6432.9 6481.0 6372.1 6375.6 6375.7 6376.0 6379.0 4678.1 4784.9 4790.5 4812.8 4887.6 4759.5 4778.2 4778.3 4787.4 4796.8 4730.4 4730.7 4740.6 4745.7 4748.0 4743.9 4745.5 4751.5 4754.9 4764.1 4080.7 4082.5 4084.3 4086.0 4089.0 6033.9 6053.7 6094.0 6095.7 6118.6 5421.1 5546.1 5546.8 5552.7 5612.6 6674.9 6676.1 6682.7 6714.6 6727.7 4622.6 4632.6 4634.7 4637.6 4641.7 6957.5 6985.6 6985.8 7009.6 7019.4 4655.2 4733.0 4733.2 4740.3 4744.8 4798.0 4800.3 4802.0 4803.8 4819.3 5514.3 5576.0 5576.7 5579.2 5614.1 6801.0 6806.8 6821.7 6835.1 6840.8 1676.1 1698.4 1699.9 1700.2 1703.7 1070.2 1095.6 1097.3 1102.6 1105.2 6461.2 6474.2 6492.5 6503.4 6531.8 7001.9 7018.0 7034.4 7060.6 7070.3 6357.6 6470.7 6471.9 6478.5 6499.8 3767.3 3792.7 3816.6 3839.3 3868.8 7319.2 7378.0 7388.9 7395.4 7399.7 7259.5 7309.8 7310.3 7312.9 7337.8 7164.1 7362.2 7428.5 7448.9 7452.6 7111.8 7163.8 7168.5 7223.5 7248.6 6996.5 7021.5 7031.1 7040.2 7058.6 7361.1 7375.6 7414.8 7422.0 7424.9 4623.8 4693.3 4695.1 4723.1 4728.5 7059.9 7109.9 7110.8 7138.5 7183.4 6884.4 6927.7 6937.3 6939.0 6948.4 6901.1 6903.1 6935.2 6948.3 6956.9 6712.1 6804.5 6835.9 6846.3 6849.9 6942.0 6952.9 7002.9 7004.8 7043.5 6765.6 6788.6 6791.8 6793.2 6798.0 12:07:54 INFO - PROCESS | 4019 | 12:07:54 INFO - PROCESS | 4019 | [#5] yui.html Cycles:180 Average:15498.83 Median:4835.48 stddev:18116.51 (374.7%) stddev-sans-first:18133.87 12:07:54 INFO - PROCESS | 4019 | Values: 836.9 897.1 903.4 910.9 920.7 14531.9 14779.5 14795.6 14816.6 14836.1 14184.9 14211.1 14216.2 14232.1 14239.9 753.6 892.8 907.8 909.2 915.3 909.8 910.8 913.9 917.2 919.9 958.5 959.7 960.6 961.0 963.8 949.7 952.6 958.2 960.9 961.0 698.5 706.7 707.6 709.6 711.2 14421.8 14578.7 14627.4 14629.1 14688.0 14291.0 14469.9 14470.9 14642.0 14642.9 11504.2 11545.6 11601.8 11673.1 11734.6 3938.9 3980.8 4058.8 4081.5 4091.9 51052.7 51349.7 51385.0 51431.0 51717.7 10362.6 10592.3 10610.5 10748.9 10817.9 19802.2 19989.7 20027.5 20064.9 20135.8 8164.1 8194.1 8329.2 8407.4 8530.1 4816.5 4854.4 4878.9 4884.7 4885.9 3398.4 3418.9 3425.8 3435.1 3444.5 598.2 604.9 605.6 605.7 612.4 602.9 615.8 725.4 729.9 754.8 9274.0 9548.6 9602.4 9791.9 9845.8 664.2 727.1 729.5 731.7 736.8 4323.4 4402.4 4437.0 4450.6 4467.6 63915.4 64166.4 64255.0 64845.0 71861.3 57412.0 58348.1 58934.7 59905.0 60254.7 53429.5 54265.5 54390.0 54610.5 55223.4 9569.2 9629.4 9743.7 9773.7 9855.1 36799.8 37504.6 39047.0 39852.2 41624.0 47373.8 47620.6 52288.5 52818.0 53305.4 11721.3 11927.6 11985.8 12730.3 12730.8 13466.3 14224.0 14229.2 14256.3 14428.5 12398.6 12552.2 13042.5 13065.8 13405.3 11613.2 12150.6 12192.4 12374.8 12743.0 11961.9 12321.3 12409.8 12573.4 12958.5 9727.2 9985.1 11003.3 11147.6 11260.4 11019.6 11175.6 11297.8 11323.5 11363.7 12:07:54 INFO - PROCESS | 4019 | -------- Summary: end -------- 12:07:54 INFO - PROCESS | 4019 | 12:07:55 INFO - TEST-INFO | 4019: exit 0 12:07:55 INFO - TEST-OK | dromaeo_css | took 1111135ms 12:07:55 INFO - TEST-START | kraken 12:07:55 INFO - operating with platform_type : linux_ 12:07:55 INFO - Initialising browser for kraken test... 12:07:55 INFO - TEST-INFO | started process 4266 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBBt3LV/profile http://localhost:50407/getInfo.html) 12:07:59 INFO - PROCESS | 4266 | 12:07:59 INFO - PROCESS | 4266 | (process:4343): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:08:00 INFO - PROCESS | 4266 | __metrics Screen width/height:1600/1200 12:08:00 INFO - PROCESS | 4266 | colorDepth:24 12:08:00 INFO - PROCESS | 4266 | Browser inner width/height: 1024/697 12:08:00 INFO - PROCESS | 4266 | __metrics 12:08:01 ERROR - PROCESS | 4266 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:08:02 INFO - TEST-INFO | 4266: exit 0 12:08:02 INFO - Browser initialized. 12:08:02 INFO - Running cycle 1/1 for kraken test... 12:08:02 INFO - TEST-INFO | started process 4394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBBt3LV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:03 INFO - PROCESS | 4394 | 12:08:03 INFO - PROCESS | 4394 | (process:4460): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:08:13 INFO - PROCESS | 4394 | RSS: Main: 154738688 12:08:13 INFO - PROCESS | 4394 | 12:08:16 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50407/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:17 INFO - PROCESS | 4394 | RSS: Main: 157974528 12:08:17 INFO - PROCESS | 4394 | 12:08:19 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50407/tests/kraken/driver.html?testName=audio-dft) 12:08:20 INFO - PROCESS | 4394 | RSS: Main: 158433280 12:08:20 INFO - PROCESS | 4394 | 12:08:23 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50407/tests/kraken/driver.html?testName=audio-fft) 12:08:23 INFO - PROCESS | 4394 | RSS: Main: 159789056 12:08:23 INFO - PROCESS | 4394 | 12:08:25 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50407/tests/kraken/driver.html?testName=audio-oscillator) 12:08:26 INFO - PROCESS | 4394 | RSS: Main: 159526912 12:08:26 INFO - PROCESS | 4394 | 12:08:28 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50407/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:29 INFO - PROCESS | 4394 | RSS: Main: 158560256 12:08:29 INFO - PROCESS | 4394 | 12:08:32 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50407/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:32 INFO - PROCESS | 4394 | RSS: Main: 157982720 12:08:32 INFO - PROCESS | 4394 | 12:08:36 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50407/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:36 INFO - PROCESS | 4394 | RSS: Main: 159588352 12:08:36 INFO - PROCESS | 4394 | 12:08:39 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50407/tests/kraken/driver.html?testName=json-parse-financial) 12:08:40 INFO - PROCESS | 4394 | RSS: Main: 158212096 12:08:40 INFO - PROCESS | 4394 | 12:08:41 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50407/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:42 INFO - PROCESS | 4394 | RSS: Main: 159047680 12:08:42 INFO - PROCESS | 4394 | 12:08:44 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:44 INFO - PROCESS | 4394 | RSS: Main: 159809536 12:08:44 INFO - PROCESS | 4394 | 12:08:46 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:47 INFO - PROCESS | 4394 | RSS: Main: 159100928 12:08:47 INFO - PROCESS | 4394 | 12:08:49 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:50 INFO - PROCESS | 4394 | RSS: Main: 159100928 12:08:50 INFO - PROCESS | 4394 | 12:08:52 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:53 INFO - PROCESS | 4394 | RSS: Main: 159072256 12:08:53 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:50407/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50407/tests/kraken/driver.html?testName=ai-astar) 12:08:55 INFO - PROCESS | 4394 | RSS: Main: 159817728 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | __start_tp_report 12:08:55 INFO - PROCESS | 4394 | _x_x_mozilla_page_load 12:08:55 INFO - PROCESS | 4394 | _x_x_mozilla_page_load_details 12:08:55 INFO - PROCESS | 4394 | |i|pagename|runs| 12:08:55 INFO - PROCESS | 4394 | |0;ai-astar;113;105;110;110;111;121;111;110;109;111 12:08:55 INFO - PROCESS | 4394 | |1;audio-beat-detection;154;125;152;159;126;155;150;134;174;126 12:08:55 INFO - PROCESS | 4394 | |2;audio-dft;165;163;164;162;164;163;160;162;165;160 12:08:55 INFO - PROCESS | 4394 | |3;audio-fft;73;72;74;160;72;74;73;75;165;76 12:08:55 INFO - PROCESS | 4394 | |4;audio-oscillator;92;93;138;93;93;93;141;92;94;145 12:08:55 INFO - PROCESS | 4394 | |5;imaging-gaussian-blur;117;118;117;116;119;117;118;117;117;117 12:08:55 INFO - PROCESS | 4394 | |6;imaging-darkroom;147;146;147;147;147;146;146;146;146;147 12:08:55 INFO - PROCESS | 4394 | |7;imaging-desaturate;95;96;96;95;97;96;97;96;97;96 12:08:55 INFO - PROCESS | 4394 | |8;json-parse-financial;60;56;56;57;58;56;62;63;54;54 12:08:55 INFO - PROCESS | 4394 | |9;json-stringify-tinderbox;65;66;66;65;67;65;66;66;65;65 12:08:55 INFO - PROCESS | 4394 | |10;stanford-crypto-aes;79;80;79;79;82;79;82;87;78;87 12:08:55 INFO - PROCESS | 4394 | |11;stanford-crypto-ccm;109;110;113;111;114;114;126;126;112;111 12:08:55 INFO - PROCESS | 4394 | |12;stanford-crypto-pbkdf2;135;138;143;147;137;136;144;146;146;135 12:08:55 INFO - PROCESS | 4394 | |13;stanford-crypto-sha256-iterative;66;66;69;75;66;67;64;69;69;67 12:08:55 INFO - PROCESS | 4394 | __end_tp_report 12:08:55 INFO - PROCESS | 4394 | __start_cc_report 12:08:55 INFO - PROCESS | 4394 | _x_x_mozilla_cycle_collect,845 12:08:55 INFO - PROCESS | 4394 | __end_cc_report 12:08:55 INFO - PROCESS | 4394 | __startTimestamp1458414535351__endTimestamp 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | ------- Summary: start ------- 12:08:55 INFO - PROCESS | 4394 | Number of tests: 14 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:4.04 (3.6%) stddev-sans-first:4.23 12:08:55 INFO - PROCESS | 4394 | Values: 113.0 105.0 110.0 110.0 111.0 121.0 111.0 110.0 109.0 111.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:153.00 stddev:16.77 (11.0%) stddev-sans-first:17.51 12:08:55 INFO - PROCESS | 4394 | Values: 154.0 125.0 152.0 159.0 126.0 155.0 150.0 134.0 174.0 126.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.50 stddev:1.81 (1.1%) stddev-sans-first:1.74 12:08:55 INFO - PROCESS | 4394 | Values: 165.0 163.0 164.0 162.0 164.0 163.0 160.0 162.0 165.0 160.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#3] audio-fft Cycles:10 Average:91.40 Median:73.50 stddev:37.51 (51.0%) stddev-sans-first:39.19 12:08:55 INFO - PROCESS | 4394 | Values: 73.0 72.0 74.0 160.0 72.0 74.0 73.0 75.0 165.0 76.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:23.48 (25.2%) stddev-sans-first:24.24 12:08:55 INFO - PROCESS | 4394 | Values: 92.0 93.0 138.0 93.0 93.0 93.0 141.0 92.0 94.0 145.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 12:08:55 INFO - PROCESS | 4394 | Values: 117.0 118.0 117.0 116.0 119.0 117.0 118.0 117.0 117.0 117.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:08:55 INFO - PROCESS | 4394 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 12:08:55 INFO - PROCESS | 4394 | Values: 95.0 96.0 96.0 95.0 97.0 96.0 97.0 96.0 97.0 96.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:3.13 (5.5%) stddev-sans-first:3.20 12:08:55 INFO - PROCESS | 4394 | Values: 60.0 56.0 56.0 57.0 58.0 56.0 62.0 63.0 54.0 54.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 12:08:55 INFO - PROCESS | 4394 | Values: 65.0 66.0 66.0 65.0 67.0 65.0 66.0 66.0 65.0 65.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.33 (4.1%) stddev-sans-first:3.43 12:08:55 INFO - PROCESS | 4394 | Values: 79.0 80.0 79.0 79.0 82.0 79.0 82.0 87.0 78.0 87.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:113.50 stddev:6.22 (5.5%) stddev-sans-first:6.26 12:08:55 INFO - PROCESS | 4394 | Values: 109.0 110.0 113.0 111.0 114.0 114.0 126.0 126.0 112.0 111.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:143.50 stddev:4.95 (3.4%) stddev-sans-first:4.80 12:08:55 INFO - PROCESS | 4394 | Values: 135.0 138.0 143.0 147.0 137.0 136.0 144.0 146.0 146.0 135.0 12:08:55 INFO - PROCESS | 4394 | 12:08:55 INFO - PROCESS | 4394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:3.01 (4.4%) stddev-sans-first:3.12 12:08:55 INFO - PROCESS | 4394 | Values: 66.0 66.0 69.0 75.0 66.0 67.0 64.0 69.0 69.0 67.0 12:08:55 INFO - PROCESS | 4394 | -------- Summary: end -------- 12:08:55 INFO - PROCESS | 4394 | 12:08:56 INFO - TEST-INFO | 4394: exit 0 12:08:56 INFO - TEST-OK | kraken | took 61105ms 12:08:56 INFO - SUITE-END | took 1172s 12:08:56 INFO - Completed test suite (00:19:32) 12:08:56 INFO - javascript benchmark 12:08:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3266.052844675044, 3302.5046243063543, 3336.2493438976217, 3364.6130694970084, 3372.291818718069, 5388.245645609618, 5412.323459567554, 5438.129899216126, 5439.864003399917, 5456.127019676853, 5422.728863556817, 5454.754536045877, 5456.508914197721, 5457.399686034533, 5488.067028605136, 4953.058918805434, 4986.152354099793, 5044.9747751261375, 5057.721825299607, 5147.099257629919, 4818.759062046901, 4976.4774698656665, 5128.05131050755, 5140.974295128519, 5149.510796474329, 5006.874828129289, 5023.572996295301, 5071.56891664209, 5131.61512886535, 5173.922391164117, 5094.184930411135, 5099.898002039957, 5108.233764935252, 5114.897702045938, 5148.3564554430695, 4859.757012149378, 4947.82682606107, 5073.061483625541, 5084.720340381277, 5102.158143906288, 5316.813911513117, 5322.627416080876, 5326.866828329284, 5345.224942383372, 5347.7058761768085, 5863.0, 5883.17635531026, 5897.174395584621, 5906.704664766788, 5913.2608423947, 5791.333996590404, 5872.765089396419, 5878.118282257653, 5905.261842269716, 5942.168096466498, 5412.5940554458175, 5440.755166017539, 5445.455454454563, 5460.099083651193, 5463.289772329612, 5926.555508336892, 5935.643861368331, 5945.554083443759, 5963.701814909237, 6013.45878870895, 5716.742746576414, 5739.741711622987, 5746.224259724967, 5766.0, 5785.71071446426, 5840.561957853178, 5841.153032810304, 5858.238429004287, 5864.530837532987, 5864.912026319608, 5731.140328950607, 5807.709614519257, 5839.766409343579, 5844.503217226498, 5880.676562789087, 5804.9419505805245, 5837.503812175928, 5838.153467747238, 5839.0949402842625, 5846.6784326862435, 4463.486699029589, 4483.663725220622, 4488.64090872736, 4488.730676159441, 4504.707194032443, 3966.8016599170505, 4005.919881602352, 4014.2774300625583, 4029.0330320722815, 4030.395440683862, 5350.197470379474, 5400.351957765015, 5403.297571315782, 5432.049391356497, 5511.448855114537, 5879.206307148565, 5889.322727886348, 5892.027815410495, 5893.440123188376, 5903.527717782653, 5411.594130440233, 5536.501714845684, 5544.528715059185, 5546.195801608744, 5556.472135147154, 5010.398752149766, 5044.596432285409, 5090.185570308733, 5095.668781529263, 5136.075506408808, 6041.788537401258, 6057.091436284504, 6100.206973093469, 6101.786437474756, 6123.755049798047, 5771.68255745938, 5903.970480147572, 5906.0, 5916.319623243382, 5928.347881733006, 6027.336992930862, 6090.2996155440915, 6095.512359011357, 6109.053096770008, 6116.694165291807, 5728.484436400744, 5770.942290577041, 5771.163181338767, 5772.971135144466, 5775.8556036099435, 5760.135979603093, 5855.736491857791, 5858.736356864037, 5859.0, 5867.911981320198, 5705.144228365778, 5738.397468265772, 5741.13882917549, 5742.08126699726, 5753.510951569164, 5683.573731970201, 5691.117876729114, 5726.284214473191, 5726.742296596746, 5730.5129064030025, 5566.4990150886615, 5632.887342253214, 5638.379778224474, 5640.097584386478, 5740.540756739368, 5722.542196624343, 5780.479756821906, 5800.738966746591, 5818.912716309174, 5828.795992140254, 5651.265335506358, 5655.773769049192, 5663.518600918968, 5694.544436444991, 5696.886062278814], "unit": "score", "name": "dojo.html", "value": 5413.329182555986}, {"lowerIsBetter": false, "replicates": [539.1328625548159, 572.5047833623917, 589.7493565234777, 609.3540846702497, 626.5989766549408, 38854.61145388545, 39466.408003879966, 39549.60450395495, 39555.2088958221, 39583.802080989626, 42404.0, 42880.356794648105, 42905.0, 42938.57061429385, 42953.0, 8743.300535957109, 8979.640814367418, 8990.68532601359, 9003.324750643695, 9013.54932253388, 8776.780580485507, 8934.73195804127, 8976.506292153961, 8995.235404990584, 8996.325275604357, 9225.261979041694, 9232.030636783142, 9239.399439036475, 9245.260379169684, 9303.534823258844, 9116.316276279273, 9145.862812057825, 9164.541772911327, 9200.953995230047, 9235.907640923571, 8951.41815781972, 9011.27909767217, 9063.909360906438, 9104.226140778042, 9108.772280692969, 42855.14289714219, 43006.13987720228, 43320.566794332284, 43369.0, 43477.0, 3624.2751449710163, 3682.4476328550663, 3691.151035261878, 3758.586555478895, 4177.0, 32307.19232019195, 32337.029889103364, 32432.513512297333, 32502.18744531382, 33494.16264593405, 4370.562943705636, 4434.423524941769, 4435.467743870724, 4460.085682435093, 4473.910521789546, 293769.0, 294978.0, 296104.0, 298271.0, 299134.0, 45194.0, 45666.77166614146, 45743.0, 62032.68983655143, 62349.68825155845, 42893.57106428958, 42963.0, 42966.785166074595, 43048.13903721908, 43119.78440107779, 15211.239438028275, 15302.158381289137, 15366.154861482502, 15370.231488425758, 15396.384144634314, 12425.31660758667, 12506.687332816753, 12521.311327876872, 12521.812172817416, 12533.561325353568, 15212.391504339703, 15228.46700365482, 15279.083255004734, 15404.92297538505, 15475.458358957383, 6109.541784366191, 6173.8456538586, 6273.780417685359, 6318.08387783778, 6353.618782873043, 1075.1452595186688, 1096.627146770102, 1104.7845670094255, 1118.9425992437232, 1153.7231064544449, 30101.849490752407, 30143.547846782316, 30184.24539386489, 30406.391872162432, 30587.2353191172, 1181.3915833345834, 1191.1780871198846, 1191.9046476281876, 1200.4357951762659, 1341.7316536692701, 14993.0, 15361.692766144615, 15414.614634634223, 15574.065556066673, 15629.531114066369, 349367.0, 519456.0, 527112.0, 527521.0, 540511.0, 57358.7132064337, 57504.0, 57943.71028144832, 58142.41857581455, 58208.12687809686, 1496.2593516209547, 1497.6147063966005, 1504.7872791590034, 1507.5402002389158, 1514.9848501515064, 28354.432911341246, 28748.856255718587, 29509.409811803213, 29732.256693582833, 29879.022598419015, 48423.5157648419, 48787.75606122088, 48824.0, 48938.26592601185, 48983.0, 304838.0, 305032.0, 307330.0, 308223.0, 309978.0, 34320.313593727486, 34434.31131377409, 34598.30803383868, 34708.0, 34717.65282347144, 48384.516154838, 48880.0, 48914.75542622264, 49781.50218497769, 49787.0, 38247.42628860514, 38480.80759596184, 38896.6110338893, 39016.804915976376, 39116.6088339113, 37098.0, 37159.442608360354, 37807.43288850615, 38727.0, 38740.6125938737, 37542.2491550162, 37764.0, 37860.432093518066, 38417.84746457611, 38822.4176637345, 34599.308013840084, 35631.643683562834, 36517.26965460729, 36917.815410922776, 37054.44418333781, 26353.341166470993, 26572.0, 26953.0566430174, 27161.86419067892, 27244.863775680995], "unit": "score", "name": "ext.html", "value": 19306.883292544397}, {"lowerIsBetter": false, "replicates": [373.47526724951433, 376.12926076133755, 380.3249232612115, 383.7735735915809, 385.58934734507767, 17671.469855904328, 18087.547811304725, 18377.173027213776, 18426.0, 18567.978761168146, 17284.654306913853, 17684.11579421027, 17822.821771782277, 17907.0, 17926.282948682037, 5552.805651802188, 5768.855778605526, 5786.218860453848, 5816.389279125694, 5820.708964551776, 5510.724463776795, 5677.886442271152, 5744.511716504102, 5749.965006298865, 5750.079987202049, 5546.805861794838, 5608.355039170487, 5636.577256705743, 5644.153376993463, 5665.660060396369, 5365.704886231256, 5540.833774986757, 5555.777768889239, 5558.333000039981, 5589.385167631537, 5050.696958182484, 5080.110980578384, 5086.949130508685, 5100.795968161269, 5126.948730512684, 22397.328080157622, 22409.32772016842, 22527.774722252732, 23060.654090188662, 23266.3020109397, 2357.210334537932, 2427.211156374168, 2549.5920652695663, 2637.9604305935427, 3025.3949210158057, 14159.575212743634, 14526.564203073818, 14588.27058647074, 14677.339519721638, 14747.188904610242, 1927.469945764912, 1990.3630838131803, 2023.0592774359845, 2038.908249128778, 2053.404512691318, 65161.674191628736, 66595.66702166555, 68008.6599566999, 68252.0, 69019.0, 10252.58989640406, 10482.63310784119, 10687.25189236746, 10792.514336854703, 10866.07638350749, 13487.595372138852, 13532.120412173177, 13550.796738048937, 13571.253581052939, 13746.175229486264, 7751.0, 7914.327282180964, 7953.642086106023, 8021.679132834622, 8055.315298199602, 7908.920910790934, 7937.484063535851, 7988.400869934778, 8043.879341809878, 8112.918870811334, 6171.876562468726, 6262.0, 6270.372962703693, 6293.779717709858, 6335.651539165298, 1851.1114664960626, 1862.5436767991657, 1889.6409682160345, 1912.8182822631827, 1918.9520261993562, 990.3760630802549, 996.3025881882711, 1073.1575713065206, 1102.7684186320803, 1176.3882780953857, 18094.457166285032, 18190.5452363692, 18246.178921948544, 18338.449846504627, 18767.718484222747, 994.6319861651091, 1039.095986491757, 1075.6772968109535, 1082.9928166804789, 1090.0571006079683, 10795.40625265618, 10876.72808179786, 10923.672289831318, 10946.671599851858, 11007.229493935507, 450596.0, 454516.0, 454682.0, 464798.0, 467552.0, 68606.65696671585, 70663.0, 71234.64382678054, 72401.0, 72562.63718681372, 1104.928179668319, 1111.261011427408, 1129.2095533126844, 1157.560127151694, 1159.066951104369, 15956.0, 16001.919990399974, 16035.438759643823, 16160.11119388445, 16324.183790810175, 27002.324941875824, 35294.82352588221, 35550.64449355473, 36444.088897777765, 36481.452778207815, 51887.0, 51935.2209716847, 52028.0, 52063.73968130287, 52854.73572632112, 8209.917900820916, 8236.464629799044, 8286.0, 8378.748637540884, 8476.745697629081, 6927.134108236471, 8522.74431767048, 8996.0, 13164.210147391188, 13410.32948352559, 10989.230753847154, 11210.271332363696, 11360.1479889007, 11373.54505819758, 11385.089192864716, 11106.389148596905, 11432.199746018032, 11594.246373985665, 11614.361210133186, 11908.345041022827, 11371.886281137413, 11507.539698412305, 11581.478833452684, 11593.0, 11866.169368144492, 7856.7250146244605, 7941.324987376138, 8080.353571714131, 8322.958385208036, 8491.448055876348, 9597.616095356108, 11367.715807104889, 11417.31496110236, 11478.713032174262, 11531.942340288246], "unit": "score", "name": "jquery.html", "value": 8994.353623501825}, {"lowerIsBetter": false, "replicates": [1585.3658536585365, 1586.373382513907, 1784.705523588608, 1876.0432179588422, 1917.1277068933628, 7737.883931741028, 8193.631286592103, 8555.572221388937, 8783.824323513525, 8795.076516965722, 8182.222688844565, 8241.052278987918, 8276.131006244348, 8291.792705182374, 8295.087540370554, 2357.787799098081, 2399.2562305685206, 2402.6396040593963, 2404.627282771173, 2405.603075492542, 2365.0894405653776, 2392.055138220402, 2405.1101092595763, 2407.8555286682767, 2411.0, 2416.758324167578, 2419.3104965084954, 2433.1605596069326, 2441.401856545149, 2445.682061332024, 2422.685050943384, 2423.4547226873988, 2426.7573242675767, 2431.671724317221, 2462.778349948513, 2392.186656536786, 2395.616701327797, 2395.6286775549816, 2395.988020059906, 2411.3127758588894, 8505.61724722389, 8525.658973641046, 8528.488290702579, 8577.785555361104, 8630.611622477003, 5175.0, 5292.311999440087, 5295.814646487354, 5314.760835762361, 5324.41431442541, 3293.917652058694, 3333.8833140839956, 3386.9661303386897, 3420.743444241667, 3434.6221915589267, 1081.551156270147, 1131.7000994736402, 1131.9151063670176, 1142.7771584541017, 1145.9484323205477, 12073.335966521838, 12179.39103044853, 12270.877291227063, 12271.0, 12280.324582147978, 4820.9517904821205, 4825.1555977703765, 4844.903101937942, 4865.343178670905, 4898.4121905371585, 10350.948245258725, 10402.531886065146, 10419.374837509773, 10450.372977621368, 10465.84301235482, 5338.065838478328, 5342.385625653022, 5367.302250707383, 5395.568354531628, 5410.026195284808, 4156.231097247019, 4734.526547345306, 4825.348577942003, 4843.07981483517, 4904.362432883774, 4010.7593544386846, 4067.9796601016806, 4093.16090201508, 4099.2416402964955, 4114.382842573578, 1224.9020078393708, 1233.0813543909844, 1237.0969192489533, 1241.757857217852, 1247.8502579690496, 1434.5266062199448, 1445.2340259662396, 1451.2453524167374, 1454.941802327895, 1479.4452080469823, 8315.750527484186, 8323.1260717625, 8332.625031873458, 8334.791630209293, 8344.874826877602, 493.83950216179886, 499.6028157614705, 501.77420160927727, 509.7425799970991, 511.0647515047454, 6170.598911070856, 6212.875742485125, 6249.78125765596, 6269.686515674198, 6301.779437719658, 10129.64546240878, 10319.277650564389, 10330.431826249478, 10335.379877207391, 10337.793244135075, 10108.292419530562, 10235.334703244265, 10298.227632927561, 10318.122959548373, 10334.379937203792, 8151.551664658501, 8156.34749220061, 8167.632456539352, 8187.0, 8238.917610823935, 7768.805779855549, 7798.727044553413, 7841.647125879464, 8060.0, 8214.301784348398, 9117.08829117083, 9270.165685088105, 9295.76760580991, 9324.580393882427, 9384.530773461163, 9406.717798466058, 9496.287778416508, 9670.951645241728, 9685.757856053373, 9712.417254964725, 6766.357196066366, 7283.126024877049, 7405.7778266652085, 7462.403007759258, 7498.7000519980775, 8264.793380165544, 8323.875141872997, 8326.084130745492, 8364.0, 8373.832523349622, 7394.445416593884, 7540.811479713051, 7641.044869391326, 7670.846583068419, 7772.805679858049, 7441.1070671519765, 7459.738909138154, 7475.476716629783, 7585.241475852371, 7606.9619651901385, 7783.299503044753, 7835.37317014626, 7868.763937081897, 7907.48601340911, 7914.802129946797, 7069.081019467436, 7160.212376638461, 7213.71145154188, 7291.963540182265, 7332.633368331669, 7330.486865919548, 7369.226231245856, 7379.0, 7381.483296169216, 7387.0], "unit": "score", "name": "mootools.html", "value": 4839.456148337503}, {"lowerIsBetter": false, "replicates": [346.0483669907754, 350.43929712460067, 352.2215902854691, 355.32488272282677, 357.05024634472306, 6395.488360931126, 6413.454856337211, 6418.518611104162, 6432.935670643292, 6481.0, 6372.139761132245, 6375.649339286338, 6375.713092910819, 6376.043593460983, 6379.011253255753, 4678.064387122572, 4784.904301913977, 4790.473047964721, 4812.783424745895, 4887.584555312794, 4759.4764575896625, 4778.235482322829, 4778.307145463923, 4787.40157480315, 4796.808127674889, 4730.408698912636, 4730.739809310487, 4740.620750339982, 4745.715257084568, 4747.976260118695, 4743.857684269477, 4745.501722319142, 4751.453582837983, 4754.928676069844, 4764.0948219838465, 4080.6735461163034, 4082.4692789937417, 4084.305668036441, 4086.0397806515443, 4089.0390758171807, 6033.909491357633, 6053.667048312341, 6094.0, 6095.725692343855, 6118.60229085108, 5421.132618780976, 5546.084895992157, 5546.750396232179, 5552.7223638818305, 5612.635178713371, 6674.899876501856, 6676.13210282665, 6682.665866706645, 6714.563553369016, 6727.730890764364, 4622.6301895848255, 4632.583067523905, 4634.72191668501, 4637.605803506706, 4641.744704041276, 6957.478189135835, 6985.615791131486, 6985.82535436613, 7009.579425234502, 7019.438444924444, 4655.162070827284, 4732.976335118371, 4733.171694953438, 4740.336352910595, 4744.833930812405, 4797.95202047982, 4800.303955926371, 4802.0, 4803.807847686124, 4819.2530157825595, 5514.310711161105, 5576.0, 5576.693281869455, 5579.246801681721, 5614.07367784311, 6800.965995169992, 6806.76176333826, 6821.658917054227, 6835.1114355134505, 6840.794776156723, 1676.1116608197674, 1698.4395149600603, 1699.9320027199021, 1700.1839117223801, 1703.6848183085922, 1070.1706177712178, 1095.5617752898745, 1097.2977294531506, 1102.5755084292446, 1105.1876870500175, 6461.19235095613, 6474.1907261592305, 6492.545521813522, 6503.447206987365, 6531.771388001397, 7001.894971575431, 7018.017477553147, 7034.40207582351, 7060.611666358297, 7070.292970702992, 6357.554971152067, 6470.676466176672, 6471.870562588721, 6478.514111441661, 6499.805005849832, 3767.2842159989514, 3792.715546334036, 3816.5610954740005, 3839.2705385976574, 3868.7678739275734, 7319.158296795937, 7378.003969464161, 7388.852222955618, 7395.4083673306, 7399.741009064657, 7259.528130671595, 7309.780706578811, 7310.268973102754, 7312.890306645405, 7337.779866604011, 7164.140303163549, 7362.226966168475, 7428.480006399608, 7448.888266676005, 7452.627368631547, 7111.751088711871, 7163.785086447415, 7168.498205125591, 7223.530470519399, 7248.637568121468, 6996.545224560387, 7021.473389495706, 7031.085958825524, 7040.155181378267, 7058.6470676467, 7361.079865016873, 7375.594342311224, 7414.777556673308, 7422.0, 7424.851502970018, 4623.791929363119, 4693.319468677091, 4695.107929493385, 4723.126221649006, 4728.479867214535, 7059.894101588377, 7109.857802844018, 7110.822229444305, 7138.535995160298, 7183.389411900047, 6884.380405763505, 6927.68825402848, 6937.340952609696, 6939.0, 6948.374646281859, 6901.137357830271, 6903.0680858083515, 6935.167779866449, 6948.305169483011, 6956.9216771400515, 6712.093867327848, 6804.523683342119, 6835.863282734417, 6846.3495967884965, 6849.897251541331, 6942.0, 6952.930470695228, 7002.8949565757575, 7004.754833580801, 7043.542169758949, 6765.594064356154, 6788.626625535643, 6791.796246112624, 6793.150856142982, 6798.0], "unit": "score", "name": "prototype.html", "value": 5105.37313658498}, {"lowerIsBetter": false, "replicates": [836.8619177835658, 897.1342654338566, 903.4263242840798, 910.899801021887, 920.6915683246115, 14531.854681453182, 14779.482718104882, 14795.556133315991, 14816.629584260372, 14836.109833409975, 14184.929075354634, 14211.147331160138, 14216.218108004055, 14232.074915130535, 14239.92880035601, 753.638253638254, 892.7723430525207, 907.7639813648433, 909.231699214163, 915.3318077803208, 909.7998440343114, 910.7814124610112, 913.9131782480687, 917.1699611851285, 919.9264058875308, 958.515949445529, 959.7456673981366, 960.6205548808216, 961.0149596663406, 963.8361478548663, 949.7388218240005, 952.5951470624991, 958.1951161024703, 960.8943016268205, 960.9711708648751, 698.4970821008866, 706.6996526476279, 707.6143501791536, 709.6168069242602, 711.1999001123736, 14421.78367324491, 14578.708425831424, 14627.414903403851, 14629.122252664874, 14688.0, 14291.0, 14469.855301446956, 14470.855291447162, 14642.04826686262, 14642.853571464362, 11504.194706370557, 11545.595904143314, 11601.76796464066, 11673.124515661359, 11734.589289374831, 3938.9015274618077, 3980.7611543307494, 4058.7767672777986, 4081.4898137732785, 4091.85678501254, 51052.74473627608, 51349.74325128388, 51385.0, 51431.0, 51717.74141129308, 10362.585496580203, 10592.311499752492, 10610.490367862683, 10748.94625526883, 10817.891821081847, 19802.20791168366, 19989.700154497696, 20027.49931251701, 20064.89967550182, 20135.798642013393, 8164.142765009708, 8194.09864914859, 8329.208725171098, 8407.41148119638, 8530.14698530142, 4816.54242846929, 4854.417469903564, 4878.902421951541, 4884.67968784882, 4885.877853053702, 3398.3882901078046, 3418.9487157692656, 3425.811580363054, 3435.0725304167736, 3444.534987776618, 598.2014011294883, 604.9062395328731, 605.6335916770379, 605.6668832142304, 612.4304396910827, 602.9366916473707, 615.833724894285, 725.4305370284302, 729.8941653460219, 754.7735679296189, 9274.0, 9548.61805527785, 9602.423854568748, 9791.853122203172, 9845.80308393828, 664.219542038113, 727.098397986493, 729.493002363363, 731.7146312937958, 736.7531876821217, 4323.351497275371, 4402.3836662867225, 4437.0, 4450.621697155713, 4467.620252278528, 63915.36084639094, 64166.358336416975, 64255.0, 64845.0, 71861.28138718546, 57412.0, 58348.12477812836, 58934.70532647309, 59905.0, 60254.69872650696, 53429.465705343224, 54265.45734542683, 54390.0, 54610.45389546133, 55223.44776552183, 9569.234461242944, 9629.374090684083, 9743.707688769347, 9773.706788796348, 9855.11303982645, 36799.816000919825, 37504.62495375011, 39047.02382440462, 39852.2029559413, 41624.0, 47373.763131184125, 47620.6189690521, 52288.477115229885, 52818.0, 53305.37666616806, 11721.335470138642, 11927.582534611247, 11985.760284794082, 12730.299833509245, 12730.809037864254, 13466.259355735529, 14224.0, 14229.217393043067, 14256.287185640884, 14428.495002674856, 12398.5660501882, 12552.184108032949, 13042.478300867859, 13065.804012939623, 13405.262710551013, 11613.187076904536, 12150.57472988441, 12192.390380480763, 12374.81437778416, 12743.0, 11961.940190298992, 12321.260724356567, 12409.75180496367, 12573.371331433575, 12958.546450874173, 9727.173190278623, 9985.051420115078, 11003.33979961205, 11147.609833655782, 11260.436978151223, 11019.550493379353, 11175.608853690082, 11297.830532541853, 11323.547058117583, 11363.659090227306], "unit": "score", "name": "yui.html", "value": 7027.259030335044}], "name": "dromaeo_css", "value": 7392.623980503612}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 110.0, 110.0, 111.0, 121.0, 111.0, 110.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 152.0, 159.0, 126.0, 155.0, 150.0, 134.0, 174.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 164.0, 162.0, 164.0, 163.0, 160.0, 162.0, 165.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 160.0, 72.0, 74.0, 73.0, 75.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 138.0, 93.0, 93.0, 93.0, 141.0, 92.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 116.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 56.0, 56.0, 57.0, 58.0, 56.0, 62.0, 63.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 79.0, 79.0, 82.0, 79.0, 82.0, 87.0, 78.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 113.0, 111.0, 114.0, 114.0, 126.0, 126.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.6}, {"lowerIsBetter": true, "replicates": [135.0, 138.0, 143.0, 147.0, 137.0, 136.0, 144.0, 146.0, 146.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 69.0, 75.0, 66.0, 67.0, 64.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1505.6}]} 12:08:56 INFO - Return code: 0 12:08:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:08:56 ERROR - # TBPL SUCCESS # 12:08:56 INFO - Running post-action listener: _resource_record_post_action 12:08:56 INFO - Running post-run listener: _resource_record_post_run 12:08:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 708608; Write bytes: 246317056; Read time: 156; Write time: 690780 12:08:57 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 1490944; Read time: 0; Write time: 164 12:08:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 708608; Write bytes: 244826112; Read time: 156; Write time: 690616 12:08:57 INFO - Running post-run listener: _upload_blobber_files 12:08:57 INFO - Blob upload gear active. 12:08:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:08:57 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 12:08:57 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 12:08:57 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 12:08:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:08:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:59 INFO - (blobuploader) - INFO - Done attempting. 12:08:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:08:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:08:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:59 INFO - (blobuploader) - INFO - Done attempting. 12:08:59 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:59 INFO - Return code: 0 12:08:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 12:08:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b35da574cc2178a528dfb56ff2febb0cf86b9db7f6aaf0d5722cd053ec866b35326b6edc1e77e497a6bd24e4d6c222f41d5d3bfd52a79e2ea9c0cb56408f4271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c3dfe616b229d513abc412ba3ff903f817303e7f379261c275cc4a29b5cd6bf3f7fa4e7222e3371e49ab1cde73e40a246870e2f5aa8e895afa6fcb12393f3b5"} 12:08:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 12:08:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 12:08:59 INFO - Contents: 12:08:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b35da574cc2178a528dfb56ff2febb0cf86b9db7f6aaf0d5722cd053ec866b35326b6edc1e77e497a6bd24e4d6c222f41d5d3bfd52a79e2ea9c0cb56408f4271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c3dfe616b229d513abc412ba3ff903f817303e7f379261c275cc4a29b5cd6bf3f7fa4e7222e3371e49ab1cde73e40a246870e2f5aa8e895afa6fcb12393f3b5"} 12:08:59 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:59 INFO - Copying logs to upload dir... 12:08:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 12:08:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.325106 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-03-19 12:08:59.969383) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 12:08:59.972756) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b35da574cc2178a528dfb56ff2febb0cf86b9db7f6aaf0d5722cd053ec866b35326b6edc1e77e497a6bd24e4d6c222f41d5d3bfd52a79e2ea9c0cb56408f4271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c3dfe616b229d513abc412ba3ff903f817303e7f379261c275cc4a29b5cd6bf3f7fa4e7222e3371e49ab1cde73e40a246870e2f5aa8e895afa6fcb12393f3b5"} build_url:https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/AoOYr8K_TwqL6B_RxrlxoA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b35da574cc2178a528dfb56ff2febb0cf86b9db7f6aaf0d5722cd053ec866b35326b6edc1e77e497a6bd24e4d6c222f41d5d3bfd52a79e2ea9c0cb56408f4271", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c3dfe616b229d513abc412ba3ff903f817303e7f379261c275cc4a29b5cd6bf3f7fa4e7222e3371e49ab1cde73e40a246870e2f5aa8e895afa6fcb12393f3b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-19 12:08:59.997987) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 12:08:59.998367) ========= 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=8783db0840cc980e80bb0bd400000236-1458411484.755045-544739245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004710 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-19 12:09:00.081579) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 12:09:00.081952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-19 12:09:00.082339) ========= ========= Total master_lag: 0.26 =========