builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1457578383.28 results: success (0) buildid: 20160309163013 builduid: 1edfbd72ffd041db962f1b7d3d8271b3 revision: 37b591f543635f193c7329451ad54f1b8c647414 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.275897) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.276394) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.276711) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006203 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.306337) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.306688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.336266) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.336626) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030350 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.399937) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.400210) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.407746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.408068) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 18:53:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.6M=0s 2016-03-09 18:53:03 (31.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.584824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.588193) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.084006 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.689037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:03.689382) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 37b591f543635f193c7329451ad54f1b8c647414 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 37b591f543635f193c7329451ad54f1b8c647414 --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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 18:53:03,742 truncating revision to first 12 chars 2016-03-09 18:53:03,742 Setting DEBUG logging. 2016-03-09 18:53:03,742 attempt 1/10 2016-03-09 18:53:03,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/37b591f54363?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 18:53:04,214 unpacking tar archive at: mozilla-inbound-37b591f54363/testing/mozharness/ program finished with exit code 0 elapsedTime=0.767021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:04.471413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:04.471749) ========= echo 37b591f543635f193c7329451ad54f1b8c647414 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'37b591f543635f193c7329451ad54f1b8c647414'] 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 37b591f543635f193c7329451ad54f1b8c647414 program finished with exit code 0 elapsedTime=0.004652 script_repo_revision: '37b591f543635f193c7329451ad54f1b8c647414' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:04.534502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:04.534842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:53:04.564021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 18:53:04.564448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:04 INFO - MultiFileLogger online at 20160309 18:53:04 in /builds/slave/test-pgo 18:53:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:53:04 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:53:04 INFO - {'append_to_log': False, 18:53:04 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:53:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:53:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:53:04 INFO - 'branch': 'Mozilla-Inbound', 18:53:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:04 INFO - 'config_files': ('talos/linux_config.py',), 18:53:04 INFO - 'default_actions': ('clobber', 18:53:04 INFO - 'read-buildbot-config', 18:53:04 INFO - 'download-and-extract', 18:53:04 INFO - 'populate-webroot', 18:53:04 INFO - 'create-virtualenv', 18:53:04 INFO - 'install', 18:53:04 INFO - 'run-tests'), 18:53:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:04 INFO - 'download_minidump_stackwalk': True, 18:53:04 INFO - 'download_symbols': 'ondemand', 18:53:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:04 INFO - 'installer_path': 'installer.exe', 18:53:04 INFO - 'log_level': 'info', 18:53:04 INFO - 'log_name': 'talos', 18:53:04 INFO - 'log_to_console': True, 18:53:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:04 INFO - 'opt_config_files': (), 18:53:04 INFO - 'pip_index': False, 18:53:04 INFO - 'sps_profile': False, 18:53:04 INFO - 'sps_profile_interval': 0, 18:53:04 INFO - 'suite': 'dromaeojs', 18:53:04 INFO - 'system_bits': '32', 18:53:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:04 INFO - 'title': 'talos-linux64-ix-046', 18:53:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:04 INFO - 'use_talos_json': True, 18:53:04 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:53:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:04 INFO - 'work_dir': 'build'} 18:53:04 INFO - ##### 18:53:04 INFO - ##### Running clobber step. 18:53:04 INFO - ##### 18:53:04 INFO - Running pre-action listener: _resource_record_pre_action 18:53:04 INFO - Running main action method: clobber 18:53:04 INFO - rmtree: /builds/slave/test-pgo/build 18:53:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:53:09 INFO - Running post-action listener: _resource_record_post_action 18:53:09 INFO - ##### 18:53:09 INFO - ##### Running read-buildbot-config step. 18:53:09 INFO - ##### 18:53:09 INFO - Running pre-action listener: _resource_record_pre_action 18:53:09 INFO - Running main action method: read_buildbot_config 18:53:09 INFO - Using buildbot properties: 18:53:09 INFO - { 18:53:09 INFO - "project": "", 18:53:09 INFO - "product": "firefox", 18:53:09 INFO - "script_repo_revision": "production", 18:53:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:53:09 INFO - "repository": "", 18:53:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:53:09 INFO - "buildid": "20160309163013", 18:53:09 INFO - "pgo_build": "True", 18:53:09 INFO - "basedir": "/builds/slave/test-pgo", 18:53:09 INFO - "buildnumber": 780, 18:53:09 INFO - "slavename": "talos-linux64-ix-046", 18:53:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:53:09 INFO - "platform": "ubuntu64_hw", 18:53:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:53:09 INFO - "branch": "mozilla-inbound", 18:53:09 INFO - "repo_path": "integration/mozilla-inbound", 18:53:09 INFO - "revision": "37b591f543635f193c7329451ad54f1b8c647414", 18:53:09 INFO - "stage_platform": "linux64-pgo", 18:53:09 INFO - "builduid": "1edfbd72ffd041db962f1b7d3d8271b3", 18:53:09 INFO - "slavebuilddir": "test" 18:53:09 INFO - } 18:53:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:53:09 INFO - Running post-action listener: _resource_record_post_action 18:53:09 INFO - ##### 18:53:09 INFO - ##### Running download-and-extract step. 18:53:09 INFO - ##### 18:53:09 INFO - Running pre-action listener: _resource_record_pre_action 18:53:09 INFO - Running main action method: download_and_extract 18:53:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:09 INFO - https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:53:09 INFO - Downloaded 1361 bytes. 18:53:09 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:09 INFO - Using the following test package requirements: 18:53:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'jsshell-linux-x86_64.zip'], 18:53:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:09 INFO - https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:12 INFO - Downloaded 23406006 bytes. 18:53:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:13 INFO - Return code: 0 18:53:13 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:13 INFO - https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:20 INFO - Downloaded 23406006 bytes. 18:53:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:21 INFO - Return code: 0 18:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:21 INFO - https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:53:22 INFO - Downloaded 10845161 bytes. 18:53:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:53:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:53:22 INFO - Return code: 0 18:53: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')]} 18:53:22 INFO - https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:53:24 INFO - Downloaded 56235095 bytes. 18:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:24 INFO - mkdir: /builds/slave/test-pgo/properties 18:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:53:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:53:24 INFO - Contents: 18:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:24 INFO - Running post-action listener: _resource_record_post_action 18:53:24 INFO - Running post-action listener: set_extra_try_arguments 18:53:24 INFO - ##### 18:53:24 INFO - ##### Running populate-webroot step. 18:53:24 INFO - ##### 18:53:24 INFO - Running pre-action listener: _resource_record_pre_action 18:53:24 INFO - Running main action method: populate_webroot 18:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:24 INFO - '--tppagecycles', 18:53:24 INFO - '7'], 18:53:24 INFO - 'tests': ['tsvgm']}}, 18:53:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:53:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:53:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'tests': ['damp', 'tps']}, 18:53:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['damp', 'tps']}, 18:53:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:24 INFO - 'other': {'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'other_l64': {'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'other_nol64': {'tests': ['a11yr', 18:53:24 INFO - 'ts_paint', 18:53:24 INFO - 'tpaint', 18:53:24 INFO - 'sessionrestore', 18:53:24 INFO - 'sessionrestore_no_auto_restore', 18:53:24 INFO - 'tabpaint']}, 18:53:24 INFO - 'svgr': {'tests': ['tsvgx', 18:53:24 INFO - 'tsvgr_opacity', 18:53:24 INFO - 'tart', 18:53:24 INFO - 'tscrollx', 18:53:24 INFO - 'cart']}, 18:53:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['tsvgx', 18:53:24 INFO - 'tsvgr_opacity', 18:53:24 INFO - 'tart', 18:53:24 INFO - 'tscrollx', 18:53:24 INFO - 'cart']}, 18:53:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'tests': ['tp5o']}, 18:53:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'talos_options': ['--e10s'], 18:53:24 INFO - 'tests': ['tp5o']}, 18:53:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'talos_options': ['--xperf_path', 18:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:24 INFO - 'tests': ['tp5n']}, 18:53:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:24 INFO - 'talos_options': ['--e10s', 18:53:24 INFO - '--xperf_path', 18:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:24 INFO - 'tests': ['tp5n']}}, 18:53:24 INFO - 'talos.zip': {'path': '', 18:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:24 INFO - Running post-action listener: _resource_record_post_action 18:53:24 INFO - ##### 18:53:24 INFO - ##### Running create-virtualenv step. 18:53:24 INFO - ##### 18:53:24 INFO - Running pre-action listener: _resource_record_pre_action 18:53:24 INFO - Running main action method: create_virtualenv 18:53:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:53:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:53:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:24 INFO - Using real prefix '/usr' 18:53:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:53:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:27 INFO - Installing pip.................done. 18:53:27 INFO - Return code: 0 18:53:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:27 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:27 INFO - Using env: {'DISPLAY': ':0', 18:53:27 INFO - 'HOME': '/home/cltbld', 18:53:27 INFO - 'LANG': 'en_US.UTF-8', 18:53:27 INFO - 'LANGUAGE': 'en_US:en', 18:53:27 INFO - 'LOGNAME': 'cltbld', 18:53:27 INFO - 'MAIL': '/var/mail/cltbld', 18:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:27 INFO - 'MOZ_NO_REMOTE': '1', 18:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:27 INFO - 'NO_EM_RESTART': '1', 18:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:27 INFO - 'SHELL': '/bin/bash', 18:53:27 INFO - 'SHLVL': '1', 18:53:27 INFO - 'TERM': 'linux', 18:53:27 INFO - 'TMOUT': '86400', 18:53:27 INFO - 'USER': 'cltbld', 18:53:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:27 INFO - '_': '/tools/buildbot/bin/python'} 18:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:53:27 INFO - Cleaning up... 18:53:27 INFO - Return code: 0 18:53:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:27 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:53:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:53:27 INFO - Using env: {'DISPLAY': ':0', 18:53:27 INFO - 'HOME': '/home/cltbld', 18:53:27 INFO - 'LANG': 'en_US.UTF-8', 18:53:27 INFO - 'LANGUAGE': 'en_US:en', 18:53:27 INFO - 'LOGNAME': 'cltbld', 18:53:27 INFO - 'MAIL': '/var/mail/cltbld', 18:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:27 INFO - 'MOZ_NO_REMOTE': '1', 18:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:27 INFO - 'NO_EM_RESTART': '1', 18:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:27 INFO - 'SHELL': '/bin/bash', 18:53:27 INFO - 'SHLVL': '1', 18:53:27 INFO - 'TERM': 'linux', 18:53:27 INFO - 'TMOUT': '86400', 18:53:27 INFO - 'USER': 'cltbld', 18:53:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:27 INFO - '_': '/tools/buildbot/bin/python'} 18:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:27 INFO - Downloading/unpacking psutil>=0.7.1 18:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:29 INFO - Installing collected packages: psutil 18:53:29 INFO - Running setup.py install for psutil 18:53:29 INFO - building 'psutil._psutil_linux' extension 18:53:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:53:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:53:30 INFO - building 'psutil._psutil_posix' extension 18:53:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:53:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:30 INFO - Successfully installed psutil 18:53:30 INFO - Cleaning up... 18:53:30 INFO - Return code: 0 18:53:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:30 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:53:30 INFO - Using env: {'DISPLAY': ':0', 18:53:30 INFO - 'HOME': '/home/cltbld', 18:53:30 INFO - 'LANG': 'en_US.UTF-8', 18:53:30 INFO - 'LANGUAGE': 'en_US:en', 18:53:30 INFO - 'LOGNAME': 'cltbld', 18:53:30 INFO - 'MAIL': '/var/mail/cltbld', 18:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:30 INFO - 'MOZ_NO_REMOTE': '1', 18:53:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:30 INFO - 'NO_EM_RESTART': '1', 18:53:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:30 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:30 INFO - 'SHELL': '/bin/bash', 18:53:30 INFO - 'SHLVL': '1', 18:53:30 INFO - 'TERM': 'linux', 18:53:30 INFO - 'TMOUT': '86400', 18:53:30 INFO - 'USER': 'cltbld', 18:53:30 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:30 INFO - '_': '/tools/buildbot/bin/python'} 18:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:53:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:53:32 INFO - Installing collected packages: mozsystemmonitor 18:53:32 INFO - Running setup.py install for mozsystemmonitor 18:53:32 INFO - Successfully installed mozsystemmonitor 18:53:32 INFO - Cleaning up... 18:53:32 INFO - Return code: 0 18:53:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:32 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:53:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:53:32 INFO - Using env: {'DISPLAY': ':0', 18:53:32 INFO - 'HOME': '/home/cltbld', 18:53:32 INFO - 'LANG': 'en_US.UTF-8', 18:53:32 INFO - 'LANGUAGE': 'en_US:en', 18:53:32 INFO - 'LOGNAME': 'cltbld', 18:53:32 INFO - 'MAIL': '/var/mail/cltbld', 18:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:32 INFO - 'MOZ_NO_REMOTE': '1', 18:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:32 INFO - 'NO_EM_RESTART': '1', 18:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:32 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:32 INFO - 'SHELL': '/bin/bash', 18:53:32 INFO - 'SHLVL': '1', 18:53:32 INFO - 'TERM': 'linux', 18:53:32 INFO - 'TMOUT': '86400', 18:53:32 INFO - 'USER': 'cltbld', 18:53:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:32 INFO - '_': '/tools/buildbot/bin/python'} 18:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:32 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:53:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:35 INFO - Downloading docopt-0.6.1.tar.gz 18:53:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:35 INFO - Running setup.py install for blobuploader 18:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:53:35 INFO - Running setup.py install for requests 18:53:35 INFO - Running setup.py install for docopt 18:53:36 INFO - Successfully installed blobuploader requests docopt 18:53:36 INFO - Cleaning up... 18:53:36 INFO - Return code: 0 18:53:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:36 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:53:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:36 INFO - Using env: {'DISPLAY': ':0', 18:53:36 INFO - 'HOME': '/home/cltbld', 18:53:36 INFO - 'LANG': 'en_US.UTF-8', 18:53:36 INFO - 'LANGUAGE': 'en_US:en', 18:53:36 INFO - 'LOGNAME': 'cltbld', 18:53:36 INFO - 'MAIL': '/var/mail/cltbld', 18:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:36 INFO - 'MOZ_NO_REMOTE': '1', 18:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:36 INFO - 'NO_EM_RESTART': '1', 18:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:36 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:36 INFO - 'SHELL': '/bin/bash', 18:53:36 INFO - 'SHLVL': '1', 18:53:36 INFO - 'TERM': 'linux', 18:53:36 INFO - 'TMOUT': '86400', 18:53:36 INFO - 'USER': 'cltbld', 18:53:36 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:36 INFO - '_': '/tools/buildbot/bin/python'} 18:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:36 INFO - Running setup.py (path:/tmp/pip-Pr_qar-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:36 INFO - Running setup.py (path:/tmp/pip-govAfM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:36 INFO - Running setup.py (path:/tmp/pip-7b4N0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:36 INFO - Running setup.py (path:/tmp/pip-JkVrVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:36 INFO - Running setup.py (path:/tmp/pip-XoiGRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:36 INFO - Running setup.py (path:/tmp/pip-7Lh77h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:36 INFO - Running setup.py (path:/tmp/pip-gk5W0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:36 INFO - Running setup.py (path:/tmp/pip-BmoRHm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:36 INFO - Running setup.py (path:/tmp/pip-jY_1jr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:37 INFO - Running setup.py (path:/tmp/pip-rHofEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:37 INFO - Running setup.py (path:/tmp/pip-5j6L31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:37 INFO - Running setup.py (path:/tmp/pip-pOPYAr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:37 INFO - Running setup.py (path:/tmp/pip-BsSvKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:37 INFO - Running setup.py (path:/tmp/pip-7x5WlT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:37 INFO - Running setup.py (path:/tmp/pip-FKHSZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:37 INFO - Running setup.py (path:/tmp/pip-qPB4bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:37 INFO - Running setup.py (path:/tmp/pip-GFzDGU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:37 INFO - Running setup.py install for manifestparser 18:53:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:53:37 INFO - Running setup.py install for mozcrash 18:53:37 INFO - Running setup.py install for mozdebug 18:53:37 INFO - Running setup.py install for mozdevice 18:53:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:53:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozfile 18:53:38 INFO - Running setup.py install for mozhttpd 18:53:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozinfo 18:53:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozInstall 18:53:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozleak 18:53:38 INFO - Running setup.py install for mozlog 18:53:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for moznetwork 18:53:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozprocess 18:53:38 INFO - Running setup.py install for mozprofile 18:53:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:53:38 INFO - Running setup.py install for mozrunner 18:53:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:53:39 INFO - Running setup.py install for mozscreenshot 18:53:39 INFO - Running setup.py install for moztest 18:53:39 INFO - Running setup.py install for mozversion 18:53:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:53:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:39 INFO - Cleaning up... 18:53:39 INFO - Return code: 0 18:53:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:39 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:53:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:39 INFO - Using env: {'DISPLAY': ':0', 18:53:39 INFO - 'HOME': '/home/cltbld', 18:53:39 INFO - 'LANG': 'en_US.UTF-8', 18:53:39 INFO - 'LANGUAGE': 'en_US:en', 18:53:39 INFO - 'LOGNAME': 'cltbld', 18:53:39 INFO - 'MAIL': '/var/mail/cltbld', 18:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:39 INFO - 'MOZ_NO_REMOTE': '1', 18:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:39 INFO - 'NO_EM_RESTART': '1', 18:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:39 INFO - 'SHELL': '/bin/bash', 18:53:39 INFO - 'SHLVL': '1', 18:53:39 INFO - 'TERM': 'linux', 18:53:39 INFO - 'TMOUT': '86400', 18:53:39 INFO - 'USER': 'cltbld', 18:53:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:39 INFO - '_': '/tools/buildbot/bin/python'} 18:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:39 INFO - Running setup.py (path:/tmp/pip-siLvLj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:39 INFO - Running setup.py (path:/tmp/pip-DKB1iY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:39 INFO - Running setup.py (path:/tmp/pip-of5tqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:39 INFO - Running setup.py (path:/tmp/pip-Lducrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:39 INFO - Running setup.py (path:/tmp/pip-xGfUrC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:53:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:39 INFO - Running setup.py (path:/tmp/pip-6_tR44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:40 INFO - Running setup.py (path:/tmp/pip-_kjO22-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:40 INFO - Running setup.py (path:/tmp/pip-hUiTOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:40 INFO - Running setup.py (path:/tmp/pip-VAOOyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:40 INFO - Running setup.py (path:/tmp/pip-p9Tct5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:40 INFO - Running setup.py (path:/tmp/pip-8voX1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:40 INFO - Running setup.py (path:/tmp/pip-6S3qta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:40 INFO - Running setup.py (path:/tmp/pip-HTNkCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:40 INFO - Running setup.py (path:/tmp/pip-nOfOE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:40 INFO - Running setup.py (path:/tmp/pip-KhVHe8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:40 INFO - Running setup.py (path:/tmp/pip-M9K_bL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:53:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:40 INFO - Running setup.py (path:/tmp/pip-_qAg67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:42 INFO - Downloading blessings-1.6.tar.gz 18:53:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:53:42 INFO - Installing collected packages: blessings 18:53:42 INFO - Running setup.py install for blessings 18:53:42 INFO - Successfully installed blessings 18:53:42 INFO - Cleaning up... 18:53:42 INFO - Return code: 0 18:53:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:53:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:53:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:53:43 INFO - Reading from file tmpfile_stdout 18:53:43 INFO - Current package versions: 18:53:43 INFO - argparse == 1.2.1 18:53:43 INFO - blessings == 1.6 18:53:43 INFO - blobuploader == 1.2.4 18:53:43 INFO - docopt == 0.6.1 18:53:43 INFO - manifestparser == 1.1 18:53:43 INFO - mozInstall == 1.12 18:53:43 INFO - mozcrash == 0.17 18:53:43 INFO - mozdebug == 0.1 18:53:43 INFO - mozdevice == 0.48 18:53:43 INFO - mozfile == 1.2 18:53:43 INFO - mozhttpd == 0.7 18:53:43 INFO - mozinfo == 0.9 18:53:43 INFO - mozleak == 0.1 18:53:43 INFO - mozlog == 3.1 18:53:43 INFO - moznetwork == 0.27 18:53:43 INFO - mozprocess == 0.22 18:53:43 INFO - mozprofile == 0.28 18:53:43 INFO - mozrunner == 6.11 18:53:43 INFO - mozscreenshot == 0.1 18:53:43 INFO - mozsystemmonitor == 0.0 18:53:43 INFO - moztest == 0.7 18:53:43 INFO - mozversion == 1.4 18:53:43 INFO - psutil == 3.1.1 18:53:43 INFO - requests == 1.2.3 18:53:43 INFO - wsgiref == 0.1.2 18:53:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 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 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:53:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:43 INFO - Using env: {'DISPLAY': ':0', 18:53:43 INFO - 'HOME': '/home/cltbld', 18:53:43 INFO - 'LANG': 'en_US.UTF-8', 18:53:43 INFO - 'LANGUAGE': 'en_US:en', 18:53:43 INFO - 'LOGNAME': 'cltbld', 18:53:43 INFO - 'MAIL': '/var/mail/cltbld', 18:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:43 INFO - 'MOZ_NO_REMOTE': '1', 18:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:43 INFO - 'NO_EM_RESTART': '1', 18:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:43 INFO - 'SHELL': '/bin/bash', 18:53:43 INFO - 'SHLVL': '1', 18:53:43 INFO - 'TERM': 'linux', 18:53:43 INFO - 'TMOUT': '86400', 18:53:43 INFO - 'USER': 'cltbld', 18:53:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:43 INFO - '_': '/tools/buildbot/bin/python'} 18:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:53:43 INFO - Cleaning up... 18:53:43 INFO - Return code: 0 18:53:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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', 'jsonschema'] in /builds/slave/test-pgo/build 18:53: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 jsonschema 18:53:43 INFO - Using env: {'DISPLAY': ':0', 18:53:43 INFO - 'HOME': '/home/cltbld', 18:53:43 INFO - 'LANG': 'en_US.UTF-8', 18:53:43 INFO - 'LANGUAGE': 'en_US:en', 18:53:43 INFO - 'LOGNAME': 'cltbld', 18:53:43 INFO - 'MAIL': '/var/mail/cltbld', 18:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:43 INFO - 'MOZ_NO_REMOTE': '1', 18:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:43 INFO - 'NO_EM_RESTART': '1', 18:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:43 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:43 INFO - 'SHELL': '/bin/bash', 18:53:43 INFO - 'SHLVL': '1', 18:53:43 INFO - 'TERM': 'linux', 18:53:43 INFO - 'TMOUT': '86400', 18:53:43 INFO - 'USER': 'cltbld', 18:53:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:43 INFO - '_': '/tools/buildbot/bin/python'} 18:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:43 INFO - Downloading/unpacking jsonschema 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:53:45 INFO - Downloading/unpacking functools32 (from jsonschema) 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:45 INFO - Downloading functools32-3.2.3-2.tar.gz 18:53:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:53:45 INFO - warning: no files found matching '*.txt' 18:53:45 INFO - no previously-included directories found matching 'build' 18:53:45 INFO - no previously-included directories found matching 'dist' 18:53:45 INFO - no previously-included directories found matching '.git*' 18:53:45 INFO - Installing collected packages: jsonschema, functools32 18:53:45 INFO - Running setup.py install for functools32 18:53:45 INFO - warning: no files found matching '*.txt' 18:53:45 INFO - no previously-included directories found matching 'build' 18:53:45 INFO - no previously-included directories found matching 'dist' 18:53:45 INFO - no previously-included directories found matching '.git*' 18:53:45 INFO - Successfully installed jsonschema functools32 18:53:45 INFO - Cleaning up... 18:53:45 INFO - Return code: 0 18:53:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47022c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a686d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:53:45 INFO - Using env: {'DISPLAY': ':0', 18:53:45 INFO - 'HOME': '/home/cltbld', 18:53:45 INFO - 'LANG': 'en_US.UTF-8', 18:53:45 INFO - 'LANGUAGE': 'en_US:en', 18:53:45 INFO - 'LOGNAME': 'cltbld', 18:53:45 INFO - 'MAIL': '/var/mail/cltbld', 18:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:45 INFO - 'MOZ_NO_REMOTE': '1', 18:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:45 INFO - 'NO_EM_RESTART': '1', 18:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:45 INFO - 'SHELL': '/bin/bash', 18:53:45 INFO - 'SHLVL': '1', 18:53:45 INFO - 'TERM': 'linux', 18:53:45 INFO - 'TMOUT': '86400', 18:53:45 INFO - 'USER': 'cltbld', 18:53:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:45 INFO - '_': '/tools/buildbot/bin/python'} 18:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:46 INFO - Downloading/unpacking flake8 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:53:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:53:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:48 INFO - no previously-included directories found matching 'docs/_build' 18:53:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:53:48 INFO - Running setup.py install for pep8 18:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:48 INFO - no previously-included directories found matching 'docs/_build' 18:53:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:53:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Running post-action listener: _resource_record_post_action 18:53:48 INFO - Running post-action listener: _start_resource_monitoring 18:53:48 INFO - Starting resource monitoring. 18:53:48 INFO - ##### 18:53:48 INFO - ##### Running install step. 18:53:48 INFO - ##### 18:53:48 INFO - Running pre-action listener: _resource_record_pre_action 18:53:48 INFO - Running main action method: install 18:53:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:53:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:53:49 INFO - Reading from file tmpfile_stdout 18:53:49 INFO - Detecting whether we're running mozinstall >=1.0... 18:53:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:53:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:53:49 INFO - Reading from file tmpfile_stdout 18:53:49 INFO - Output received: 18:53:49 INFO - Usage: mozinstall [options] installer 18:53:49 INFO - Options: 18:53:49 INFO - -h, --help show this help message and exit 18:53:49 INFO - -d DEST, --destination=DEST 18:53:49 INFO - Directory to install application into. [default: 18:53:49 INFO - "/builds/slave/test-pgo"] 18:53:49 INFO - --app=APP Application being installed. [default: firefox] 18:53:49 INFO - mkdir: /builds/slave/test-pgo/build/application 18:53:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:53:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Output received: 18:54:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:54:05 INFO - Running post-action listener: _resource_record_post_action 18:54:05 INFO - ##### 18:54:05 INFO - ##### Running run-tests step. 18:54:05 INFO - ##### 18:54:05 INFO - Running pre-action listener: _resource_record_pre_action 18:54:05 INFO - Running main action method: run_tests 18:54:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:54:05 INFO - Python 2.7.3 18:54:05 INFO - Return code: 0 18:54:05 INFO - grabbing minidump binary from tooltool 18:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:05 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 0x1af7920>, '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 0x1af8820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af8cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:54:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:54:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:54:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:05 INFO - Return code: 0 18:54:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:54:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:54:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:54:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:54:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:54:06 INFO - Return code: 0 18:54:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 18:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 18:54:06 INFO - Using env: {'DISPLAY': ':0', 18:54:06 INFO - 'HOME': '/home/cltbld', 18:54:06 INFO - 'LANG': 'en_US.UTF-8', 18:54:06 INFO - 'LANGUAGE': 'en_US:en', 18:54:06 INFO - 'LOGNAME': 'cltbld', 18:54:06 INFO - 'MAIL': '/var/mail/cltbld', 18:54:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:06 INFO - 'MOZ_NO_REMOTE': '1', 18:54:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:06 INFO - 'NO_EM_RESTART': '1', 18:54:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:54:06 INFO - 'SHELL': '/bin/bash', 18:54:06 INFO - 'SHLVL': '1', 18:54:06 INFO - 'TERM': 'linux', 18:54:06 INFO - 'TMOUT': '86400', 18:54:06 INFO - 'USER': 'cltbld', 18:54:06 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928', 18:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:06 INFO - '_': '/tools/buildbot/bin/python'} 18:54:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:54:06 INFO - mozversion application_buildid: 20160309163013 18:54:06 INFO - mozversion application_changeset: 37b591f543635f193c7329451ad54f1b8c647414 18:54:06 INFO - mozversion application_display_name: Nightly 18:54:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:06 INFO - mozversion application_name: Firefox 18:54:06 INFO - mozversion application_remotingname: firefox 18:54:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:06 INFO - mozversion application_vendor: Mozilla 18:54:06 INFO - mozversion application_version: 48.0a1 18:54:06 INFO - mozversion platform_buildid: 20160309163013 18:54:06 INFO - mozversion platform_changeset: 37b591f543635f193c7329451ad54f1b8c647414 18:54:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:06 INFO - mozversion platform_version: 48.0a1 18:54:06 INFO - using testdate: 1457578446 18:54:06 INFO - actual date: 1457578446 18:54:06 INFO - starting webserver on 'localhost:47027' 18:54:06 INFO - SUITE-START | Running 2 tests 18:54:06 INFO - TEST-START | dromaeo_css 18:54:06 INFO - operating with platform_type : linux_ 18:54:06 INFO - Initialising browser for dromaeo_css test... 18:54:06 INFO - TEST-INFO | started process 1221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHUcday/profile http://localhost:47027/getInfo.html) 18:54:10 INFO - PROCESS | 1221 | __metrics Screen width/height:1600/1200 18:54:10 INFO - PROCESS | 1221 | colorDepth:24 18:54:10 INFO - PROCESS | 1221 | Browser inner width/height: 1024/697 18:54:10 INFO - PROCESS | 1221 | __metrics 18:54:11 ERROR - PROCESS | 1221 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:54:11 INFO - PROCESS | 1221 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:54:12 INFO - TEST-INFO | 1221: exit 0 18:54:12 INFO - Browser initialized. 18:54:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:12 INFO - TEST-INFO | started process 1325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHUcday/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:23 INFO - PROCESS | 1325 | RSS: Main: 154517504 18:54:23 INFO - PROCESS | 1325 | 18:55:15 INFO - PROCESS | 1325 | 1457578515337 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:57:23 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47027/tests/dromaeo/cssquery-ext.html) 18:57:24 INFO - PROCESS | 1325 | RSS: Main: 260247552 18:57:24 INFO - PROCESS | 1325 | 19:00:26 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-ext.html (next: http://localhost:47027/tests/dromaeo/cssquery-jquery.html) 19:00:27 INFO - PROCESS | 1325 | RSS: Main: 236441600 19:00:27 INFO - PROCESS | 1325 | 19:03:29 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47027/tests/dromaeo/cssquery-mootools.html) 19:03:30 INFO - PROCESS | 1325 | RSS: Main: 241532928 19:03:30 INFO - PROCESS | 1325 | 19:06:31 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47027/tests/dromaeo/cssquery-prototype.html) 19:06:32 INFO - PROCESS | 1325 | RSS: Main: 222044160 19:06:32 INFO - PROCESS | 1325 | 19:09:35 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47027/tests/dromaeo/cssquery-yui.html) 19:09:35 INFO - PROCESS | 1325 | RSS: Main: 219316224 19:09:35 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | Cycle 1(1): loaded http://localhost:47027/tests/dromaeo/cssquery-yui.html (next: http://localhost:47027/tests/dromaeo/cssquery-dojo.html) 19:12:38 INFO - PROCESS | 1325 | RSS: Main: 292802560 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | __start_tp_report 19:12:38 INFO - PROCESS | 1325 | _x_x_mozilla_page_load 19:12:38 INFO - PROCESS | 1325 | _x_x_mozilla_page_load_details 19:12:38 INFO - PROCESS | 1325 | |i|pagename|runs| 19:12:38 INFO - PROCESS | 1325 | |0;dojo.html;3132.6084239470065;3158.636756772969;3197.5363572282035;3197.8081315121094;3228.790128641639;5071;5079.339685840836;5134.229865520174;5207;5213.061648903196;5115.079285728568;5126.026055049538;5127.641065125443;5154;5158.845234642958;4639.582437580617;4681.836135735241;4740.668153229275;4785.856424307276;4800.927986080212;4656.092062047902;4702.929456058162;4769.093872164278;4780.617550595962;4876.097921884445;4698.906021879578;4708.270218116198;4715.457722361938;4744.810207591692;4755.904881902343;4687.95312046882;4707.693999889996;4715.858524244278;4748.905021899577;4764.452088009889;4608;4664.440267167927;4719.834805781781;4744.217204161309;4751.263554149113;5029.094762942669;5046.419661738911;5048.545630893237;5060.139776238048;5087.364079490064;5520.171974203861;5523.088690366125;5523.25436066134;5527.889442211133;5569.832905012856;5500.6424582402415;5525.778968841241;5572.888542229173;5594.9720251398885;5626.803061892855;5203.947960520422;5208.713520756357;5210.192420174917;5212.061828870802;5230.895382092375;5629.971850140723;5660.2075709400715;5686.886262274731;5689.089745640677;5693.430656934273;5336.679799211982;5457.290552228185;5464.9453505465235;5528.419515950848;5552.7778888843995;5542.168674698827;5550.361708403505;5553.916691249635;5556.416576259516;5561;5490.450954904558;5503.559715222773;5505.009098362333;5510.366307874566;5555.194496798023;5384.380796208407;5472.91790623133;5517.586181036439;5559.416261292587;5566.832995010156;4209.284421648327;4217.557156498585;4218.430511880918;4223.345381465878;4255.276602977439;3705.5738590062488;3823.3500304948225;3823.6941044716355;3851.017990412427;3872.5546562145714;5210;5214.504622060898;5214.84355469329;5251.947480525222;5259.973700131475;5469.56243500519;5490.450954904478;5498.670079795145;5500.28496295487;5508.44915508446;5042.193249080129;5075.949240507622;5154.8969020620125;5160.690358578498;5210.505002024802;4586.4725556561425;4589.954100459019;4609.193391156534;4627.95372046282;4661.021185551004;5738.569607279471;5756.597038207286;5758.049921762946;5766.654000759884;5825.446582574648;5393.595480339069;5497.780088796563;5520.751566179451;5532.253145825262;5607.831765047055;5765.798197063083;5839.182514448065;5854.882902341844;5862.296524417097;5896.14505896634;5506.366767821592;5510.779568817203;5521.2270282159725;5521.558275338044;5531.059719847555;5427.48438898304;5554.166874968787;5573.331200255995;5619.072852979376;5661.858453538694;5317.282166907418;5353.304070470814;5355.27703760003;5385.13837785968;5406.02691515531;5338.759755811076;5364.544013758718;5368.973155134199;5409.756560954688;5423.538999184956;5173.534381905646;5240.7641656126325;5272.578193744414;5338.733063346739;5369.382521010134;5408.8377348679605;5447.182922561489;5448.5368743655645;5449.04641687711;5451.20957461158;5194.97402512985;5343.599230057684;5348.705821179872;5349;5353.491418315254 19:12:38 INFO - PROCESS | 1325 | |1;ext.html;507.7283653245514;519.2082074835874;529.8595872093896;530.9389420216676;547.1027514875603;29270.41459170815;30113.24716882079;37623.43564846526;38096;38115.428268575924;43989.78005109978;44610.33084503727;44646.107077858425;44655.77672111643;44743.77628111863;7594.240575942389;8698.434601750881;8912.197902188802;8914.73255802327;8919;7617.504862183968;10418.739531511736;10685.519151638156;10688;10700.518476668569;10563.841542376871;10733.516991735352;10739.355638661666;10741.677749667522;10744.247902646817;10517.579296828118;10524.842127368096;10595.152387808996;10647.627333043345;10648.787024259549;10304.227182961307;10418.583256669725;10453.006964338376;10482.633107841266;10502.9474852626;41047.7947610263;41384.37923431151;41409.58590414088;41477.170456591004;41503.1699366011;3700.777953322809;3707.6292370762976;3984.880453586397;4012.4382586437923;4171.895702607429;31291;31721;31850;31987.360252794813;32677.836610816794;4037.9394309085387;4053.2298863215897;4153.293940030172;4160.313548264533;4186.644135248507;280205;281438;281500;282182;285064;43035.56964430378;43852.3422148668;63087.6845615769;63496;63909.36090639127;41500.79249603733;41742.330306788;41841.58158418438;41844.372334415006;41885.371719424234;15101.622459438382;15268.847311526964;15279.159646219343;15296.082235065931;15299.464518742014;11050.447477626087;12528.373581320897;12664.74670506603;12681.429335679917;12706.682332941566;14244.430222790972;14300.928495357457;14310.212938288287;14331.641708957151;14360.210188439736;5665.206871038058;5694.60137790359;5754.4533269339345;5839.649621022667;5851.210086638334;926.7312479381039;957.9233661307079;988.2736188901152;1015.968791676449;1021.2595867995792;29298.267543311587;29322;29408.558871616944;29850.10449686513;29865;988.2094324540338;999.8700168977987;1014.7513859104419;1032.1897310611134;1064.984025239622;14785.852141478663;14896.70206595862;15219.847801521842;15326.540203793904;15565;324163;326153;326739;328736;330450;54749.72625136849;55134;55269;55278;55333;1104.5195340027115;1312.2061153002487;1330.5742162507904;1335.2122247873801;1360.5238166641595;26021;27297.454050918474;27603.30991725223;28245.858770706014;31509.527357089202;48746;48912.266316006004;49159.26261106015;49206.50793492019;49259.26111108408;286921;288658;289429;289639;290106;36908.26183476369;44622;45002.63254621836;45715.54284457113;47516.060492438446;43884.561154388044;43890.56109438865;44283.77858110818;44337.556624434634;44469.33296000498;36719.08202294964;37074.814625926694;37317.25365492729;37503.81248093742;37826;36586.63413365832;36978.26043479169;37251.25497490089;37377.62622373742;37433.438498422;36350.63649363472;36889.26221475609;37232.81383593065;37568.62431375761;37605.05987350338;31845.681543184273;32873.50689739608;33103.83448082744;33478.66521334756;33506.83246583751;25229.369265767768;25639.487210256062;25682.229533114038;25945.22164335073;26174.738252617994 19:12:38 INFO - PROCESS | 1325 | |2;jquery.html;355.26637493575765;362.11643589641267;364.69730123997084;371.3983346977896;373.70290618957927;16843.157842107907;17325.22036508357;17341.999999999985;17659.91170044148;17686.911565442155;16593.66812663746;17542.210600522976;17744.201510932005;17747.91126044371;17760.378386756434;5299.60252981026;5379.35447746271;5501.229827824108;5507.063799154133;5517.475839795233;4032.677385809143;5367.275417818603;5844.1818145459665;6144.5698801083945;6173.166622505972;6049.395060493959;6082;6115.938840611581;6117.785877494289;6124.601900876451;5887.735051922674;5998.910016349758;6038.818835434944;6047.183630209909;6089.939100608982;3675.9816200918826;5110.182370820688;5271.710055946922;5330.307060082203;5339.5728341732565;20257.594848102955;21105.47236319089;21167.788322116736;21370;21385.786142138535;2300.482391461908;2366.503034362786;2467.444824914398;2626.960595591068;2669.172556507489;12838.614841554769;12984;13295.734085318336;13671.794923076062;13864.376103075387;1883.3878989328387;1892.3093071029114;1893.0723945266857;1912.7513423255027;1958.7159861820098;59906.101408478906;60586;62836.37163628351;63193.68403158001;63512;9937.105660490446;10013.849792253122;10204.183665306758;10213.182945364502;10304.639337623148;13554.525591604246;13583.91328693702;13602.795958060637;13615.25116118623;13697.178169309873;7817.295274759345;7917.802054948673;8033.879491807627;8052.315553178046;8127.75616731499;7907.723229686933;7955.602219889098;8086.150954149847;8090.1909809018625;8092.352611791042;5970.313413957364;6139.96930015356;6195.19462469876;6201.596896201732;6218.378162183745;1744.7034004219313;1805.7291406288898;1838.3841413126486;1839.3654189304668;1847.325726109987;957.1481381570408;1011.9949400252951;1051.436764442324;1057.8677665291839;1083.6315652678127;16814;17212.655746885244;17431.128443578025;17616.735748963776;17680.115994200238;919.6965001549472;929.4655573045526;929.5398777604994;992.5136683025265;1016.2682868334787;8118.512889226666;10144.340617859963;10276.177905767521;10333.276670632984;10376.896231037745;406773;411523;434948;435116;436825.0539956796;67662.3233767656;67816.321836782;68865.65567172233;68904.3109568908;70071.29928700648;1020.4081632653043;1024.1448390593937;1024.3239461955075;1034.539629864718;1037.7896171478133;15360.923195383952;15362.923185384001;15442.922785386001;15569.844301557292;15595;32133.517997229592;32793.50809737904;33678.32643347168;33967.32065358728;33975.66024339725;42334;42474.575254247065;43148.352774707775;43321.78339108284;44433;7398.3341499265325;7541.5475071495885;7572.621368931421;7607.429442791702;7646.197149299243;11877.287362758263;12123.090768192244;12440.937795311327;12553.748925021631;12758.61724148277;10291.794164116825;10463.58145674195;10497.9475102624;10826.242163048511;10970.890291096986;10579.259451838298;10646.946765266124;10661.200409969128;10798.892011080103;10981.835272471078;10979.67910164443;11026.779464410827;11051.557937682403;11099.686545410766;11407.087433005174;7639.159692433939;7778.805529861799;7784.766457006299;7793.9220607793195;8043.919560804551;9561.084707855767;10928.672139835817;10993.450327483753;11161.330320180816;11248.550057997589 19:12:38 INFO - PROCESS | 1325 | |3;mootools.html;1380.4340220509594;1474.3586539855164;1478.5416520878528;1660.369059757292;1841.8228555741348;7124.964375178123;7787.065552133745;7902.051753789539;7931.167227441122;7946.562939038351;7890.210978902107;8066.11272759996;8074.4347895647325;8082.151374105722;8086.757397278091;2034.9389518314474;2310.445493081665;2347.835651504395;2368.976310236893;2378.7621237876247;2343.6367363058666;2356.3402247370764;2359.4337359033793;2360.0913648245464;2363.1138323128826;2298.689676893623;2371.620540713486;2375.8336916415856;2376.3583832365252;2378.0368950575044;2309.815214782813;2339.1462116327502;2363.7281712602926;2371.8932648030795;2372.110458578033;2288.553732022256;2296.598095333327;2315.2938353802083;2381.6546600742795;2383.880805959695;8136.267735903738;8183.95908020456;8194.139615340422;8200.958995205045;8212.46618969771;4754.857354279377;4826.638002149853;4860.562549370574;4864.635152363551;4868.488808675073;3167.3506931079073;3266.9836650816833;3288.70401663849;3326.251593391492;3331.983340083284;1036.3781730961439;1079.7894410589938;1085.478970094359;1103.1230172013268;1120.0367683792015;11326.773464530663;11349.829752553718;11360.318380897173;11414.942925285404;11442.14183936208;4446.1330040642415;4459;4540.636749060067;4546.931796023062;4555.157295900269;9731.318807683394;9732.854007189757;9742.659006934724;9747.415155090717;9768.316217864824;4453.465584129925;4971.37857767779;4996.975015124901;4999.175136102575;5012.598992080625;4329.09089091288;4409.845655402046;4434.357018232338;4440.86677399672;4451.0430257494145;3829.3107240696386;3889.8249578769023;3897.2984862724416;3927.6857851371824;3946.8223929923224;1244.4710997825887;1277.0485987939044;1278.9040821938393;1289.9677508062373;1290.8967282617368;1322.1472150462898;1339.9196048237136;1340.1958824705098;1354.9729005419836;1373.3545233740126;7445.739399121005;7560.735374261874;7634.427417943676;7653.732119375795;7657.770266892002;475.83821500689237;486.56452475034644;492.8767808047988;493.4744497110566;499.07670809003054;5916.319623243296;5927.4665280125;5937.435943585352;5972.13404056418;5992.610480318765;9273.072692730673;9644.95177524108;9662.75843103928;9755.512224388753;9782.657606983721;9493.715188544355;9528.809423811485;9611.759706007406;9630.518474076269;9643.807123857483;7287.744928927462;7569.810754731066;7631.122420921665;7653.808654783675;7654.846903061907;7249.456290778107;7254.6735396908325;7255.963720181366;7305.488615797056;7308.123025237006;8585.613647385757;8612.923384576929;8723.127687231226;8726.956365218133;8889.19997200255;8776.078511756174;8782.209601135928;9021.188093071654;9035.819283614159;9044.050374710823;6395.104685343963;6572.474202063919;6867.793966181022;7145.678444469907;7207.351338379571;7665.3101220890385;7711.305982461381;7728.420368472274;7738.729144479917;7757.806054848674;6925.826854328682;7150.7497237596435;7168.784936451915;7274.236205198378;7291.708331666674;6865.27914568963;7046.647667616496;7049.577025378494;7167.498275120692;7167.856642867009;7274.16347120088;7274.563526188445;7332.046833911558;7332.706691732271;7358.0434543509;6613.272540020497;6617.371349721769;6658.900116498353;6660.0675905374255;6661.3338666132995;6441.098246245436;6579.769708060195;6613.371729685672;6658.900116498159;6707.027481015323 19:12:38 INFO - PROCESS | 1325 | |4;prototype.html;311.1086736499928;313.8023045481347;314.10949956872264;318.83579956322484;319.2163239247647;5779.21980532628;5884.882302353955;5904.202932604097;5911.201987731655;5929.970350148249;5773.653580785156;5781.595288329819;5782.82651520454;5801.100829371444;5811.27359080115;4308.547602501739;4360.760158191299;4448.666350023745;4448.844290449835;4472.821087156518;4461.4869290031575;4475.619572336355;4481.4846292676275;4499.820007199708;4505.234110201257;4456.866294011184;4457.175422546839;4463.062756821071;4464.843730469434;4476.753778542179;4265.78671066447;4361.5856493633055;4442.3336499525;4458.509563947963;4472.575105364985;3930.213957208541;3930.744501607386;3942.9156981830224;3956.604339566049;3957.0503079261057;5513.807016754435;5531.3915469298345;5540.058190107691;5546.833594992157;5548.833534993957;5161.045206636784;5191.688498690053;5199;5199.402068762065;5202.687838729688;6142.723577439026;6148.446639802394;6149.631022138686;6152.907706384408;6159.784407545759;3989.5611482736876;4059.3707975263883;4062.7765472898977;4353.521112677603;4366.781660916973;6304.716287767062;6400.4559612432995;6409.294977552466;6417.93582064178;6435.356464353574;4315.554289313115;4315.978420107942;4317.805698743564;4318.848840290575;4321.092570560218;4364.039911219526;4364.825406983685;4365.039691267916;4367.606915377632;4368.716033457815;5085.720285384339;5098.056859481007;5100.285959965608;5102.668326558762;5103.821366252163;6043.123747056652;6186.907196392058;6187.504999600022;6187.690615469209;6190.226221722285;1494.4619936822735;1507.3819733909045;1508.3891024135244;1510.101489613678;1513.6821267533942;952.6951375559754;975.531744762518;983.0562659846485;991.3258983891023;1056.5087234436023;5838.12428135783;5845.357010728816;5847.649141051551;5853.122031695195;5861.150133230658;6256.43692067707;6278.372162783685;6292.653904035322;6296.024116261987;6298;5875.089361149029;5878.206442130343;5883.264591926009;5884.352721200665;5886.735096920649;3342.4317865962357;3384.915377115592;3386.813725245086;3387.4241378965144;3394.2702319001532;6549.9345006550275;6643.368879956396;6658.667066646648;6760.7295708172105;6798.966005169942;6533.705983230766;6569.244536878225;6573;6574.572652777554;6583.440407565315;6699.698513566804;6751.628660423626;6757.222919364336;6766.25571187169;6768.458523318122;6332.905006425;6346.777862774781;6365;6367.42693157618;6370.74517019314;6201.472874805511;6344.651044192614;6350.396712312323;6361.14124593174;6363.268224154282;6715.7985260442265;6729.394354508117;6741.52809303344;6744.22441419243;6749;4303.870883873489;4304.311310190355;4313.331433627793;4313.870583882489;4318.265894797954;6357.936420635734;6362.650054246876;6368.5860419072615;6377.8724425512155;6385.201849768779;6192.164057852132;6207.286162091417;6207.503399728102;6207.906881396873;6213;6055.091736239599;6154.1999540059505;6192.195014648067;6199.504039676905;6210.596311239936;6064.514838812973;6084.482818960261;6099.573029887865;6107;6128.754849806136;6232.220972378453;6233.937660623517;6236.688165591793;6242.188515493139;6242.375762423903;5848.152017957457;5923.585349025527;6072.969635151796;6083.452489275986;6091.969540152271 19:12:38 INFO - PROCESS | 1325 | |5;yui.html;735.3418690272207;742.9108506979163;784.1335324466464;795.5266616363266;808.4098608016144;13976.930115349422;14051.086679365833;14248.073875198117;14277.928610356947;14426.495072672433;13188.670283242924;13548.525801596947;13548.796768048462;13577.59267221985;13604.727905441885;841.0538144587339;846.4286606540592;853.2363534636496;853.2832420766555;853.87191921212;680.2890978927009;831.8502669519484;852.0159216105408;853.4452605806214;853.8728877881199;883.9292856571491;889.937704360695;890.2699786175339;890.3900827932854;890.5013192612125;721.9169795473483;873.8995015573227;879.4767113567417;881.0968757024037;884.0496466298722;645.4803882874285;653.8921078022121;654.0973456629868;654.5483616304734;654.6170490263202;13870.58388248344;13914.860851391457;13975.301234938212;13981.930090349584;13993.30033498321;12558.560450384193;12609.936950315281;13004.414801333962;13150.605481835464;13191.208527488285;10732.248742588023;10744.516496757664;10808.675739727822;10932.672019839418;10995.120390368751;3611.3319035978166;3672.1186915140443;3694.2057457646465;3695.4826324314618;3797.39241721326;50747.746261268825;51428;51474;51963.48036519624;52041.47958520442;10568.577256909792;10780.353178809297;10844.728881778019;10986.285891417192;11081.5567377304;19424.12591433389;19607.31374401889;19862.70205946912;19969.400917972194;19977.800221997593;7946.165652606509;8049.195080491904;8080.27277545012;8093.676252949934;8130.674773009132;4282.89292767677;4422.204003279377;4436.245838207513;4540.659450541222;4643.44278686553;3009.6990300970165;3051.588035615208;3052.648945371266;3058.632964044329;3060.6786287439945;608.2670382189451;617.8856911471393;620.9937900621027;621.5276389943675;626.8025571944822;598.2701104652317;614.0985132873086;615.7475435071599;640.1294239833823;653.3662347522895;8316.719731008488;8585.227329540247;8733.737987860375;8854.690085846965;8947.597358118901;482.31752070820096;554.9500544950973;601.5305390524877;615.0221148374106;623.5884316351187;3737.3272810893754;3845;3960.7029472789654;3969.4839670843185;4014.2769671898823;61435;62124;62795.37204627987;62953;63397;54414;55378.16932746012;55705;55822.720886395306;55856.72071639616;48739;50221.74889125531;50626;50635.49364506381;51356.74321628368;8319.209675080858;8463;8578.313734901318;8585.527795971282;8598.78503037429;36516.45225321569;36575;36846.44730329101;38414.615853842224;38571.22857542778;42156.57843421526;47164.292535611305;47199.05601888012;47867.76066119786;48582.75708621434;10949.233553651487;11050.723731906766;11090.944545277222;11215.214934954802;11253.606123785628;11957.461914213707;12030.879691202976;12289.631311060682;12357.38213089324;12754.61736147917;11248;11994.400279986141;11995;12265.816012759995;12271.57049503263;11147.163962702993;11357.716057098309;11431.657050288504;11540.884591153981;11701;11232.3260604364;11575.652730418102;11668.299902005907;11941.402929853646;12004.159708820298;9492.193163581172;9681.70954871355;9862.55618497155;9923;10115.797684046425;8835.690750823947;8914.86627700572;9285.48929808867;9576;9743.853842192515 19:12:38 INFO - PROCESS | 1325 | __end_tp_report 19:12:38 INFO - PROCESS | 1325 | __start_cc_report 19:12:38 INFO - PROCESS | 1325 | _x_x_mozilla_cycle_collect,811 19:12:38 INFO - PROCESS | 1325 | __end_cc_report 19:12:38 INFO - PROCESS | 1325 | __startTimestamp1457579558537__endTimestamp 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | ------- Summary: start ------- 19:12:38 INFO - PROCESS | 1325 | Number of tests: 6 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#0] dojo.html Cycles:165 Average:5141.31 Median:5338.76 stddev:566.67 (10.6%) stddev-sans-first:546.06 19:12:38 INFO - PROCESS | 1325 | Values: 3132.6 3158.6 3197.5 3197.8 3228.8 5071.0 5079.3 5134.2 5207.0 5213.1 5115.1 5126.0 5127.6 5154.0 5158.8 4639.6 4681.8 4740.7 4785.9 4800.9 4656.1 4702.9 4769.1 4780.6 4876.1 4698.9 4708.3 4715.5 4744.8 4755.9 4688.0 4707.7 4715.9 4748.9 4764.5 4608.0 4664.4 4719.8 4744.2 4751.3 5029.1 5046.4 5048.5 5060.1 5087.4 5520.2 5523.1 5523.3 5527.9 5569.8 5500.6 5525.8 5572.9 5595.0 5626.8 5203.9 5208.7 5210.2 5212.1 5230.9 5630.0 5660.2 5686.9 5689.1 5693.4 5336.7 5457.3 5464.9 5528.4 5552.8 5542.2 5550.4 5553.9 5556.4 5561.0 5490.5 5503.6 5505.0 5510.4 5555.2 5384.4 5472.9 5517.6 5559.4 5566.8 4209.3 4217.6 4218.4 4223.3 4255.3 3705.6 3823.4 3823.7 3851.0 3872.6 5210.0 5214.5 5214.8 5251.9 5260.0 5469.6 5490.5 5498.7 5500.3 5508.4 5042.2 5075.9 5154.9 5160.7 5210.5 4586.5 4590.0 4609.2 4628.0 4661.0 5738.6 5756.6 5758.0 5766.7 5825.4 5393.6 5497.8 5520.8 5532.3 5607.8 5765.8 5839.2 5854.9 5862.3 5896.1 5506.4 5510.8 5521.2 5521.6 5531.1 5427.5 5554.2 5573.3 5619.1 5661.9 5317.3 5353.3 5355.3 5385.1 5406.0 5338.8 5364.5 5369.0 5409.8 5423.5 5173.5 5240.8 5272.6 5338.7 5369.4 5408.8 5447.2 5448.5 5449.0 5451.2 5195.0 5343.6 5348.7 5349.0 5353.5 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#1] ext.html Cycles:180 Average:47034.07 Median:34928.73 stddev:78334.45 (224.3%) stddev-sans-first:78476.31 19:12:38 INFO - PROCESS | 1325 | Values: 507.7 519.2 529.9 530.9 547.1 29270.4 30113.2 37623.4 38096.0 38115.4 43989.8 44610.3 44646.1 44655.8 44743.8 7594.2 8698.4 8912.2 8914.7 8919.0 7617.5 10418.7 10685.5 10688.0 10700.5 10563.8 10733.5 10739.4 10741.7 10744.2 10517.6 10524.8 10595.2 10647.6 10648.8 10304.2 10418.6 10453.0 10482.6 10502.9 41047.8 41384.4 41409.6 41477.2 41503.2 3700.8 3707.6 3984.9 4012.4 4171.9 31291.0 31721.0 31850.0 31987.4 32677.8 4037.9 4053.2 4153.3 4160.3 4186.6 280205.0 281438.0 281500.0 282182.0 285064.0 43035.6 43852.3 63087.7 63496.0 63909.4 41500.8 41742.3 41841.6 41844.4 41885.4 15101.6 15268.8 15279.2 15296.1 15299.5 11050.4 12528.4 12664.7 12681.4 12706.7 14244.4 14300.9 14310.2 14331.6 14360.2 5665.2 5694.6 5754.5 5839.6 5851.2 926.7 957.9 988.3 1016.0 1021.3 29298.3 29322.0 29408.6 29850.1 29865.0 988.2 999.9 1014.8 1032.2 1065.0 14785.9 14896.7 15219.8 15326.5 15565.0 324163.0 326153.0 326739.0 328736.0 330450.0 54749.7 55134.0 55269.0 55278.0 55333.0 1104.5 1312.2 1330.6 1335.2 1360.5 26021.0 27297.5 27603.3 28245.9 31509.5 48746.0 48912.3 49159.3 49206.5 49259.3 286921.0 288658.0 289429.0 289639.0 290106.0 36908.3 44622.0 45002.6 45715.5 47516.1 43884.6 43890.6 44283.8 44337.6 44469.3 36719.1 37074.8 37317.3 37503.8 37826.0 36586.6 36978.3 37251.3 37377.6 37433.4 36350.6 36889.3 37232.8 37568.6 37605.1 31845.7 32873.5 33103.8 33478.7 33506.8 25229.4 25639.5 25682.2 25945.2 26174.7 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#2] jquery.html Cycles:180 Average:24958.90 Median:2648.07 stddev:69549.77 (2626.4%) stddev-sans-first:69720.34 19:12:38 INFO - PROCESS | 1325 | Values: 355.3 362.1 364.7 371.4 373.7 16843.2 17325.2 17342.0 17659.9 17686.9 16593.7 17542.2 17744.2 17747.9 17760.4 5299.6 5379.4 5501.2 5507.1 5517.5 4032.7 5367.3 5844.2 6144.6 6173.2 6049.4 6082.0 6115.9 6117.8 6124.6 5887.7 5998.9 6038.8 6047.2 6089.9 3676.0 5110.2 5271.7 5330.3 5339.6 20257.6 21105.5 21167.8 21370.0 21385.8 2300.5 2366.5 2467.4 2627.0 2669.2 12838.6 12984.0 13295.7 13671.8 13864.4 1883.4 1892.3 1893.1 1912.8 1958.7 59906.1 60586.0 62836.4 63193.7 63512.0 9937.1 10013.8 10204.2 10213.2 10304.6 13554.5 13583.9 13602.8 13615.3 13697.2 7817.3 7917.8 8033.9 8052.3 8127.8 7907.7 7955.6 8086.2 8090.2 8092.4 5970.3 6140.0 6195.2 6201.6 6218.4 1744.7 1805.7 1838.4 1839.4 1847.3 957.1 1012.0 1051.4 1057.9 1083.6 16814.0 17212.7 17431.1 17616.7 17680.1 919.7 929.5 929.5 992.5 1016.3 8118.5 10144.3 10276.2 10333.3 10376.9 406773.0 411523.0 434948.0 435116.0 436825.1 67662.3 67816.3 68865.7 68904.3 70071.3 1020.4 1024.1 1024.3 1034.5 1037.8 15360.9 15362.9 15442.9 15569.8 15595.0 32133.5 32793.5 33678.3 33967.3 33975.7 42334.0 42474.6 43148.4 43321.8 44433.0 7398.3 7541.5 7572.6 7607.4 7646.2 11877.3 12123.1 12440.9 12553.7 12758.6 10291.8 10463.6 10497.9 10826.2 10970.9 10579.3 10646.9 10661.2 10798.9 10981.8 10979.7 11026.8 11051.6 11099.7 11407.1 7639.2 7778.8 7784.8 7793.9 8043.9 9561.1 10928.7 10993.5 11161.3 11248.6 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#3] mootools.html Cycles:180 Average:5636.51 Median:6418.10 stddev:2952.55 (46.0%) stddev-sans-first:2943.50 19:12:38 INFO - PROCESS | 1325 | Values: 1380.4 1474.4 1478.5 1660.4 1841.8 7125.0 7787.1 7902.1 7931.2 7946.6 7890.2 8066.1 8074.4 8082.2 8086.8 2034.9 2310.4 2347.8 2369.0 2378.8 2343.6 2356.3 2359.4 2360.1 2363.1 2298.7 2371.6 2375.8 2376.4 2378.0 2309.8 2339.1 2363.7 2371.9 2372.1 2288.6 2296.6 2315.3 2381.7 2383.9 8136.3 8184.0 8194.1 8201.0 8212.5 4754.9 4826.6 4860.6 4864.6 4868.5 3167.4 3267.0 3288.7 3326.3 3332.0 1036.4 1079.8 1085.5 1103.1 1120.0 11326.8 11349.8 11360.3 11414.9 11442.1 4446.1 4459.0 4540.6 4546.9 4555.2 9731.3 9732.9 9742.7 9747.4 9768.3 4453.5 4971.4 4997.0 4999.2 5012.6 4329.1 4409.8 4434.4 4440.9 4451.0 3829.3 3889.8 3897.3 3927.7 3946.8 1244.5 1277.0 1278.9 1290.0 1290.9 1322.1 1339.9 1340.2 1355.0 1373.4 7445.7 7560.7 7634.4 7653.7 7657.8 475.8 486.6 492.9 493.5 499.1 5916.3 5927.5 5937.4 5972.1 5992.6 9273.1 9645.0 9662.8 9755.5 9782.7 9493.7 9528.8 9611.8 9630.5 9643.8 7287.7 7569.8 7631.1 7653.8 7654.8 7249.5 7254.7 7256.0 7305.5 7308.1 8585.6 8612.9 8723.1 8727.0 8889.2 8776.1 8782.2 9021.2 9035.8 9044.1 6395.1 6572.5 6867.8 7145.7 7207.4 7665.3 7711.3 7728.4 7738.7 7757.8 6925.8 7150.7 7168.8 7274.2 7291.7 6865.3 7046.6 7049.6 7167.5 7167.9 7274.2 7274.6 7332.0 7332.7 7358.0 6613.3 6617.4 6658.9 6660.1 6661.3 6441.1 6579.8 6613.4 6658.9 6707.0 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#4] prototype.html Cycles:180 Average:5160.02 Median:5883.81 stddev:1579.17 (26.8%) stddev-sans-first:1541.09 19:12:38 INFO - PROCESS | 1325 | Values: 311.1 313.8 314.1 318.8 319.2 5779.2 5884.9 5904.2 5911.2 5930.0 5773.7 5781.6 5782.8 5801.1 5811.3 4308.5 4360.8 4448.7 4448.8 4472.8 4461.5 4475.6 4481.5 4499.8 4505.2 4456.9 4457.2 4463.1 4464.8 4476.8 4265.8 4361.6 4442.3 4458.5 4472.6 3930.2 3930.7 3942.9 3956.6 3957.1 5513.8 5531.4 5540.1 5546.8 5548.8 5161.0 5191.7 5199.0 5199.4 5202.7 6142.7 6148.4 6149.6 6152.9 6159.8 3989.6 4059.4 4062.8 4353.5 4366.8 6304.7 6400.5 6409.3 6417.9 6435.4 4315.6 4316.0 4317.8 4318.8 4321.1 4364.0 4364.8 4365.0 4367.6 4368.7 5085.7 5098.1 5100.3 5102.7 5103.8 6043.1 6186.9 6187.5 6187.7 6190.2 1494.5 1507.4 1508.4 1510.1 1513.7 952.7 975.5 983.1 991.3 1056.5 5838.1 5845.4 5847.6 5853.1 5861.2 6256.4 6278.4 6292.7 6296.0 6298.0 5875.1 5878.2 5883.3 5884.4 5886.7 3342.4 3384.9 3386.8 3387.4 3394.3 6549.9 6643.4 6658.7 6760.7 6799.0 6533.7 6569.2 6573.0 6574.6 6583.4 6699.7 6751.6 6757.2 6766.3 6768.5 6332.9 6346.8 6365.0 6367.4 6370.7 6201.5 6344.7 6350.4 6361.1 6363.3 6715.8 6729.4 6741.5 6744.2 6749.0 4303.9 4304.3 4313.3 4313.9 4318.3 6357.9 6362.7 6368.6 6377.9 6385.2 6192.2 6207.3 6207.5 6207.9 6213.0 6055.1 6154.2 6192.2 6199.5 6210.6 6064.5 6084.5 6099.6 6107.0 6128.8 6232.2 6233.9 6236.7 6242.2 6242.4 5848.2 5923.6 6073.0 6083.5 6092.0 19:12:38 INFO - PROCESS | 1325 | 19:12:38 INFO - PROCESS | 1325 | [#5] yui.html Cycles:180 Average:14565.82 Median:24532.54 stddev:17227.01 (70.2%) stddev-sans-first:17244.02 19:12:38 INFO - PROCESS | 1325 | Values: 735.3 742.9 784.1 795.5 808.4 13976.9 14051.1 14248.1 14277.9 14426.5 13188.7 13548.5 13548.8 13577.6 13604.7 841.1 846.4 853.2 853.3 853.9 680.3 831.9 852.0 853.4 853.9 883.9 889.9 890.3 890.4 890.5 721.9 873.9 879.5 881.1 884.0 645.5 653.9 654.1 654.5 654.6 13870.6 13914.9 13975.3 13981.9 13993.3 12558.6 12609.9 13004.4 13150.6 13191.2 10732.2 10744.5 10808.7 10932.7 10995.1 3611.3 3672.1 3694.2 3695.5 3797.4 50747.7 51428.0 51474.0 51963.5 52041.5 10568.6 10780.4 10844.7 10986.3 11081.6 19424.1 19607.3 19862.7 19969.4 19977.8 7946.2 8049.2 8080.3 8093.7 8130.7 4282.9 4422.2 4436.2 4540.7 4643.4 3009.7 3051.6 3052.6 3058.6 3060.7 608.3 617.9 621.0 621.5 626.8 598.3 614.1 615.7 640.1 653.4 8316.7 8585.2 8733.7 8854.7 8947.6 482.3 555.0 601.5 615.0 623.6 3737.3 3845.0 3960.7 3969.5 4014.3 61435.0 62124.0 62795.4 62953.0 63397.0 54414.0 55378.2 55705.0 55822.7 55856.7 48739.0 50221.7 50626.0 50635.5 51356.7 8319.2 8463.0 8578.3 8585.5 8598.8 36516.5 36575.0 36846.4 38414.6 38571.2 42156.6 47164.3 47199.1 47867.8 48582.8 10949.2 11050.7 11090.9 11215.2 11253.6 11957.5 12030.9 12289.6 12357.4 12754.6 11248.0 11994.4 11995.0 12265.8 12271.6 11147.2 11357.7 11431.7 11540.9 11701.0 11232.3 11575.7 11668.3 11941.4 12004.2 9492.2 9681.7 9862.6 9923.0 10115.8 8835.7 8914.9 9285.5 9576.0 9743.9 19:12:38 INFO - PROCESS | 1325 | -------- Summary: end -------- 19:12:38 INFO - PROCESS | 1325 | 19:12:39 INFO - TEST-INFO | 1325: exit 0 19:12:39 INFO - TEST-OK | dromaeo_css | took 1112671ms 19:12:39 INFO - TEST-START | kraken 19:12:39 INFO - operating with platform_type : linux_ 19:12:39 INFO - Initialising browser for kraken test... 19:12:39 INFO - TEST-INFO | started process 1512 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZhTvLE/profile http://localhost:47027/getInfo.html) 19:12:43 INFO - PROCESS | 1512 | __metrics Screen width/height:1600/1200 19:12:43 INFO - PROCESS | 1512 | colorDepth:24 19:12:43 INFO - PROCESS | 1512 | Browser inner width/height: 1024/697 19:12:43 INFO - PROCESS | 1512 | __metrics 19:12:44 ERROR - PROCESS | 1512 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:44 INFO - TEST-INFO | 1512: exit 0 19:12:44 INFO - Browser initialized. 19:12:44 INFO - Running cycle 1/1 for kraken test... 19:12:44 INFO - TEST-INFO | started process 1593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZhTvLE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:56 INFO - PROCESS | 1593 | RSS: Main: 154152960 19:12:56 INFO - PROCESS | 1593 | 19:12:59 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47027/tests/kraken/driver.html?testName=audio-beat-detection) 19:12:59 INFO - PROCESS | 1593 | RSS: Main: 195284992 19:12:59 INFO - PROCESS | 1593 | 19:13:02 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47027/tests/kraken/driver.html?testName=audio-dft) 19:13:03 INFO - PROCESS | 1593 | RSS: Main: 185462784 19:13:03 INFO - PROCESS | 1593 | 19:13:06 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47027/tests/kraken/driver.html?testName=audio-fft) 19:13:06 INFO - PROCESS | 1593 | RSS: Main: 171216896 19:13:06 INFO - PROCESS | 1593 | 19:13:08 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47027/tests/kraken/driver.html?testName=audio-oscillator) 19:13:09 INFO - PROCESS | 1593 | RSS: Main: 174080000 19:13:09 INFO - PROCESS | 1593 | 19:13:11 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:11 INFO - PROCESS | 1593 | RSS: Main: 175984640 19:13:11 INFO - PROCESS | 1593 | 19:13:15 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47027/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:15 INFO - PROCESS | 1593 | RSS: Main: 176005120 19:13:15 INFO - PROCESS | 1593 | 19:13:19 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47027/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:19 INFO - PROCESS | 1593 | RSS: Main: 177057792 19:13:19 INFO - PROCESS | 1593 | 19:13:22 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47027/tests/kraken/driver.html?testName=json-parse-financial) 19:13:23 INFO - PROCESS | 1593 | RSS: Main: 175751168 19:13:23 INFO - PROCESS | 1593 | 19:13:24 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:25 INFO - PROCESS | 1593 | RSS: Main: 186445824 19:13:25 INFO - PROCESS | 1593 | 19:13:26 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:27 INFO - PROCESS | 1593 | RSS: Main: 183328768 19:13:27 INFO - PROCESS | 1593 | 19:13:29 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:30 INFO - PROCESS | 1593 | RSS: Main: 195391488 19:13:30 INFO - PROCESS | 1593 | 19:13:32 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:33 INFO - PROCESS | 1593 | RSS: Main: 199983104 19:13:33 INFO - PROCESS | 1593 | 19:13:35 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:36 INFO - PROCESS | 1593 | RSS: Main: 199327744 19:13:36 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | Cycle 1(1): loaded http://localhost:47027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47027/tests/kraken/driver.html?testName=ai-astar) 19:13:38 INFO - PROCESS | 1593 | RSS: Main: 260333568 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | __start_tp_report 19:13:38 INFO - PROCESS | 1593 | _x_x_mozilla_page_load 19:13:38 INFO - PROCESS | 1593 | _x_x_mozilla_page_load_details 19:13:38 INFO - PROCESS | 1593 | |i|pagename|runs| 19:13:38 INFO - PROCESS | 1593 | |0;ai-astar;108;110;106;110;110;111;101;110;110;109 19:13:38 INFO - PROCESS | 1593 | |1;audio-beat-detection;157;126;150;163;127;150;151;130;169;127 19:13:38 INFO - PROCESS | 1593 | |2;audio-dft;162;160;160;161;161;159;160;167;162;162 19:13:38 INFO - PROCESS | 1593 | |3;audio-fft;76;76;105;94;72;75;75;111;96;72 19:13:38 INFO - PROCESS | 1593 | |4;audio-oscillator;93;94;147;94;93;93;151;93;94;138 19:13:38 INFO - PROCESS | 1593 | |5;imaging-gaussian-blur;118;117;117;116;117;117;117;118;117;118 19:13:38 INFO - PROCESS | 1593 | |6;imaging-darkroom;146;145;145;146;145;146;145;146;146;146 19:13:38 INFO - PROCESS | 1593 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 19:13:38 INFO - PROCESS | 1593 | |8;json-parse-financial;56;56;55;57;55;56;56;65;54;52 19:13:38 INFO - PROCESS | 1593 | |9;json-stringify-tinderbox;67;68;67;68;69;69;69;69;68;68 19:13:38 INFO - PROCESS | 1593 | |10;stanford-crypto-aes;83;82;83;82;82;82;84;83;84;82 19:13:38 INFO - PROCESS | 1593 | |11;stanford-crypto-ccm;120;125;118;126;116;114;120;117;114;121 19:13:38 INFO - PROCESS | 1593 | |12;stanford-crypto-pbkdf2;159;139;147;139;153;137;159;149;155;148 19:13:38 INFO - PROCESS | 1593 | |13;stanford-crypto-sha256-iterative;67;71;72;67;67;69;68;69;67;69 19:13:38 INFO - PROCESS | 1593 | __end_tp_report 19:13:38 INFO - PROCESS | 1593 | __start_cc_report 19:13:38 INFO - PROCESS | 1593 | _x_x_mozilla_cycle_collect,1078 19:13:38 INFO - PROCESS | 1593 | __end_cc_report 19:13:38 INFO - PROCESS | 1593 | __startTimestamp1457579618284__endTimestamp 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | ------- Summary: start ------- 19:13:38 INFO - PROCESS | 1593 | Number of tests: 14 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:2.99 (2.7%) stddev-sans-first:3.17 19:13:38 INFO - PROCESS | 1593 | Values: 108.0 110.0 106.0 110.0 110.0 111.0 101.0 110.0 110.0 109.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:150.50 stddev:16.21 (10.8%) stddev-sans-first:16.60 19:13:38 INFO - PROCESS | 1593 | Values: 157.0 126.0 150.0 163.0 127.0 150.0 151.0 130.0 169.0 127.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:2.22 (1.4%) stddev-sans-first:2.35 19:13:38 INFO - PROCESS | 1593 | Values: 162.0 160.0 160.0 161.0 161.0 159.0 160.0 167.0 162.0 162.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.50 stddev:14.82 (19.6%) stddev-sans-first:15.34 19:13:38 INFO - PROCESS | 1593 | Values: 76.0 76.0 105.0 94.0 72.0 75.0 75.0 111.0 96.0 72.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:93.00 stddev:25.27 (27.2%) stddev-sans-first:26.13 19:13:38 INFO - PROCESS | 1593 | Values: 93.0 94.0 147.0 94.0 93.0 93.0 151.0 93.0 94.0 138.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 19:13:38 INFO - PROCESS | 1593 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 118.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:13:38 INFO - PROCESS | 1593 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:13:38 INFO - PROCESS | 1593 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.39 (6.1%) stddev-sans-first:3.60 19:13:38 INFO - PROCESS | 1593 | Values: 56.0 56.0 55.0 57.0 55.0 56.0 56.0 65.0 54.0 52.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 19:13:38 INFO - PROCESS | 1593 | Values: 67.0 68.0 67.0 68.0 69.0 69.0 69.0 69.0 68.0 68.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 19:13:38 INFO - PROCESS | 1593 | Values: 83.0 82.0 83.0 82.0 82.0 82.0 84.0 83.0 84.0 82.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:120.00 stddev:4.15 (3.5%) stddev-sans-first:4.39 19:13:38 INFO - PROCESS | 1593 | Values: 120.0 125.0 118.0 126.0 116.0 114.0 120.0 117.0 114.0 121.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:151.00 stddev:8.15 (5.4%) stddev-sans-first:7.71 19:13:38 INFO - PROCESS | 1593 | Values: 159.0 139.0 147.0 139.0 153.0 137.0 159.0 149.0 155.0 148.0 19:13:38 INFO - PROCESS | 1593 | 19:13:38 INFO - PROCESS | 1593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.79 19:13:38 INFO - PROCESS | 1593 | Values: 67.0 71.0 72.0 67.0 67.0 69.0 68.0 69.0 67.0 69.0 19:13:38 INFO - PROCESS | 1593 | -------- Summary: end -------- 19:13:38 INFO - PROCESS | 1593 | 19:13:39 INFO - TEST-INFO | 1593: exit 0 19:13:39 INFO - TEST-OK | kraken | took 59910ms 19:13:39 INFO - SUITE-END | took 1172s 19:13:39 INFO - Completed test suite (00:19:32) 19:13:39 INFO - javascript benchmark 19:13:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3132.6084239470065, 3158.636756772969, 3197.5363572282035, 3197.8081315121094, 3228.790128641639, 5071.0, 5079.339685840836, 5134.229865520174, 5207.0, 5213.061648903196, 5115.079285728568, 5126.026055049538, 5127.641065125443, 5154.0, 5158.845234642958, 4639.582437580617, 4681.836135735241, 4740.668153229275, 4785.856424307276, 4800.927986080212, 4656.092062047902, 4702.929456058162, 4769.093872164278, 4780.617550595962, 4876.097921884445, 4698.906021879578, 4708.270218116198, 4715.457722361938, 4744.810207591692, 4755.904881902343, 4687.95312046882, 4707.693999889996, 4715.858524244278, 4748.905021899577, 4764.452088009889, 4608.0, 4664.440267167927, 4719.834805781781, 4744.217204161309, 4751.263554149113, 5029.094762942669, 5046.419661738911, 5048.545630893237, 5060.139776238048, 5087.364079490064, 5520.171974203861, 5523.088690366125, 5523.25436066134, 5527.889442211133, 5569.832905012856, 5500.6424582402415, 5525.778968841241, 5572.888542229173, 5594.9720251398885, 5626.803061892855, 5203.947960520422, 5208.713520756357, 5210.192420174917, 5212.061828870802, 5230.895382092375, 5629.971850140723, 5660.2075709400715, 5686.886262274731, 5689.089745640677, 5693.430656934273, 5336.679799211982, 5457.290552228185, 5464.9453505465235, 5528.419515950848, 5552.7778888843995, 5542.168674698827, 5550.361708403505, 5553.916691249635, 5556.416576259516, 5561.0, 5490.450954904558, 5503.559715222773, 5505.009098362333, 5510.366307874566, 5555.194496798023, 5384.380796208407, 5472.91790623133, 5517.586181036439, 5559.416261292587, 5566.832995010156, 4209.284421648327, 4217.557156498585, 4218.430511880918, 4223.345381465878, 4255.276602977439, 3705.5738590062488, 3823.3500304948225, 3823.6941044716355, 3851.017990412427, 3872.5546562145714, 5210.0, 5214.504622060898, 5214.84355469329, 5251.947480525222, 5259.973700131475, 5469.56243500519, 5490.450954904478, 5498.670079795145, 5500.28496295487, 5508.44915508446, 5042.193249080129, 5075.949240507622, 5154.8969020620125, 5160.690358578498, 5210.505002024802, 4586.4725556561425, 4589.954100459019, 4609.193391156534, 4627.95372046282, 4661.021185551004, 5738.569607279471, 5756.597038207286, 5758.049921762946, 5766.654000759884, 5825.446582574648, 5393.595480339069, 5497.780088796563, 5520.751566179451, 5532.253145825262, 5607.831765047055, 5765.798197063083, 5839.182514448065, 5854.882902341844, 5862.296524417097, 5896.14505896634, 5506.366767821592, 5510.779568817203, 5521.2270282159725, 5521.558275338044, 5531.059719847555, 5427.48438898304, 5554.166874968787, 5573.331200255995, 5619.072852979376, 5661.858453538694, 5317.282166907418, 5353.304070470814, 5355.27703760003, 5385.13837785968, 5406.02691515531, 5338.759755811076, 5364.544013758718, 5368.973155134199, 5409.756560954688, 5423.538999184956, 5173.534381905646, 5240.7641656126325, 5272.578193744414, 5338.733063346739, 5369.382521010134, 5408.8377348679605, 5447.182922561489, 5448.5368743655645, 5449.04641687711, 5451.20957461158, 5194.97402512985, 5343.599230057684, 5348.705821179872, 5349.0, 5353.491418315254], "unit": "score", "name": "dojo.html", "value": 5105.370263653997}, {"lowerIsBetter": false, "replicates": [507.7283653245514, 519.2082074835874, 529.8595872093896, 530.9389420216676, 547.1027514875603, 29270.41459170815, 30113.24716882079, 37623.43564846526, 38096.0, 38115.428268575924, 43989.78005109978, 44610.33084503727, 44646.107077858425, 44655.77672111643, 44743.77628111863, 7594.240575942389, 8698.434601750881, 8912.197902188802, 8914.73255802327, 8919.0, 7617.504862183968, 10418.739531511736, 10685.519151638156, 10688.0, 10700.518476668569, 10563.841542376871, 10733.516991735352, 10739.355638661666, 10741.677749667522, 10744.247902646817, 10517.579296828118, 10524.842127368096, 10595.152387808996, 10647.627333043345, 10648.787024259549, 10304.227182961307, 10418.583256669725, 10453.006964338376, 10482.633107841266, 10502.9474852626, 41047.7947610263, 41384.37923431151, 41409.58590414088, 41477.170456591004, 41503.1699366011, 3700.777953322809, 3707.6292370762976, 3984.880453586397, 4012.4382586437923, 4171.895702607429, 31291.0, 31721.0, 31850.0, 31987.360252794813, 32677.836610816794, 4037.9394309085387, 4053.2298863215897, 4153.293940030172, 4160.313548264533, 4186.644135248507, 280205.0, 281438.0, 281500.0, 282182.0, 285064.0, 43035.56964430378, 43852.3422148668, 63087.6845615769, 63496.0, 63909.36090639127, 41500.79249603733, 41742.330306788, 41841.58158418438, 41844.372334415006, 41885.371719424234, 15101.622459438382, 15268.847311526964, 15279.159646219343, 15296.082235065931, 15299.464518742014, 11050.447477626087, 12528.373581320897, 12664.74670506603, 12681.429335679917, 12706.682332941566, 14244.430222790972, 14300.928495357457, 14310.212938288287, 14331.641708957151, 14360.210188439736, 5665.206871038058, 5694.60137790359, 5754.4533269339345, 5839.649621022667, 5851.210086638334, 926.7312479381039, 957.9233661307079, 988.2736188901152, 1015.968791676449, 1021.2595867995792, 29298.267543311587, 29322.0, 29408.558871616944, 29850.10449686513, 29865.0, 988.2094324540338, 999.8700168977987, 1014.7513859104419, 1032.1897310611134, 1064.984025239622, 14785.852141478663, 14896.70206595862, 15219.847801521842, 15326.540203793904, 15565.0, 324163.0, 326153.0, 326739.0, 328736.0, 330450.0, 54749.72625136849, 55134.0, 55269.0, 55278.0, 55333.0, 1104.5195340027115, 1312.2061153002487, 1330.5742162507904, 1335.2122247873801, 1360.5238166641595, 26021.0, 27297.454050918474, 27603.30991725223, 28245.858770706014, 31509.527357089202, 48746.0, 48912.266316006004, 49159.26261106015, 49206.50793492019, 49259.26111108408, 286921.0, 288658.0, 289429.0, 289639.0, 290106.0, 36908.26183476369, 44622.0, 45002.63254621836, 45715.54284457113, 47516.060492438446, 43884.561154388044, 43890.56109438865, 44283.77858110818, 44337.556624434634, 44469.33296000498, 36719.08202294964, 37074.814625926694, 37317.25365492729, 37503.81248093742, 37826.0, 36586.63413365832, 36978.26043479169, 37251.25497490089, 37377.62622373742, 37433.438498422, 36350.63649363472, 36889.26221475609, 37232.81383593065, 37568.62431375761, 37605.05987350338, 31845.681543184273, 32873.50689739608, 33103.83448082744, 33478.66521334756, 33506.83246583751, 25229.369265767768, 25639.487210256062, 25682.229533114038, 25945.22164335073, 26174.738252617994], "unit": "score", "name": "ext.html", "value": 18717.58565785696}, {"lowerIsBetter": false, "replicates": [355.26637493575765, 362.11643589641267, 364.69730123997084, 371.3983346977896, 373.70290618957927, 16843.157842107907, 17325.22036508357, 17341.999999999985, 17659.91170044148, 17686.911565442155, 16593.66812663746, 17542.210600522976, 17744.201510932005, 17747.91126044371, 17760.378386756434, 5299.60252981026, 5379.35447746271, 5501.229827824108, 5507.063799154133, 5517.475839795233, 4032.677385809143, 5367.275417818603, 5844.1818145459665, 6144.5698801083945, 6173.166622505972, 6049.395060493959, 6082.0, 6115.938840611581, 6117.785877494289, 6124.601900876451, 5887.735051922674, 5998.910016349758, 6038.818835434944, 6047.183630209909, 6089.939100608982, 3675.9816200918826, 5110.182370820688, 5271.710055946922, 5330.307060082203, 5339.5728341732565, 20257.594848102955, 21105.47236319089, 21167.788322116736, 21370.0, 21385.786142138535, 2300.482391461908, 2366.503034362786, 2467.444824914398, 2626.960595591068, 2669.172556507489, 12838.614841554769, 12984.0, 13295.734085318336, 13671.794923076062, 13864.376103075387, 1883.3878989328387, 1892.3093071029114, 1893.0723945266857, 1912.7513423255027, 1958.7159861820098, 59906.101408478906, 60586.0, 62836.37163628351, 63193.68403158001, 63512.0, 9937.105660490446, 10013.849792253122, 10204.183665306758, 10213.182945364502, 10304.639337623148, 13554.525591604246, 13583.91328693702, 13602.795958060637, 13615.25116118623, 13697.178169309873, 7817.295274759345, 7917.802054948673, 8033.879491807627, 8052.315553178046, 8127.75616731499, 7907.723229686933, 7955.602219889098, 8086.150954149847, 8090.1909809018625, 8092.352611791042, 5970.313413957364, 6139.96930015356, 6195.19462469876, 6201.596896201732, 6218.378162183745, 1744.7034004219313, 1805.7291406288898, 1838.3841413126486, 1839.3654189304668, 1847.325726109987, 957.1481381570408, 1011.9949400252951, 1051.436764442324, 1057.8677665291839, 1083.6315652678127, 16814.0, 17212.655746885244, 17431.128443578025, 17616.735748963776, 17680.115994200238, 919.6965001549472, 929.4655573045526, 929.5398777604994, 992.5136683025265, 1016.2682868334787, 8118.512889226666, 10144.340617859963, 10276.177905767521, 10333.276670632984, 10376.896231037745, 406773.0, 411523.0, 434948.0, 435116.0, 436825.0539956796, 67662.3233767656, 67816.321836782, 68865.65567172233, 68904.3109568908, 70071.29928700648, 1020.4081632653043, 1024.1448390593937, 1024.3239461955075, 1034.539629864718, 1037.7896171478133, 15360.923195383952, 15362.923185384001, 15442.922785386001, 15569.844301557292, 15595.0, 32133.517997229592, 32793.50809737904, 33678.32643347168, 33967.32065358728, 33975.66024339725, 42334.0, 42474.575254247065, 43148.352774707775, 43321.78339108284, 44433.0, 7398.3341499265325, 7541.5475071495885, 7572.621368931421, 7607.429442791702, 7646.197149299243, 11877.287362758263, 12123.090768192244, 12440.937795311327, 12553.748925021631, 12758.61724148277, 10291.794164116825, 10463.58145674195, 10497.9475102624, 10826.242163048511, 10970.890291096986, 10579.259451838298, 10646.946765266124, 10661.200409969128, 10798.892011080103, 10981.835272471078, 10979.67910164443, 11026.779464410827, 11051.557937682403, 11099.686545410766, 11407.087433005174, 7639.159692433939, 7778.805529861799, 7784.766457006299, 7793.9220607793195, 8043.919560804551, 9561.084707855767, 10928.672139835817, 10993.450327483753, 11161.330320180816, 11248.550057997589], "unit": "score", "name": "jquery.html", "value": 8655.866336213458}, {"lowerIsBetter": false, "replicates": [1380.4340220509594, 1474.3586539855164, 1478.5416520878528, 1660.369059757292, 1841.8228555741348, 7124.964375178123, 7787.065552133745, 7902.051753789539, 7931.167227441122, 7946.562939038351, 7890.210978902107, 8066.11272759996, 8074.4347895647325, 8082.151374105722, 8086.757397278091, 2034.9389518314474, 2310.445493081665, 2347.835651504395, 2368.976310236893, 2378.7621237876247, 2343.6367363058666, 2356.3402247370764, 2359.4337359033793, 2360.0913648245464, 2363.1138323128826, 2298.689676893623, 2371.620540713486, 2375.8336916415856, 2376.3583832365252, 2378.0368950575044, 2309.815214782813, 2339.1462116327502, 2363.7281712602926, 2371.8932648030795, 2372.110458578033, 2288.553732022256, 2296.598095333327, 2315.2938353802083, 2381.6546600742795, 2383.880805959695, 8136.267735903738, 8183.95908020456, 8194.139615340422, 8200.958995205045, 8212.46618969771, 4754.857354279377, 4826.638002149853, 4860.562549370574, 4864.635152363551, 4868.488808675073, 3167.3506931079073, 3266.9836650816833, 3288.70401663849, 3326.251593391492, 3331.983340083284, 1036.3781730961439, 1079.7894410589938, 1085.478970094359, 1103.1230172013268, 1120.0367683792015, 11326.773464530663, 11349.829752553718, 11360.318380897173, 11414.942925285404, 11442.14183936208, 4446.1330040642415, 4459.0, 4540.636749060067, 4546.931796023062, 4555.157295900269, 9731.318807683394, 9732.854007189757, 9742.659006934724, 9747.415155090717, 9768.316217864824, 4453.465584129925, 4971.37857767779, 4996.975015124901, 4999.175136102575, 5012.598992080625, 4329.09089091288, 4409.845655402046, 4434.357018232338, 4440.86677399672, 4451.0430257494145, 3829.3107240696386, 3889.8249578769023, 3897.2984862724416, 3927.6857851371824, 3946.8223929923224, 1244.4710997825887, 1277.0485987939044, 1278.9040821938393, 1289.9677508062373, 1290.8967282617368, 1322.1472150462898, 1339.9196048237136, 1340.1958824705098, 1354.9729005419836, 1373.3545233740126, 7445.739399121005, 7560.735374261874, 7634.427417943676, 7653.732119375795, 7657.770266892002, 475.83821500689237, 486.56452475034644, 492.8767808047988, 493.4744497110566, 499.07670809003054, 5916.319623243296, 5927.4665280125, 5937.435943585352, 5972.13404056418, 5992.610480318765, 9273.072692730673, 9644.95177524108, 9662.75843103928, 9755.512224388753, 9782.657606983721, 9493.715188544355, 9528.809423811485, 9611.759706007406, 9630.518474076269, 9643.807123857483, 7287.744928927462, 7569.810754731066, 7631.122420921665, 7653.808654783675, 7654.846903061907, 7249.456290778107, 7254.6735396908325, 7255.963720181366, 7305.488615797056, 7308.123025237006, 8585.613647385757, 8612.923384576929, 8723.127687231226, 8726.956365218133, 8889.19997200255, 8776.078511756174, 8782.209601135928, 9021.188093071654, 9035.819283614159, 9044.050374710823, 6395.104685343963, 6572.474202063919, 6867.793966181022, 7145.678444469907, 7207.351338379571, 7665.3101220890385, 7711.305982461381, 7728.420368472274, 7738.729144479917, 7757.806054848674, 6925.826854328682, 7150.7497237596435, 7168.784936451915, 7274.236205198378, 7291.708331666674, 6865.27914568963, 7046.647667616496, 7049.577025378494, 7167.498275120692, 7167.856642867009, 7274.16347120088, 7274.563526188445, 7332.046833911558, 7332.706691732271, 7358.0434543509, 6613.272540020497, 6617.371349721769, 6658.900116498353, 6660.0675905374255, 6661.3338666132995, 6441.098246245436, 6579.769708060195, 6613.371729685672, 6658.900116498159, 6707.027481015323], "unit": "score", "name": "mootools.html", "value": 4557.498950218196}, {"lowerIsBetter": false, "replicates": [311.1086736499928, 313.8023045481347, 314.10949956872264, 318.83579956322484, 319.2163239247647, 5779.21980532628, 5884.882302353955, 5904.202932604097, 5911.201987731655, 5929.970350148249, 5773.653580785156, 5781.595288329819, 5782.82651520454, 5801.100829371444, 5811.27359080115, 4308.547602501739, 4360.760158191299, 4448.666350023745, 4448.844290449835, 4472.821087156518, 4461.4869290031575, 4475.619572336355, 4481.4846292676275, 4499.820007199708, 4505.234110201257, 4456.866294011184, 4457.175422546839, 4463.062756821071, 4464.843730469434, 4476.753778542179, 4265.78671066447, 4361.5856493633055, 4442.3336499525, 4458.509563947963, 4472.575105364985, 3930.213957208541, 3930.744501607386, 3942.9156981830224, 3956.604339566049, 3957.0503079261057, 5513.807016754435, 5531.3915469298345, 5540.058190107691, 5546.833594992157, 5548.833534993957, 5161.045206636784, 5191.688498690053, 5199.0, 5199.402068762065, 5202.687838729688, 6142.723577439026, 6148.446639802394, 6149.631022138686, 6152.907706384408, 6159.784407545759, 3989.5611482736876, 4059.3707975263883, 4062.7765472898977, 4353.521112677603, 4366.781660916973, 6304.716287767062, 6400.4559612432995, 6409.294977552466, 6417.93582064178, 6435.356464353574, 4315.554289313115, 4315.978420107942, 4317.805698743564, 4318.848840290575, 4321.092570560218, 4364.039911219526, 4364.825406983685, 4365.039691267916, 4367.606915377632, 4368.716033457815, 5085.720285384339, 5098.056859481007, 5100.285959965608, 5102.668326558762, 5103.821366252163, 6043.123747056652, 6186.907196392058, 6187.504999600022, 6187.690615469209, 6190.226221722285, 1494.4619936822735, 1507.3819733909045, 1508.3891024135244, 1510.101489613678, 1513.6821267533942, 952.6951375559754, 975.531744762518, 983.0562659846485, 991.3258983891023, 1056.5087234436023, 5838.12428135783, 5845.357010728816, 5847.649141051551, 5853.122031695195, 5861.150133230658, 6256.43692067707, 6278.372162783685, 6292.653904035322, 6296.024116261987, 6298.0, 5875.089361149029, 5878.206442130343, 5883.264591926009, 5884.352721200665, 5886.735096920649, 3342.4317865962357, 3384.915377115592, 3386.813725245086, 3387.4241378965144, 3394.2702319001532, 6549.9345006550275, 6643.368879956396, 6658.667066646648, 6760.7295708172105, 6798.966005169942, 6533.705983230766, 6569.244536878225, 6573.0, 6574.572652777554, 6583.440407565315, 6699.698513566804, 6751.628660423626, 6757.222919364336, 6766.25571187169, 6768.458523318122, 6332.905006425, 6346.777862774781, 6365.0, 6367.42693157618, 6370.74517019314, 6201.472874805511, 6344.651044192614, 6350.396712312323, 6361.14124593174, 6363.268224154282, 6715.7985260442265, 6729.394354508117, 6741.52809303344, 6744.22441419243, 6749.0, 4303.870883873489, 4304.311310190355, 4313.331433627793, 4313.870583882489, 4318.265894797954, 6357.936420635734, 6362.650054246876, 6368.5860419072615, 6377.8724425512155, 6385.201849768779, 6192.164057852132, 6207.286162091417, 6207.503399728102, 6207.906881396873, 6213.0, 6055.091736239599, 6154.1999540059505, 6192.195014648067, 6199.504039676905, 6210.596311239936, 6064.514838812973, 6084.482818960261, 6099.573029887865, 6107.0, 6128.754849806136, 6232.220972378453, 6233.937660623517, 6236.688165591793, 6242.188515493139, 6242.375762423903, 5848.152017957457, 5923.585349025527, 6072.969635151796, 6083.452489275986, 6091.969540152271], "unit": "score", "name": "prototype.html", "value": 4637.057794749326}, {"lowerIsBetter": false, "replicates": [735.3418690272207, 742.9108506979163, 784.1335324466464, 795.5266616363266, 808.4098608016144, 13976.930115349422, 14051.086679365833, 14248.073875198117, 14277.928610356947, 14426.495072672433, 13188.670283242924, 13548.525801596947, 13548.796768048462, 13577.59267221985, 13604.727905441885, 841.0538144587339, 846.4286606540592, 853.2363534636496, 853.2832420766555, 853.87191921212, 680.2890978927009, 831.8502669519484, 852.0159216105408, 853.4452605806214, 853.8728877881199, 883.9292856571491, 889.937704360695, 890.2699786175339, 890.3900827932854, 890.5013192612125, 721.9169795473483, 873.8995015573227, 879.4767113567417, 881.0968757024037, 884.0496466298722, 645.4803882874285, 653.8921078022121, 654.0973456629868, 654.5483616304734, 654.6170490263202, 13870.58388248344, 13914.860851391457, 13975.301234938212, 13981.930090349584, 13993.30033498321, 12558.560450384193, 12609.936950315281, 13004.414801333962, 13150.605481835464, 13191.208527488285, 10732.248742588023, 10744.516496757664, 10808.675739727822, 10932.672019839418, 10995.120390368751, 3611.3319035978166, 3672.1186915140443, 3694.2057457646465, 3695.4826324314618, 3797.39241721326, 50747.746261268825, 51428.0, 51474.0, 51963.48036519624, 52041.47958520442, 10568.577256909792, 10780.353178809297, 10844.728881778019, 10986.285891417192, 11081.5567377304, 19424.12591433389, 19607.31374401889, 19862.70205946912, 19969.400917972194, 19977.800221997593, 7946.165652606509, 8049.195080491904, 8080.27277545012, 8093.676252949934, 8130.674773009132, 4282.89292767677, 4422.204003279377, 4436.245838207513, 4540.659450541222, 4643.44278686553, 3009.6990300970165, 3051.588035615208, 3052.648945371266, 3058.632964044329, 3060.6786287439945, 608.2670382189451, 617.8856911471393, 620.9937900621027, 621.5276389943675, 626.8025571944822, 598.2701104652317, 614.0985132873086, 615.7475435071599, 640.1294239833823, 653.3662347522895, 8316.719731008488, 8585.227329540247, 8733.737987860375, 8854.690085846965, 8947.597358118901, 482.31752070820096, 554.9500544950973, 601.5305390524877, 615.0221148374106, 623.5884316351187, 3737.3272810893754, 3845.0, 3960.7029472789654, 3969.4839670843185, 4014.2769671898823, 61435.0, 62124.0, 62795.37204627987, 62953.0, 63397.0, 54414.0, 55378.16932746012, 55705.0, 55822.720886395306, 55856.72071639616, 48739.0, 50221.74889125531, 50626.0, 50635.49364506381, 51356.74321628368, 8319.209675080858, 8463.0, 8578.313734901318, 8585.527795971282, 8598.78503037429, 36516.45225321569, 36575.0, 36846.44730329101, 38414.615853842224, 38571.22857542778, 42156.57843421526, 47164.292535611305, 47199.05601888012, 47867.76066119786, 48582.75708621434, 10949.233553651487, 11050.723731906766, 11090.944545277222, 11215.214934954802, 11253.606123785628, 11957.461914213707, 12030.879691202976, 12289.631311060682, 12357.38213089324, 12754.61736147917, 11248.0, 11994.400279986141, 11995.0, 12265.816012759995, 12271.57049503263, 11147.163962702993, 11357.716057098309, 11431.657050288504, 11540.884591153981, 11701.0, 11232.3260604364, 11575.652730418102, 11668.299902005907, 11941.402929853646, 12004.159708820298, 9492.193163581172, 9681.70954871355, 9862.55618497155, 9923.0, 10115.797684046425, 8835.690750823947, 8914.86627700572, 9285.48929808867, 9576.0, 9743.853842192515], "unit": "score", "name": "yui.html", "value": 6487.916918907002}], "name": "dromaeo_css", "value": 6957.453227478179}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 106.0, 110.0, 110.0, 111.0, 101.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 150.0, 163.0, 127.0, 150.0, 151.0, 130.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 161.0, 161.0, 159.0, 160.0, 167.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 105.0, 94.0, 72.0, 75.0, 75.0, 111.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 147.0, 94.0, 93.0, 93.0, 151.0, 93.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 56.0, 65.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 84.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 118.0, 126.0, 116.0, 114.0, 120.0, 117.0, 114.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [159.0, 139.0, 147.0, 139.0, 153.0, 137.0, 159.0, 149.0, 155.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 72.0, 67.0, 67.0, 69.0, 68.0, 69.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1511.1}]} 19:13:39 INFO - Return code: 0 19:13:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:39 ERROR - # TBPL SUCCESS # 19:13:39 INFO - Running post-action listener: _resource_record_post_action 19:13:39 INFO - Running post-run listener: _resource_record_post_run 19:13:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 20480; Write bytes: 541585408; Read time: 32; Write time: 554604 19:13:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252125184; Read time: 0; Write time: 324676 19:13:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 289460224; Read time: 32; Write time: 229928 19:13:40 INFO - Running post-run listener: _upload_blobber_files 19:13:40 INFO - Blob upload gear active. 19:13:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:13:40 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:13:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:13:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:13:41 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:41 INFO - (blobuploader) - INFO - Done attempting. 19:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:42 INFO - (blobuploader) - INFO - Done attempting. 19:13:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:42 INFO - Return code: 0 19:13:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:13:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73228563a506441895a8c670ffc5e7f33f10b1735dd62f69faec921e0cc049536b3cdbefc9bcecbb20e840d1d06604a5f54cbed531cc8c5e141dcda0b0ce1bd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15d5112518b33a8281f28ab5c0ee680a6c6902254d109cea1ef7bada558c645b7132177764e78f9347efd1fbed3443bcb5deac031324f3f9f335378636779a78"} 19:13:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:13:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:13:42 INFO - Contents: 19:13:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73228563a506441895a8c670ffc5e7f33f10b1735dd62f69faec921e0cc049536b3cdbefc9bcecbb20e840d1d06604a5f54cbed531cc8c5e141dcda0b0ce1bd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15d5112518b33a8281f28ab5c0ee680a6c6902254d109cea1ef7bada558c645b7132177764e78f9347efd1fbed3443bcb5deac031324f3f9f335378636779a78"} 19:13:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:13:42 INFO - Copying logs to upload dir... 19:13:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:13:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.135742 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-09 19:13:42.725233) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 19:13:42.728410) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73228563a506441895a8c670ffc5e7f33f10b1735dd62f69faec921e0cc049536b3cdbefc9bcecbb20e840d1d06604a5f54cbed531cc8c5e141dcda0b0ce1bd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15d5112518b33a8281f28ab5c0ee680a6c6902254d109cea1ef7bada558c645b7132177764e78f9347efd1fbed3443bcb5deac031324f3f9f335378636779a78"} build_url:https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011537 build_url: 'https://queue.taskcluster.net/v1/task/I9iV__pHQp23iXO-7yCYNg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/73228563a506441895a8c670ffc5e7f33f10b1735dd62f69faec921e0cc049536b3cdbefc9bcecbb20e840d1d06604a5f54cbed531cc8c5e141dcda0b0ce1bd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15d5112518b33a8281f28ab5c0ee680a6c6902254d109cea1ef7bada558c645b7132177764e78f9347efd1fbed3443bcb5deac031324f3f9f335378636779a78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 19:13:42.756439) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 19:13:42.757062) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457578356.200893-115602928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 19:13:42.841480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 19:13:42.842052) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 19:13:42.842782) ========= ========= Total master_lag: 0.28 =========