builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1460415252.97 results: success (0) buildid: 20160411131746 builduid: e180de5667b44723a2bddd20b9a42428 revision: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:12.970220) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:12.970659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:12.970957) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.076087) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.076374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.205578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.205839) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.260074) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.260338) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.260674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.260949) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 15:54:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 15.6M=0.001s 2016-04-11 15:54:13 (15.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.406046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.406344) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.459504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:13.460112) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 --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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 15:54:13,754 truncating revision to first 12 chars 2016-04-11 15:54:13,754 Setting DEBUG logging. 2016-04-11 15:54:13,754 attempt 1/10 2016-04-11 15:54:13,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1cff2bbb09ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 15:54:14,027 unpacking tar archive at: mozilla-aurora-1cff2bbb09ff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:14.048460) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:14.048989) ========= echo 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1cff2bbb09ff3d87be20c32ceade91b70b40ad40'] 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 program finished with exit code 0 elapsedTime=0.004697 script_repo_revision: '1cff2bbb09ff3d87be20c32ceade91b70b40ad40' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:14.100675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:14.100966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 15:54:14.111136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-11 15:54:14.111483) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:14 INFO - MultiFileLogger online at 20160411 15:54:14 in /builds/slave/test-pgo 15:54:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:54:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:54:14 INFO - {'append_to_log': False, 15:54:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:54:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:54:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:54:14 INFO - 'branch': 'Mozilla-Aurora', 15:54:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:14 INFO - 'config_files': ('talos/linux_config.py',), 15:54:14 INFO - 'default_actions': ('clobber', 15:54:14 INFO - 'read-buildbot-config', 15:54:14 INFO - 'download-and-extract', 15:54:14 INFO - 'populate-webroot', 15:54:14 INFO - 'create-virtualenv', 15:54:14 INFO - 'install', 15:54:14 INFO - 'run-tests'), 15:54:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:14 INFO - 'download_minidump_stackwalk': True, 15:54:14 INFO - 'download_symbols': 'ondemand', 15:54:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:14 INFO - 'installer_path': 'installer.exe', 15:54:14 INFO - 'log_level': 'info', 15:54:14 INFO - 'log_name': 'talos', 15:54:14 INFO - 'log_to_console': True, 15:54:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:14 INFO - 'opt_config_files': (), 15:54:14 INFO - 'pip_index': False, 15:54:14 INFO - 'sps_profile': False, 15:54:14 INFO - 'sps_profile_interval': 0, 15:54:14 INFO - 'suite': 'dromaeojs', 15:54:14 INFO - 'system_bits': '32', 15:54:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:14 INFO - 'title': 'talos-linux64-ix-011', 15:54:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:14 INFO - 'use_talos_json': True, 15:54:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:54:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:14 INFO - 'work_dir': 'build'} 15:54:14 INFO - ##### 15:54:14 INFO - ##### Running clobber step. 15:54:14 INFO - ##### 15:54:14 INFO - Running pre-action listener: _resource_record_pre_action 15:54:14 INFO - Running main action method: clobber 15:54:14 INFO - rmtree: /builds/slave/test-pgo/build 15:54:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:54:14 INFO - Running post-action listener: _resource_record_post_action 15:54:14 INFO - ##### 15:54:14 INFO - ##### Running read-buildbot-config step. 15:54:14 INFO - ##### 15:54:14 INFO - Running pre-action listener: _resource_record_pre_action 15:54:14 INFO - Running main action method: read_buildbot_config 15:54:14 INFO - Using buildbot properties: 15:54:14 INFO - { 15:54:14 INFO - "project": "", 15:54:14 INFO - "product": "firefox", 15:54:14 INFO - "script_repo_revision": "production", 15:54:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:54:14 INFO - "repository": "", 15:54:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:54:14 INFO - "buildid": "20160411131746", 15:54:14 INFO - "pgo_build": "True", 15:54:14 INFO - "basedir": "/builds/slave/test-pgo", 15:54:14 INFO - "buildnumber": 422, 15:54:14 INFO - "slavename": "talos-linux64-ix-011", 15:54:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:54:14 INFO - "platform": "ubuntu64_hw", 15:54:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:54:14 INFO - "branch": "mozilla-aurora", 15:54:14 INFO - "repo_path": "releases/mozilla-aurora", 15:54:14 INFO - "revision": "1cff2bbb09ff3d87be20c32ceade91b70b40ad40", 15:54:14 INFO - "stage_platform": "linux64-pgo", 15:54:14 INFO - "builduid": "e180de5667b44723a2bddd20b9a42428", 15:54:14 INFO - "slavebuilddir": "test" 15:54:14 INFO - } 15:54:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:54:14 INFO - Running post-action listener: _resource_record_post_action 15:54:14 INFO - ##### 15:54:14 INFO - ##### Running download-and-extract step. 15:54:14 INFO - ##### 15:54:14 INFO - Running pre-action listener: _resource_record_pre_action 15:54:14 INFO - Running main action method: download_and_extract 15:54:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:14 INFO - https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:54:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:54:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:54:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:54:25 INFO - Downloaded 1448 bytes. 15:54:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:54:25 INFO - Using the following test package requirements: 15:54:25 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:54:25 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:25 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:54:25 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'jsshell-linux-x86_64.zip'], 15:54:25 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:25 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:54:25 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:54:25 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:54:25 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:25 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:54:25 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:54:25 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:25 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54:25 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')]} 15:54:25 INFO - https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:26 INFO - Downloaded 23349869 bytes. 15:54:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:54:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:54:27 INFO - Return code: 0 15:54:27 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:54: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')]} 15:54:27 INFO - https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:34 INFO - Downloaded 23349869 bytes. 15:54:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:54:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:54:35 INFO - Return code: 0 15:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:35 INFO - https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:36 INFO - Downloaded 10845168 bytes. 15:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:54:37 INFO - Return code: 0 15:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:37 INFO - https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:54:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:54:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:54:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:54:38 INFO - Downloaded 60568326 bytes. 15:54:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:54:38 INFO - mkdir: /builds/slave/test-pgo/properties 15:54:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:54:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:54:38 INFO - Contents: 15:54:38 INFO - build_url:https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:54:39 INFO - Running post-action listener: _resource_record_post_action 15:54:39 INFO - Running post-action listener: set_extra_try_arguments 15:54:39 INFO - ##### 15:54:39 INFO - ##### Running populate-webroot step. 15:54:39 INFO - ##### 15:54:39 INFO - Running pre-action listener: _resource_record_pre_action 15:54:39 INFO - Running main action method: populate_webroot 15:54:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:39 INFO - '--tppagecycles', 15:54:39 INFO - '7'], 15:54:39 INFO - 'tests': ['tsvgm']}}, 15:54:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:54:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:54:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['damp', 'tps']}, 15:54:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['damp', 'tps']}, 15:54:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:54:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:39 INFO - 'other': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'other_l64': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:54:39 INFO - 'ts_paint', 15:54:39 INFO - 'tpaint', 15:54:39 INFO - 'sessionrestore', 15:54:39 INFO - 'sessionrestore_no_auto_restore', 15:54:39 INFO - 'tabpaint']}, 15:54:39 INFO - 'svgr': {'tests': ['tsvgx', 15:54:39 INFO - 'tsvgr_opacity', 15:54:39 INFO - 'tart', 15:54:39 INFO - 'tscrollx', 15:54:39 INFO - 'cart']}, 15:54:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tsvgx', 15:54:39 INFO - 'tsvgr_opacity', 15:54:39 INFO - 'tart', 15:54:39 INFO - 'tscrollx', 15:54:39 INFO - 'cart']}, 15:54:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'tests': ['tp5o']}, 15:54:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s'], 15:54:39 INFO - 'tests': ['tp5o']}, 15:54:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--xperf_path', 15:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:39 INFO - 'tests': ['tp5n']}, 15:54:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:39 INFO - 'talos_options': ['--e10s', 15:54:39 INFO - '--xperf_path', 15:54:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:39 INFO - 'tests': ['tp5n']}}, 15:54:39 INFO - 'talos.zip': {'path': '', 15:54:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:39 INFO - Running post-action listener: _resource_record_post_action 15:54:39 INFO - ##### 15:54:39 INFO - ##### Running create-virtualenv step. 15:54:39 INFO - ##### 15:54:39 INFO - Running pre-action listener: _resource_record_pre_action 15:54:39 INFO - Running main action method: create_virtualenv 15:54:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:54:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:54:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:54:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:39 INFO - Using real prefix '/usr' 15:54:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:54:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:41 INFO - Installing pip.................done. 15:54:41 INFO - Return code: 0 15:54:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:54:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:54:42 INFO - Cleaning up... 15:54:42 INFO - Return code: 0 15:54:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:54:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:54:42 INFO - Using env: {'DISPLAY': ':0', 15:54:42 INFO - 'HOME': '/home/cltbld', 15:54:42 INFO - 'LANG': 'en_US.UTF-8', 15:54:42 INFO - 'LANGUAGE': 'en_US:en', 15:54:42 INFO - 'LOGNAME': 'cltbld', 15:54:42 INFO - 'MAIL': '/var/mail/cltbld', 15:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:42 INFO - 'MOZ_NO_REMOTE': '1', 15:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:42 INFO - 'NO_EM_RESTART': '1', 15:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:42 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:42 INFO - 'SHELL': '/bin/bash', 15:54:42 INFO - 'SHLVL': '1', 15:54:42 INFO - 'TERM': 'linux', 15:54:42 INFO - 'TMOUT': '86400', 15:54:42 INFO - 'USER': 'cltbld', 15:54:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:42 INFO - '_': '/tools/buildbot/bin/python'} 15:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:42 INFO - Downloading/unpacking psutil>=0.7.1 15:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:44 INFO - Installing collected packages: psutil 15:54:44 INFO - Running setup.py install for psutil 15:54:44 INFO - building 'psutil._psutil_linux' extension 15:54:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:54:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:54:44 INFO - building 'psutil._psutil_posix' extension 15:54:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:54:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:44 INFO - Successfully installed psutil 15:54:44 INFO - Cleaning up... 15:54:44 INFO - Return code: 0 15:54:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:54:44 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')]} 15:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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')]} 15:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:44 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 15:54:44 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 15:54:44 INFO - Using env: {'DISPLAY': ':0', 15:54:44 INFO - 'HOME': '/home/cltbld', 15:54:44 INFO - 'LANG': 'en_US.UTF-8', 15:54:44 INFO - 'LANGUAGE': 'en_US:en', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MAIL': '/var/mail/cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SHLVL': '1', 15:54:44 INFO - 'TERM': 'linux', 15:54:44 INFO - 'TMOUT': '86400', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - '_': '/tools/buildbot/bin/python'} 15:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:54:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:54:47 INFO - Installing collected packages: mozsystemmonitor 15:54:47 INFO - Running setup.py install for mozsystemmonitor 15:54:47 INFO - Successfully installed mozsystemmonitor 15:54:47 INFO - Cleaning up... 15:54:47 INFO - Return code: 0 15:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:54:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:54:47 INFO - Using env: {'DISPLAY': ':0', 15:54:47 INFO - 'HOME': '/home/cltbld', 15:54:47 INFO - 'LANG': 'en_US.UTF-8', 15:54:47 INFO - 'LANGUAGE': 'en_US:en', 15:54:47 INFO - 'LOGNAME': 'cltbld', 15:54:47 INFO - 'MAIL': '/var/mail/cltbld', 15:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:47 INFO - 'MOZ_NO_REMOTE': '1', 15:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:47 INFO - 'NO_EM_RESTART': '1', 15:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:47 INFO - 'SHELL': '/bin/bash', 15:54:47 INFO - 'SHLVL': '1', 15:54:47 INFO - 'TERM': 'linux', 15:54:47 INFO - 'TMOUT': '86400', 15:54:47 INFO - 'USER': 'cltbld', 15:54:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:47 INFO - '_': '/tools/buildbot/bin/python'} 15:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:49 INFO - Downloading docopt-0.6.1.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:50 INFO - Running setup.py install for blobuploader 15:54:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:54:50 INFO - Running setup.py install for requests 15:54:50 INFO - Running setup.py install for docopt 15:54:50 INFO - Successfully installed blobuploader requests docopt 15:54:50 INFO - Cleaning up... 15:54:50 INFO - Return code: 0 15:54:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:54:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:50 INFO - Using env: {'DISPLAY': ':0', 15:54:50 INFO - 'HOME': '/home/cltbld', 15:54:50 INFO - 'LANG': 'en_US.UTF-8', 15:54:50 INFO - 'LANGUAGE': 'en_US:en', 15:54:50 INFO - 'LOGNAME': 'cltbld', 15:54:50 INFO - 'MAIL': '/var/mail/cltbld', 15:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:50 INFO - 'MOZ_NO_REMOTE': '1', 15:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:50 INFO - 'NO_EM_RESTART': '1', 15:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:50 INFO - 'SHELL': '/bin/bash', 15:54:50 INFO - 'SHLVL': '1', 15:54:50 INFO - 'TERM': 'linux', 15:54:50 INFO - 'TMOUT': '86400', 15:54:50 INFO - 'USER': 'cltbld', 15:54:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:50 INFO - '_': '/tools/buildbot/bin/python'} 15:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:50 INFO - Running setup.py (path:/tmp/pip-ccG_hY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:50 INFO - Running setup.py (path:/tmp/pip-NcKgIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:50 INFO - Running setup.py (path:/tmp/pip-_vf6aJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:51 INFO - Running setup.py (path:/tmp/pip-SmseDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:51 INFO - Running setup.py (path:/tmp/pip-Kbe6IZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:51 INFO - Running setup.py (path:/tmp/pip-LItCFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:51 INFO - Running setup.py (path:/tmp/pip-zhxWkb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:51 INFO - Running setup.py (path:/tmp/pip-ck2WXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:51 INFO - Running setup.py (path:/tmp/pip-U5pp_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:51 INFO - Running setup.py (path:/tmp/pip-cR7nSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:51 INFO - Running setup.py (path:/tmp/pip-Ac068b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:51 INFO - Running setup.py (path:/tmp/pip-oVW1eb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:51 INFO - Running setup.py (path:/tmp/pip-HCZd85-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:51 INFO - Running setup.py (path:/tmp/pip-__Y1xy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Running setup.py (path:/tmp/pip-vAMvuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:51 INFO - Running setup.py (path:/tmp/pip-010jBS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:51 INFO - Running setup.py (path:/tmp/pip-OZY7xr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:52 INFO - Running setup.py install for manifestparser 15:54:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozcrash 15:54:52 INFO - Running setup.py install for mozdebug 15:54:52 INFO - Running setup.py install for mozdevice 15:54:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozfile 15:54:52 INFO - Running setup.py install for mozhttpd 15:54:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozinfo 15:54:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozInstall 15:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:54:52 INFO - Running setup.py install for mozleak 15:54:52 INFO - Running setup.py install for mozlog 15:54:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Running setup.py install for moznetwork 15:54:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Running setup.py install for mozprocess 15:54:53 INFO - Running setup.py install for mozprofile 15:54:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Running setup.py install for mozrunner 15:54:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Running setup.py install for mozscreenshot 15:54:53 INFO - Running setup.py install for moztest 15:54:53 INFO - Running setup.py install for mozversion 15:54:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 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 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:53 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 15:54:53 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 15:54:53 INFO - Using env: {'DISPLAY': ':0', 15:54:53 INFO - 'HOME': '/home/cltbld', 15:54:53 INFO - 'LANG': 'en_US.UTF-8', 15:54:53 INFO - 'LANGUAGE': 'en_US:en', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MAIL': '/var/mail/cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SHLVL': '1', 15:54:53 INFO - 'TERM': 'linux', 15:54:53 INFO - 'TMOUT': '86400', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - '_': '/tools/buildbot/bin/python'} 15:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:54 INFO - Running setup.py (path:/tmp/pip-Owb79_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:54 INFO - Running setup.py (path:/tmp/pip-YZhCTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:54 INFO - Running setup.py (path:/tmp/pip-JCqpy6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:54 INFO - Running setup.py (path:/tmp/pip-z2OOrs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:54 INFO - Running setup.py (path:/tmp/pip-tW73PS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:54 INFO - Running setup.py (path:/tmp/pip-kMDNBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:54 INFO - Running setup.py (path:/tmp/pip-O13TtD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:54 INFO - Running setup.py (path:/tmp/pip-jEFnPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:54 INFO - Running setup.py (path:/tmp/pip-Jbolfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:54:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:54 INFO - Running setup.py (path:/tmp/pip-tY3M7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:54 INFO - Running setup.py (path:/tmp/pip-OSIOXN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:54 INFO - Running setup.py (path:/tmp/pip-P1OGAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:54 INFO - Running setup.py (path:/tmp/pip-wIJJ4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:54:54 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)) 15:54:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:54 INFO - Running setup.py (path:/tmp/pip-1mDnuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:55 INFO - Running setup.py (path:/tmp/pip-a1Twq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:55 INFO - Running setup.py (path:/tmp/pip-xgs9_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:54:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:55 INFO - Running setup.py (path:/tmp/pip-u2eg38-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:54:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:57 INFO - Downloading blessings-1.6.tar.gz 15:54:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:57 INFO - Installing collected packages: blessings 15:54:57 INFO - Running setup.py install for blessings 15:54:57 INFO - Successfully installed blessings 15:54:57 INFO - Cleaning up... 15:54:57 INFO - Return code: 0 15:54:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:54:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:54:57 INFO - Reading from file tmpfile_stdout 15:54:57 INFO - Current package versions: 15:54:57 INFO - argparse == 1.2.1 15:54:57 INFO - blessings == 1.6 15:54:57 INFO - blobuploader == 1.2.4 15:54:57 INFO - docopt == 0.6.1 15:54:57 INFO - manifestparser == 1.1 15:54:57 INFO - mozInstall == 1.12 15:54:57 INFO - mozcrash == 0.17 15:54:57 INFO - mozdebug == 0.1 15:54:57 INFO - mozdevice == 0.48 15:54:57 INFO - mozfile == 1.2 15:54:57 INFO - mozhttpd == 0.7 15:54:57 INFO - mozinfo == 0.9 15:54:57 INFO - mozleak == 0.1 15:54:57 INFO - mozlog == 3.1 15:54:57 INFO - moznetwork == 0.27 15:54:57 INFO - mozprocess == 0.22 15:54:57 INFO - mozprofile == 0.28 15:54:57 INFO - mozrunner == 6.11 15:54:57 INFO - mozscreenshot == 0.1 15:54:57 INFO - mozsystemmonitor == 0.0 15:54:57 INFO - moztest == 0.7 15:54:57 INFO - mozversion == 1.4 15:54:57 INFO - psutil == 3.1.1 15:54:57 INFO - requests == 1.2.3 15:54:57 INFO - wsgiref == 0.1.2 15:54:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:54:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:54:57 INFO - Using env: {'DISPLAY': ':0', 15:54:57 INFO - 'HOME': '/home/cltbld', 15:54:57 INFO - 'LANG': 'en_US.UTF-8', 15:54:57 INFO - 'LANGUAGE': 'en_US:en', 15:54:57 INFO - 'LOGNAME': 'cltbld', 15:54:57 INFO - 'MAIL': '/var/mail/cltbld', 15:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:57 INFO - 'MOZ_NO_REMOTE': '1', 15:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:57 INFO - 'NO_EM_RESTART': '1', 15:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:57 INFO - 'SHELL': '/bin/bash', 15:54:57 INFO - 'SHLVL': '1', 15:54:57 INFO - 'TERM': 'linux', 15:54:57 INFO - 'TMOUT': '86400', 15:54:57 INFO - 'USER': 'cltbld', 15:54:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:57 INFO - '_': '/tools/buildbot/bin/python'} 15:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:54:57 INFO - Cleaning up... 15:54:57 INFO - Return code: 0 15:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:57 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 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:54:57 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 15:54:57 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 15:54:57 INFO - Using env: {'DISPLAY': ':0', 15:54:57 INFO - 'HOME': '/home/cltbld', 15:54:57 INFO - 'LANG': 'en_US.UTF-8', 15:54:57 INFO - 'LANGUAGE': 'en_US:en', 15:54:57 INFO - 'LOGNAME': 'cltbld', 15:54:57 INFO - 'MAIL': '/var/mail/cltbld', 15:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:57 INFO - 'MOZ_NO_REMOTE': '1', 15:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:57 INFO - 'NO_EM_RESTART': '1', 15:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:54:57 INFO - 'SHELL': '/bin/bash', 15:54:57 INFO - 'SHLVL': '1', 15:54:57 INFO - 'TERM': 'linux', 15:54:57 INFO - 'TMOUT': '86400', 15:54:57 INFO - 'USER': 'cltbld', 15:54:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:57 INFO - '_': '/tools/buildbot/bin/python'} 15:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:58 INFO - Downloading/unpacking jsonschema 15:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:59 INFO - Downloading/unpacking functools32 (from jsonschema) 15:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:55:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:55:00 INFO - warning: no files found matching '*.txt' 15:55:00 INFO - no previously-included directories found matching 'build' 15:55:00 INFO - no previously-included directories found matching 'dist' 15:55:00 INFO - no previously-included directories found matching '.git*' 15:55:00 INFO - Installing collected packages: jsonschema, functools32 15:55:00 INFO - Running setup.py install for functools32 15:55:00 INFO - warning: no files found matching '*.txt' 15:55:00 INFO - no previously-included directories found matching 'build' 15:55:00 INFO - no previously-included directories found matching 'dist' 15:55:00 INFO - no previously-included directories found matching '.git*' 15:55:00 INFO - Successfully installed jsonschema functools32 15:55:00 INFO - Cleaning up... 15:55:00 INFO - Return code: 0 15:55:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88ff041f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29516d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', '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 15:55:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:55:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:55:00 INFO - Using env: {'DISPLAY': ':0', 15:55:00 INFO - 'HOME': '/home/cltbld', 15:55:00 INFO - 'LANG': 'en_US.UTF-8', 15:55:00 INFO - 'LANGUAGE': 'en_US:en', 15:55:00 INFO - 'LOGNAME': 'cltbld', 15:55:00 INFO - 'MAIL': '/var/mail/cltbld', 15:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:00 INFO - 'MOZ_NO_REMOTE': '1', 15:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:00 INFO - 'NO_EM_RESTART': '1', 15:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:55:00 INFO - 'SHELL': '/bin/bash', 15:55:00 INFO - 'SHLVL': '1', 15:55:00 INFO - 'TERM': 'linux', 15:55:00 INFO - 'TMOUT': '86400', 15:55:00 INFO - 'USER': 'cltbld', 15:55:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:00 INFO - '_': '/tools/buildbot/bin/python'} 15:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:00 INFO - Downloading/unpacking flake8 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:55:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:55:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:03 INFO - no previously-included directories found matching 'docs/_build' 15:55:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:55:03 INFO - Running setup.py install for pep8 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:03 INFO - no previously-included directories found matching 'docs/_build' 15:55:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:55:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:55:03 INFO - Cleaning up... 15:55:03 INFO - Return code: 0 15:55:03 INFO - Running post-action listener: _resource_record_post_action 15:55:03 INFO - Running post-action listener: _start_resource_monitoring 15:55:03 INFO - Starting resource monitoring. 15:55:03 INFO - ##### 15:55:03 INFO - ##### Running install step. 15:55:03 INFO - ##### 15:55:03 INFO - Running pre-action listener: _resource_record_pre_action 15:55:03 INFO - Running main action method: install 15:55:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:55:03 INFO - Reading from file tmpfile_stdout 15:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:55:03 INFO - Reading from file tmpfile_stdout 15:55:03 INFO - Output received: 15:55:03 INFO - Usage: mozinstall [options] installer 15:55:03 INFO - Options: 15:55:03 INFO - -h, --help show this help message and exit 15:55:03 INFO - -d DEST, --destination=DEST 15:55:03 INFO - Directory to install application into. [default: 15:55:03 INFO - "/builds/slave/test-pgo"] 15:55:03 INFO - --app=APP Application being installed. [default: firefox] 15:55:03 INFO - mkdir: /builds/slave/test-pgo/build/application 15:55:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:55:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:55:19 INFO - Reading from file tmpfile_stdout 15:55:19 INFO - Output received: 15:55:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:55:19 INFO - Running post-action listener: _resource_record_post_action 15:55:19 INFO - ##### 15:55:19 INFO - ##### Running run-tests step. 15:55:19 INFO - ##### 15:55:19 INFO - Running pre-action listener: _resource_record_pre_action 15:55:19 INFO - Running main action method: run_tests 15:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:55:19 INFO - Python 2.7.3 15:55:19 INFO - Return code: 0 15:55:19 INFO - grabbing minidump binary from tooltool 15:55:19 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')]} 15:55:19 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 0x29e0920>, '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 0x29e1820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e1cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:55:19 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 15:55:19 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 15:55:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:19 INFO - Return code: 0 15:55:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:55:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:55:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:55:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:55:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:55:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:55:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:55:20 INFO - Return code: 0 15:55:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:55:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:55:20 INFO - Using env: {'DISPLAY': ':0', 15:55:20 INFO - 'HOME': '/home/cltbld', 15:55:20 INFO - 'LANG': 'en_US.UTF-8', 15:55:20 INFO - 'LANGUAGE': 'en_US:en', 15:55:20 INFO - 'LOGNAME': 'cltbld', 15:55:20 INFO - 'MAIL': '/var/mail/cltbld', 15:55:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:55:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:20 INFO - 'MOZ_NO_REMOTE': '1', 15:55:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:55:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:20 INFO - 'NO_EM_RESTART': '1', 15:55:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:55:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:55:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:55:20 INFO - 'SHELL': '/bin/bash', 15:55:20 INFO - 'SHLVL': '1', 15:55:20 INFO - 'TERM': 'linux', 15:55:20 INFO - 'TMOUT': '86400', 15:55:20 INFO - 'USER': 'cltbld', 15:55:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814', 15:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:20 INFO - '_': '/tools/buildbot/bin/python'} 15:55:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:55:20 INFO - mozversion application_buildid: 20160411131746 15:55:20 INFO - mozversion application_changeset: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 15:55:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:55:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:20 INFO - mozversion application_name: Firefox 15:55:20 INFO - mozversion application_remotingname: firefox-dev 15:55:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:55:20 INFO - mozversion application_vendor: Mozilla 15:55:20 INFO - mozversion application_version: 47.0a2 15:55:20 INFO - mozversion platform_buildid: 20160411131746 15:55:20 INFO - mozversion platform_changeset: 1cff2bbb09ff3d87be20c32ceade91b70b40ad40 15:55:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:55:20 INFO - mozversion platform_version: 47.0a2 15:55:20 INFO - using testdate: 1460415320 15:55:20 INFO - actual date: 1460415320 15:55:20 INFO - starting webserver on 'localhost:51227' 15:55:20 INFO - SUITE-START | Running 2 tests 15:55:20 INFO - TEST-START | dromaeo_css 15:55:20 INFO - operating with platform_type : linux_ 15:55:20 INFO - Initialising browser for dromaeo_css test... 15:55:20 INFO - TEST-INFO | started process 16199 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJtqFZk/profile http://localhost:51227/getInfo.html) 15:55:25 INFO - PROCESS | 16199 | __metrics Screen width/height:1600/1200 15:55:25 INFO - PROCESS | 16199 | colorDepth:24 15:55:25 INFO - PROCESS | 16199 | Browser inner width/height: 1024/697 15:55:25 INFO - PROCESS | 16199 | __metrics 15:55:27 INFO - PROCESS | 16199 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:55:28 INFO - TEST-INFO | 16199: exit 0 15:55:28 INFO - Browser initialized. 15:55:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:28 INFO - TEST-INFO | started process 16292 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJtqFZk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:40 INFO - PROCESS | 16292 | RSS: Main: 141959168 15:55:40 INFO - PROCESS | 16292 | 15:56:31 INFO - PROCESS | 16292 | 1460415391838 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] 15:58:39 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51227/tests/dromaeo/cssquery-ext.html) 15:58:40 INFO - PROCESS | 16292 | RSS: Main: 255893504 15:58:40 INFO - PROCESS | 16292 | 16:01:42 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-ext.html (next: http://localhost:51227/tests/dromaeo/cssquery-jquery.html) 16:01:43 INFO - PROCESS | 16292 | RSS: Main: 224374784 16:01:43 INFO - PROCESS | 16292 | 16:04:45 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51227/tests/dromaeo/cssquery-mootools.html) 16:04:45 INFO - PROCESS | 16292 | RSS: Main: 239214592 16:04:45 INFO - PROCESS | 16292 | 16:07:47 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51227/tests/dromaeo/cssquery-prototype.html) 16:07:48 INFO - PROCESS | 16292 | RSS: Main: 207794176 16:07:48 INFO - PROCESS | 16292 | 16:10:50 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51227/tests/dromaeo/cssquery-yui.html) 16:10:51 INFO - PROCESS | 16292 | RSS: Main: 206237696 16:10:51 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | Cycle 1(1): loaded http://localhost:51227/tests/dromaeo/cssquery-yui.html (next: http://localhost:51227/tests/dromaeo/cssquery-dojo.html) 16:13:53 INFO - PROCESS | 16292 | RSS: Main: 252039168 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | __start_tp_report 16:13:53 INFO - PROCESS | 16292 | _x_x_mozilla_page_load 16:13:53 INFO - PROCESS | 16292 | _x_x_mozilla_page_load_details 16:13:53 INFO - PROCESS | 16292 | |i|pagename|runs| 16:13:53 INFO - PROCESS | 16292 | |0;dojo.html;3248.512723091537;3321.8671253149873;3354.8490317935675;3356.8992930212103;3401.302732939748;5412.025835349636;5420.430854760248;5423.213634023069;5427;5478.945210547893;5388.245645609618;5433.1850222466555;5434.592405569579;5443.591730620199;5443.8094666686675;4878.902421951559;4935.210366341377;4994.475580064095;5012.548870601645;5046.192609182532;4936;5038.319826823368;5038.899222015558;5041.017001684673;5041.04220198163;4955.677880937727;4955.826546070888;4960.429550601691;4975;5038.345015148026;5084.313617661605;5090.669106508065;5109.718965456898;5114.693118412907;5117.462666420047;4804.23132298834;4849.733264670442;4975.601951843843;4982.103221420143;4996.7001979881325;5211.687298762086;5214.065293160088;5221.869453263661;5225.033368826779;5277.7361131943635;5680.971595142039;5746.74139663712;5777.364489906107;5793.275840519935;5795.449432303924;5853.004989151812;5862.589618726691;5891.469767720926;5892.646441213498;5922.703864806743;5492.093804522249;5505.917411238835;5508;5520.144377621435;5533.612647114664;5871.383504732027;5875.030619947661;5878.441548052928;5907.497862681635;5919.289685237799;5726;5728.656280623176;5734.569907256972;5738.081906894877;5738.68437235956;5761.9135712964335;5776.884462310814;5782.161586569924;5783.971080144656;5790.739416726257;5618.297712785902;5738.397468265855;5770.653760774367;5842.649441033552;5851.414858514115;5768.596198266165;5790.073588225948;5795.478406943395;5796.014677504834;5796.971015144897;4389.407429996973;4420.823167073281;4425.84509542171;4435.379046933432;4456.420665313489;3921.450996860442;3989.5611482736876;4055.7769322686945;4071.65635340337;4098.610631989956;5458.344998600114;5498.340199176125;5502.697351645618;5503.972480137573;5509.283793106871;5717.971410143005;5854.268216472941;5866.090755932837;5869.559783016291;5877;5432.619716619878;5476.069068258405;5496.258005169331;5498.367687715964;5539.058360078796;5035.823746168867;5038.193888977819;5056.216286475602;5060.240963855451;5084.211947148198;5965.194698715618;6001.939980600138;6052.576319657582;6052.727627256784;6054.182685337423;5826.94173058264;5895.911561326498;5896.882062358814;5902.321233058082;5915.201447804491;6073.423024812636;6074.3318234994995;6074.757009719739;6077.908831367445;6084.239470066242;5669.943300566942;5694.06048002075;5783.913241301299;5793.681347525927;5823.854403639773;5765.682887441063;5812.564057695605;5819.359870414166;5819.738111784895;5835.649861008353;5614.522765564972;5659.207710920392;5665.688387138747;5673.0639444492845;5675.57433192504;5596.86007849807;5663.801766938137;5698.344690360662;5762.5389968801555;5763.942360576509;5590.832275031756;5596.076647353141;5611.102223644198;5625.071863142535;5628.155776633538;5715.085586306171;5722.227499287543;5724.74238659253;5736.799212027559;5739.5695322850115;5529.502344788988;5539.833804985857;5564.10974244119;5626.127950167731;5636.88726225465 16:13:53 INFO - PROCESS | 16292 | |1;ext.html;533.9839804805857;559.888022395521;562.5879043600561;606.8179546136158;616.4575173847014;29631.55552666709;30210;30247.69752302479;30276.394472110573;37901;40803;41325.79337103318;41326.793366033206;41402;41569.16861662772;8796.42823216492;8997.95501022494;9000.504972226558;9002.54987250638;9019.278457723367;8724.302055835518;8957.104289571023;8957.95521022394;8960.507172105532;8967.506787126706;8892.777680558005;9186.632534698638;9200.585973631169;9200.907990920072;9213.078692130766;9111.772205694877;9192.218661413788;9202.677906273282;9204.125608067223;9206.815863682756;9133.223675987549;9273.443593384418;9277.396969196981;9284.118008789153;9285.675001374988;41110.794446027576;41532.96167595804;41585.1682966339;41591.7920410399;41601.79199103985;3383.3571621391857;3499.212677147647;3545.131442796506;3995.4805875236034;4243.087736136746;31045.0686479406;31083.68916310853;31109.68890311113;31433;32661.18347041319;4296.6562674986235;4300;4349.151915376503;4383.9342409863875;4408.933865992013;345105;347686;351441;352315;353430;57856.13215801767;58228.126578101364;58532.41467585355;58562.7071864638;58605;61315;66915.66542167257;67851.3214867845;67862;68071;15216.695666086616;15294.464693735667;15294.770578441332;15313.387464501518;15328.463503777315;13200.933995330153;13201.801972970414;13277.136986095873;13309.667258318426;13315.800262996063;19841.900790496245;20556.588868222552;20593.58812823765;20707.79292207059;20712.171513139307;7380.114386273682;7461.232077800676;7621.809454763676;7703.768886933401;7855.8821617675785;886.6542048601051;972.4505654305295;981.9361741486781;1016.5781200801732;1044.3368461027303;29393.265168370963;29700.405991880474;29875.850620746758;30068.548971765442;30136.54795178074;1055.72551136705;1066.1724409370397;1155.9942200289113;1156.7744289863565;1211.836402085707;15253.771193432107;15258.618534536503;15432;15566.299516521784;15633.687326253412;332384;335927;336620;337187;338656;51853.222201667006;53319.46680533145;53320;53413.46586534085;53525;1234.4074844074894;1315.3686230609362;1324.9867501325057;1335.7996300554994;1352.2697743218946;27116.593251100854;27417.31456713598;31417.37165256728;31545.8422707885;34167.89688004684;50327;50970.49029509806;51008.74495627498;51020;51043.23435148402;304940;308940;311330;311475;312233;38018.429723553614;46948.295775564075;47345.289820652026;48074.759626201645;49054.50945490642;44403.33394999013;44730.77634611806;44972.55027449683;45605.315920261884;45837.31244031409;37124.443133352484;38045;38360.80819595996;38361.616383835804;38811;36975.26049479049;37463.063423414635;37595.62404375921;37761.62238377581;37774.62225377821;36611.63388366082;37051.25897482089;37747;37974;38169.23661526809;33416.832915835264;34285.657143428245;34526.48210276798;34653.9207647542;34783.652163478044;25836.741632583435;26200.213993580222;26250.606240906785;26261.606075908494;26416.73583264143 16:13:53 INFO - PROCESS | 16292 | |2;jquery.html;358.6843577651666;362.3604338342824;363.5855125157321;364.8011833550715;376.67417683703604;17074.65850682987;17555.297788088475;19177.137028833702;19187.32844350448;19210.711839322423;17009.2345844437;17209.913950430262;17431.389901353454;17443;17501;5326.7070311132875;5554.527865131468;5572;5573.749181286852;5575.832725018256;4189.329707246841;5407.756650950717;5667.263255776743;5896.970515147418;5911.556633252501;5851.590388672795;5859.384764599719;5874.647521148745;5878.823635290948;5879.970600147015;5691.686957217351;5886.117082437626;5944.405559444086;5954.106883967396;5978;3765.7928813915223;5000.499950005007;5262.7631756571045;5303.575713942875;5307.761150748187;20621.484462888548;20765.68851467214;20869.791302087087;21117.5776484471;21153.36539903805;2269.3872654383226;2347.5774360615083;2379;3065.478868592322;3143.072793525915;12253.853163754535;13103.957530883916;13552.051356405056;13826.861731382658;13891.79162312566;1858.321712574914;1915.5689969756831;1939.4569520534274;1994.7706013808452;2000.1199472232172;64566.67716661387;66887;66997.66501167463;67213.66393168052;67252.663736681;9275.58259878307;9355.29835262358;9762;9828.606855725691;9839.606415743434;13492;13560.186388816703;13562.728745425036;13609.455621775216;13614.523491677744;8022.753628983894;8055.275025247756;8135.389845761473;8177.345812334999;8213.178682131738;8153.1439198884445;8167.469114507538;8300.626471808782;8314.584270786436;8337;5784.219130417424;5891.116332550066;5916.852078698067;5954.702264886739;5991.430814072656;1665.383807991051;1712.24661149094;1740.7562941188244;1751.6058886750634;1764.2413762082429;942.7407462947745;991.3754334769194;996.8006398720285;1055.5988724284723;1069.315637991686;15870.285837137357;16077.437289695039;16086.517404477885;16265;16548.255328510248;914.3142643017736;944.551338114404;949.6818565780541;979.9706008819746;987.2299606307092;9387.718368448957;9547.42715437076;9571.707819444426;9925.950370248247;10059.144972677259;456369;477675;480765;484354;492024;76286.23713762792;77819.61090194513;78061.60969195118;78790.60604696939;78930;1007.2294694558668;1010.5503051142318;1054.2672842374477;1068.5031460370965;1078.035158533124;15365.769513457532;15502.84497155014;15524.30140643651;15704.136272505122;15859.207039647741;34078.318433631684;34717;35016;35297;35544.82227588846;49396.75301623469;49413.25880111873;49453.75273123611;50287.994240115724;50485.747571263375;6644.468442524683;6678.131842860591;6725.865482690221;6837.931620683729;6888.965555172192;12382.56661016896;13052.804207936699;13197.34013299312;13252.072354935448;13350;11176.944115279372;11444.885551144715;11450.37022963745;11568.13239007061;11591.18861679708;4691.741954192552;8205.4409662164;9558.904410955802;11485.942570287429;11541.076713862703;11258.324500529994;11277.492512837107;11408.372539510407;11446.484908179318;11785.705357366134;6446.226452825691;6507.707153178213;6709.899351509634;6771.492138089565;6912.239653638197;8973.955130224307;11483.425828708365;11742.119341049627;11747.765044698886;11756.23584467007 16:13:53 INFO - PROCESS | 16292 | |3;mootools.html;1334.0928168845182;1411.2449839335954;1441.9855801441988;1553.9922300388496;1710.6664200480911;7462.253774622542;8149.918500814997;8334;8376.664933402657;8382.329413646909;8413.284870785976;8636.39545231834;8664.696735614254;8679.088695686956;8681.696140635078;2050.241410678051;2351.3533778211;2355.882205889707;2370.4073981504625;2423.2245681381964;2405.7714517120844;2411.445367565461;2420.3586049696846;2424.224248240555;2426.296374051523;2367.4318163640687;2432.1609044879488;2435.2450740270483;2436.6954130733657;2437.524682686877;2102.8843413612244;2292.64464008079;2323;2324.32594547581;2325.9418514537188;2336.883155842218;2341.7424083350816;2345.1323010486058;2345.8006069484113;2402.531506356261;8447.535385553792;8520.8721869172;8521.573921303972;8525.019622743403;8527.530985795778;4928.063667903087;5033.144365457881;5033.647644664875;5041.445441001487;5073.822416215452;3182.5226216067545;3216.9839150804332;3263.4452143135723;3348.8827891023698;3377.7973321600784;1023.687775228555;2039.857209995301;2045.3966080006435;2065.6385132601736;2067.266120527206;11791.88208117925;11883.227590206609;11929.105317101164;11930.701732456671;11942.582009629621;4230.61924426803;4297.871063868089;4339.34909763538;4356.716813407118;4430.712003719748;8958.328125390623;9019.639214431481;9022.593983270768;9034.36759426847;9041.502717350477;4502.909941801211;5173.275741396207;5200.947990520122;5206.271122042917;5215.217717342353;4673.6728429009645;4692.0850434165695;4732.787024583902;4735.810567577259;4747.477777444478;3513.789172649649;3573.356795776733;3576.338377400189;3625.2386998730562;3641.417373220325;1039.8128336899279;1044.1229367331478;1051.984220236697;1058.4125810175426;1059.5814653212092;1311.76388250114;1311.9934400327936;1331.7269959658247;1344.7982802579495;1345.7308538292184;7586.468947173756;7610.39116870649;7681.039870016248;7689.692412303557;7706.07527096752;479.60911856836566;487.3323546740988;489.2685435274288;489.9436564795094;508.1742168975415;6297.149884765498;6299;6368.203974503187;6410.358964103646;6426.35736426363;10423.270371073952;10758.838617420744;10772.892271077346;10905.01854833053;10919.344839309666;10514.26400151982;10647.30792498485;10750.247482676294;10751.408672523086;10762.300450470695;8188.222118898695;8267.049289331684;8276.006879174418;8292.212239837207;8358.498490090615;7837.7648670539975;7920.841583168189;7923.920760792549;7953.880691789744;7977.162397948132;9490.525473726148;9581.089796469325;9655.179309758749;9674.226061915171;9733.853992190265;9721.319507634398;9827.754306142404;9954.55204515784;10019.198464122706;10119.949400252952;6248.843778905563;6661.966690166518;6781.660916954034;7123.786286411416;7254.96372518134;8081.313088387553;8081.9595902022465;8099.392545559224;8131.715389961323;8147.470414423044;7155.534890232118;7319.45104117204;7397.556146631219;7423.183449820407;7465.925340746523;7205.459590530626;7215.891761623685;7228.132624085143;7229.349358557755;7262.564246145248;7403.962980185064;7414.480986330905;7460.216677248811;7465.776026719207;7469.178390376946;7037.085178926707;7051.048108505492;7099.396551293198;7104.467164962545;7107.573545587281;7259.419246460376;7307.7807665770115;7324.926750732638;7328.303811137934;7331.04696389466 16:13:53 INFO - PROCESS | 16292 | |4;prototype.html;328.66640360034586;333.1288680101534;335.97648164628487;337.1638336924428;340.169985236024;5998.190244317016;6055.455009049185;6063.393660633935;6080.574359794816;6082.270127584685;5972.462478376945;5973.133895585138;5984.611000284989;5987.042073268278;6000.579959402833;4352;4485.394471746322;4498.122866041123;4579.152856721501;4615.123126605942;4624;4633.582977532022;4636.930446043295;4647.907041859161;4649.349091127245;4598.126355992367;4600.861974140781;4607.216773148556;4609.101225261075;4615.515370886059;4330.631896288819;4447.11057788442;4496.820127194908;4523.819047238107;4533.387992620987;4005.639492445694;4015.959840401588;4016.879493615196;4020.5175378954714;4025.7584544927104;5699.857503562403;5712.057510510761;5713.457221563945;5713.685747283897;5724.914126288109;5343.305370301875;5349.679019258857;5351.57187425005;5352.304200453916;5352.384475785296;6261.092141639482;6298.842528936768;6316.210473690789;6331.398517140864;6332.683365831736;4365.301551751736;4446.9777651111535;4454;4460.219461594241;4467.888302792424;6561.015847622847;6579.111819904348;6583.703733332011;6586.506012049115;6599.439047680905;4553.521880202531;4555.157295900269;4562.1560011398;4566.70316429431;4567.543245675406;4616.815327386867;4623.098495793288;4627.375304333939;4627.814887404466;4630.467496237909;5306.310179676694;5309.230161626542;5316.813911513156;5319.547838433777;5320.388155362106;6216.409441103088;6374.808755737336;6377.298497165308;6389.6805159741825;6391.265004524446;1593.6414306781114;1621.8945768525243;1632.1023437109543;1639.221369849312;1644.777954976087;997.7229146692246;1081.2755453845941;1081.4808891731855;1083.1389045708681;1092.2190633696946;6010.038393856962;6022.5483088768515;6027.608205466719;6029.909551356734;6039.456448919531;6446.903296450557;6619.867602648016;6622.139121914121;6624.536282460182;6637.369449902251;6123.265208174958;6129.448349648553;6131.417515336036;6133.742582770521;6135.7852475164045;3490.1798077451776;3529.7529172957647;3537;3537.646235376442;3541.9291614168087;6621.768238111643;6740.528163028541;6758.7296508139125;6760.42536384403;6760.42536384403;6666.566673166229;6685.565438246498;6687;6741.191057073084;6782.93217067823;6727.831804204836;6740.224874139537;6741.59550426976;6742.190937087483;6750.1224840771365;6511.902321465276;6516.250631177475;6516.609003459807;6526;6526.216853977553;6264.31092579825;6396.808095757135;6415.3263907289065;6454.096426500388;6487.967560162169;6843.863122737617;6874.965625172043;6878.209005964378;6880.2431732508385;6890.069840571458;4500.482444518922;4553.157665831699;4559.270516717442;4563.908721825611;4566.634669226521;6636.668166591748;6638.83402914931;6651.268360480247;6652.501062420241;6656.101426307387;6356.300806911144;6447;6449.290578036318;6450.838729031811;6476.352364763675;6438.67806609677;6454.322296158835;6459.741610335534;6460.967695161494;6470.158879345655;6346.1432706585865;6351.68241587928;6359.109724638462;6361.491080713439;6362.913986716347;6427.678616069272;6449.806505804833;6468.8059358219325;6477;6484.902726459201;6020.4280593343565;6118.694065296806;6263.874722505433;6310.05349197624;6321.336259692666 16:13:53 INFO - PROCESS | 16292 | |5;yui.html;652.4714980865498;797.816502204493;803.5741057239661;817.8527864984308;821.9794505137374;13729.038967272294;13818.861811381883;13852.792208116874;13867.930660346685;13903.721925561495;12707.93646031771;12788.296643684595;12806.487740490393;12817.166884152546;12820.294883781387;668.3450218785594;768.4467183627779;779.166292067488;780.5472825761074;781.6677911887454;776.5651235308218;777.4829738224103;780.1963977103593;780.4731806030907;781.2539025230919;797.7646594254709;808.4138999225573;809.1908091908092;809.955452450115;811.0753740735566;716.9533980291264;789.4158322841114;796.24356860982;799.6321692021677;806.3670019035088;587.1369087441497;590.0294016343091;590.108935507387;591.5149577346577;591.5918016568597;12343.382830858422;12422;12434.129610927239;12438.253704777742;12451.937740311241;13118.147320424141;13812.585622431343;13918.652033699138;14322.212278324689;14453.277336133257;11599.246049006872;11679.357635330054;12008.759824803543;12124.151309408346;12833.67915802103;3818.1409182933894;3855.248226595815;3873.922521549553;3948.506436695413;3985.461962635065;52945.47054529444;52946.735266323805;53179.734101329246;53471;53552.73223633896;10499.94750026245;10600.416977066181;10641.946790266154;10653.78692426147;10698.51856666452;18225.088745562934;18249.90875045616;18299.26802927868;18324.54188645268;18331.908340458212;7658.693652253847;7716.7684969451;7776.183500732454;7845.607719613997;7854.410919181084;4419;4457.8216871324785;4486.439195100613;4521.8191272349395;4535.160995215896;3144.1039303798307;3205.7916235444623;3217.3886961477247;3238.9028329150165;3247.5453436518906;589.3340525206489;595.3659352789266;600.5165841497549;604.2567641800609;604.3714536881682;577.9739911703983;591.973361198747;626.4049153304379;670.4468813229106;704.4434896431864;7979.521228726295;8129.268365847102;8247.092819789817;8487.830243395221;8680.95659521711;621.4407033669643;638.6295948349946;645.3997782062632;658.4238791057825;668.3917634952268;3784.243151369737;3875.283072631516;3878.3019056569524;3895.8052097395016;3934.6655534279907;57166.42833571694;57576;58161.709191453774;58219;58445.41554584485;48964.51035489671;50143;50414;50682.74658626757;50873.745631272344;44632.330515042304;45103.32345014827;45449.54550454519;45742.313865292046;45879.77060114678;7634.236576342321;7775.028121484815;7863.724769633035;8000.4399692021;8098.947136872169;35165.64834351726;35433.29133417266;36102.63897360993;37249.81375093107;37558;42587.36118958156;43793.56206437895;45291;45758.313625296316;45858.77070614626;9277.814443710953;9395.24838012971;9667.178289845442;9704.320697551104;9726.36778609388;10320.948395257976;10438.739031524272;10817.188710846875;10925.235233533576;10953.452327383759;11091.389973551532;11102.61140860066;11238.66284011481;11772.882271177521;11937.28376297425;10866.293690910066;11338.829917551078;11586.13104017219;11875.584354547549;11885.940570297093;11157.72105697364;11244.606438774603;11311.095112391153;11868.109891758326;11953.402329883296;8706.521141337287;8889;8941.105889411007;9180.219681327162;9523.857142143012;9038.954805225932;9155.26757859383;9156.450612963243;9226.123518265755;9426.434413935185 16:13:53 INFO - PROCESS | 16292 | __end_tp_report 16:13:53 INFO - PROCESS | 16292 | __start_cc_report 16:13:53 INFO - PROCESS | 16292 | _x_x_mozilla_cycle_collect,886 16:13:53 INFO - PROCESS | 16292 | __end_cc_report 16:13:53 INFO - PROCESS | 16292 | __startTimestamp1460416433856__endTimestamp 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | ------- Summary: start ------- 16:13:53 INFO - PROCESS | 16292 | Number of tests: 6 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#0] dojo.html Cycles:165 Average:5414.76 Median:5614.52 stddev:584.04 (10.4%) stddev-sans-first:560.56 16:13:53 INFO - PROCESS | 16292 | Values: 3248.5 3321.9 3354.8 3356.9 3401.3 5412.0 5420.4 5423.2 5427.0 5478.9 5388.2 5433.2 5434.6 5443.6 5443.8 4878.9 4935.2 4994.5 5012.5 5046.2 4936.0 5038.3 5038.9 5041.0 5041.0 4955.7 4955.8 4960.4 4975.0 5038.3 5084.3 5090.7 5109.7 5114.7 5117.5 4804.2 4849.7 4975.6 4982.1 4996.7 5211.7 5214.1 5221.9 5225.0 5277.7 5681.0 5746.7 5777.4 5793.3 5795.4 5853.0 5862.6 5891.5 5892.6 5922.7 5492.1 5505.9 5508.0 5520.1 5533.6 5871.4 5875.0 5878.4 5907.5 5919.3 5726.0 5728.7 5734.6 5738.1 5738.7 5761.9 5776.9 5782.2 5784.0 5790.7 5618.3 5738.4 5770.7 5842.6 5851.4 5768.6 5790.1 5795.5 5796.0 5797.0 4389.4 4420.8 4425.8 4435.4 4456.4 3921.5 3989.6 4055.8 4071.7 4098.6 5458.3 5498.3 5502.7 5504.0 5509.3 5718.0 5854.3 5866.1 5869.6 5877.0 5432.6 5476.1 5496.3 5498.4 5539.1 5035.8 5038.2 5056.2 5060.2 5084.2 5965.2 6001.9 6052.6 6052.7 6054.2 5826.9 5895.9 5896.9 5902.3 5915.2 6073.4 6074.3 6074.8 6077.9 6084.2 5669.9 5694.1 5783.9 5793.7 5823.9 5765.7 5812.6 5819.4 5819.7 5835.6 5614.5 5659.2 5665.7 5673.1 5675.6 5596.9 5663.8 5698.3 5762.5 5763.9 5590.8 5596.1 5611.1 5625.1 5628.2 5715.1 5722.2 5724.7 5736.8 5739.6 5529.5 5539.8 5564.1 5626.1 5636.9 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#1] ext.html Cycles:180 Average:50694.36 Median:38031.71 stddev:87054.22 (228.9%) stddev-sans-first:87216.97 16:13:53 INFO - PROCESS | 16292 | Values: 534.0 559.9 562.6 606.8 616.5 29631.6 30210.0 30247.7 30276.4 37901.0 40803.0 41325.8 41326.8 41402.0 41569.2 8796.4 8998.0 9000.5 9002.5 9019.3 8724.3 8957.1 8958.0 8960.5 8967.5 8892.8 9186.6 9200.6 9200.9 9213.1 9111.8 9192.2 9202.7 9204.1 9206.8 9133.2 9273.4 9277.4 9284.1 9285.7 41110.8 41533.0 41585.2 41591.8 41601.8 3383.4 3499.2 3545.1 3995.5 4243.1 31045.1 31083.7 31109.7 31433.0 32661.2 4296.7 4300.0 4349.2 4383.9 4408.9 345105.0 347686.0 351441.0 352315.0 353430.0 57856.1 58228.1 58532.4 58562.7 58605.0 61315.0 66915.7 67851.3 67862.0 68071.0 15216.7 15294.5 15294.8 15313.4 15328.5 13200.9 13201.8 13277.1 13309.7 13315.8 19841.9 20556.6 20593.6 20707.8 20712.2 7380.1 7461.2 7621.8 7703.8 7855.9 886.7 972.5 981.9 1016.6 1044.3 29393.3 29700.4 29875.9 30068.5 30136.5 1055.7 1066.2 1156.0 1156.8 1211.8 15253.8 15258.6 15432.0 15566.3 15633.7 332384.0 335927.0 336620.0 337187.0 338656.0 51853.2 53319.5 53320.0 53413.5 53525.0 1234.4 1315.4 1325.0 1335.8 1352.3 27116.6 27417.3 31417.4 31545.8 34167.9 50327.0 50970.5 51008.7 51020.0 51043.2 304940.0 308940.0 311330.0 311475.0 312233.0 38018.4 46948.3 47345.3 48074.8 49054.5 44403.3 44730.8 44972.6 45605.3 45837.3 37124.4 38045.0 38360.8 38361.6 38811.0 36975.3 37463.1 37595.6 37761.6 37774.6 36611.6 37051.3 37747.0 37974.0 38169.2 33416.8 34285.7 34526.5 34653.9 34783.7 25836.7 26200.2 26250.6 26261.6 26416.7 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#2] jquery.html Cycles:180 Average:26981.89 Median:230279.16 stddev:78404.12 (34.0%) stddev-sans-first:78598.58 16:13:53 INFO - PROCESS | 16292 | Values: 358.7 362.4 363.6 364.8 376.7 17074.7 17555.3 19177.1 19187.3 19210.7 17009.2 17209.9 17431.4 17443.0 17501.0 5326.7 5554.5 5572.0 5573.7 5575.8 4189.3 5407.8 5667.3 5897.0 5911.6 5851.6 5859.4 5874.6 5878.8 5880.0 5691.7 5886.1 5944.4 5954.1 5978.0 3765.8 5000.5 5262.8 5303.6 5307.8 20621.5 20765.7 20869.8 21117.6 21153.4 2269.4 2347.6 2379.0 3065.5 3143.1 12253.9 13104.0 13552.1 13826.9 13891.8 1858.3 1915.6 1939.5 1994.8 2000.1 64566.7 66887.0 66997.7 67213.7 67252.7 9275.6 9355.3 9762.0 9828.6 9839.6 13492.0 13560.2 13562.7 13609.5 13614.5 8022.8 8055.3 8135.4 8177.3 8213.2 8153.1 8167.5 8300.6 8314.6 8337.0 5784.2 5891.1 5916.9 5954.7 5991.4 1665.4 1712.2 1740.8 1751.6 1764.2 942.7 991.4 996.8 1055.6 1069.3 15870.3 16077.4 16086.5 16265.0 16548.3 914.3 944.6 949.7 980.0 987.2 9387.7 9547.4 9571.7 9926.0 10059.1 456369.0 477675.0 480765.0 484354.0 492024.0 76286.2 77819.6 78061.6 78790.6 78930.0 1007.2 1010.6 1054.3 1068.5 1078.0 15365.8 15502.8 15524.3 15704.1 15859.2 34078.3 34717.0 35016.0 35297.0 35544.8 49396.8 49413.3 49453.8 50288.0 50485.7 6644.5 6678.1 6725.9 6837.9 6889.0 12382.6 13052.8 13197.3 13252.1 13350.0 11176.9 11444.9 11450.4 11568.1 11591.2 4691.7 8205.4 9558.9 11485.9 11541.1 11258.3 11277.5 11408.4 11446.5 11785.7 6446.2 6507.7 6709.9 6771.5 6912.2 8974.0 11483.4 11742.1 11747.8 11756.2 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#3] mootools.html Cycles:180 Average:5908.41 Median:5057.63 stddev:3172.91 (62.7%) stddev-sans-first:3163.18 16:13:53 INFO - PROCESS | 16292 | Values: 1334.1 1411.2 1442.0 1554.0 1710.7 7462.3 8149.9 8334.0 8376.7 8382.3 8413.3 8636.4 8664.7 8679.1 8681.7 2050.2 2351.4 2355.9 2370.4 2423.2 2405.8 2411.4 2420.4 2424.2 2426.3 2367.4 2432.2 2435.2 2436.7 2437.5 2102.9 2292.6 2323.0 2324.3 2325.9 2336.9 2341.7 2345.1 2345.8 2402.5 8447.5 8520.9 8521.6 8525.0 8527.5 4928.1 5033.1 5033.6 5041.4 5073.8 3182.5 3217.0 3263.4 3348.9 3377.8 1023.7 2039.9 2045.4 2065.6 2067.3 11791.9 11883.2 11929.1 11930.7 11942.6 4230.6 4297.9 4339.3 4356.7 4430.7 8958.3 9019.6 9022.6 9034.4 9041.5 4502.9 5173.3 5200.9 5206.3 5215.2 4673.7 4692.1 4732.8 4735.8 4747.5 3513.8 3573.4 3576.3 3625.2 3641.4 1039.8 1044.1 1052.0 1058.4 1059.6 1311.8 1312.0 1331.7 1344.8 1345.7 7586.5 7610.4 7681.0 7689.7 7706.1 479.6 487.3 489.3 489.9 508.2 6297.1 6299.0 6368.2 6410.4 6426.4 10423.3 10758.8 10772.9 10905.0 10919.3 10514.3 10647.3 10750.2 10751.4 10762.3 8188.2 8267.0 8276.0 8292.2 8358.5 7837.8 7920.8 7923.9 7953.9 7977.2 9490.5 9581.1 9655.2 9674.2 9733.9 9721.3 9827.8 9954.6 10019.2 10119.9 6248.8 6662.0 6781.7 7123.8 7255.0 8081.3 8082.0 8099.4 8131.7 8147.5 7155.5 7319.5 7397.6 7423.2 7465.9 7205.5 7215.9 7228.1 7229.3 7262.6 7404.0 7414.5 7460.2 7465.8 7469.2 7037.1 7051.0 7099.4 7104.5 7107.6 7259.4 7307.8 7324.9 7328.3 7331.0 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#4] prototype.html Cycles:180 Average:5330.81 Median:6047.46 stddev:1605.72 (26.6%) stddev-sans-first:1565.72 16:13:53 INFO - PROCESS | 16292 | Values: 328.7 333.1 336.0 337.2 340.2 5998.2 6055.5 6063.4 6080.6 6082.3 5972.5 5973.1 5984.6 5987.0 6000.6 4352.0 4485.4 4498.1 4579.2 4615.1 4624.0 4633.6 4636.9 4647.9 4649.3 4598.1 4600.9 4607.2 4609.1 4615.5 4330.6 4447.1 4496.8 4523.8 4533.4 4005.6 4016.0 4016.9 4020.5 4025.8 5699.9 5712.1 5713.5 5713.7 5724.9 5343.3 5349.7 5351.6 5352.3 5352.4 6261.1 6298.8 6316.2 6331.4 6332.7 4365.3 4447.0 4454.0 4460.2 4467.9 6561.0 6579.1 6583.7 6586.5 6599.4 4553.5 4555.2 4562.2 4566.7 4567.5 4616.8 4623.1 4627.4 4627.8 4630.5 5306.3 5309.2 5316.8 5319.5 5320.4 6216.4 6374.8 6377.3 6389.7 6391.3 1593.6 1621.9 1632.1 1639.2 1644.8 997.7 1081.3 1081.5 1083.1 1092.2 6010.0 6022.5 6027.6 6029.9 6039.5 6446.9 6619.9 6622.1 6624.5 6637.4 6123.3 6129.4 6131.4 6133.7 6135.8 3490.2 3529.8 3537.0 3537.6 3541.9 6621.8 6740.5 6758.7 6760.4 6760.4 6666.6 6685.6 6687.0 6741.2 6782.9 6727.8 6740.2 6741.6 6742.2 6750.1 6511.9 6516.3 6516.6 6526.0 6526.2 6264.3 6396.8 6415.3 6454.1 6488.0 6843.9 6875.0 6878.2 6880.2 6890.1 4500.5 4553.2 4559.3 4563.9 4566.6 6636.7 6638.8 6651.3 6652.5 6656.1 6356.3 6447.0 6449.3 6450.8 6476.4 6438.7 6454.3 6459.7 6461.0 6470.2 6346.1 6351.7 6359.1 6361.5 6362.9 6427.7 6449.8 6468.8 6477.0 6484.9 6020.4 6118.7 6263.9 6310.1 6321.3 16:13:53 INFO - PROCESS | 16292 | 16:13:53 INFO - PROCESS | 16292 | [#5] yui.html Cycles:180 Average:13897.66 Median:49553.76 stddev:16245.82 (32.8%) stddev-sans-first:16260.94 16:13:53 INFO - PROCESS | 16292 | Values: 652.5 797.8 803.6 817.9 822.0 13729.0 13818.9 13852.8 13867.9 13903.7 12707.9 12788.3 12806.5 12817.2 12820.3 668.3 768.4 779.2 780.5 781.7 776.6 777.5 780.2 780.5 781.3 797.8 808.4 809.2 810.0 811.1 717.0 789.4 796.2 799.6 806.4 587.1 590.0 590.1 591.5 591.6 12343.4 12422.0 12434.1 12438.3 12451.9 13118.1 13812.6 13918.7 14322.2 14453.3 11599.2 11679.4 12008.8 12124.2 12833.7 3818.1 3855.2 3873.9 3948.5 3985.5 52945.5 52946.7 53179.7 53471.0 53552.7 10499.9 10600.4 10641.9 10653.8 10698.5 18225.1 18249.9 18299.3 18324.5 18331.9 7658.7 7716.8 7776.2 7845.6 7854.4 4419.0 4457.8 4486.4 4521.8 4535.2 3144.1 3205.8 3217.4 3238.9 3247.5 589.3 595.4 600.5 604.3 604.4 578.0 592.0 626.4 670.4 704.4 7979.5 8129.3 8247.1 8487.8 8681.0 621.4 638.6 645.4 658.4 668.4 3784.2 3875.3 3878.3 3895.8 3934.7 57166.4 57576.0 58161.7 58219.0 58445.4 48964.5 50143.0 50414.0 50682.7 50873.7 44632.3 45103.3 45449.5 45742.3 45879.8 7634.2 7775.0 7863.7 8000.4 8098.9 35165.6 35433.3 36102.6 37249.8 37558.0 42587.4 43793.6 45291.0 45758.3 45858.8 9277.8 9395.2 9667.2 9704.3 9726.4 10320.9 10438.7 10817.2 10925.2 10953.5 11091.4 11102.6 11238.7 11772.9 11937.3 10866.3 11338.8 11586.1 11875.6 11885.9 11157.7 11244.6 11311.1 11868.1 11953.4 8706.5 8889.0 8941.1 9180.2 9523.9 9039.0 9155.3 9156.5 9226.1 9426.4 16:13:53 INFO - PROCESS | 16292 | -------- Summary: end -------- 16:13:53 INFO - PROCESS | 16292 | 16:13:54 INFO - TEST-INFO | 16292: exit 0 16:13:54 INFO - TEST-OK | dromaeo_css | took 1114393ms 16:13:54 INFO - TEST-START | kraken 16:13:54 INFO - operating with platform_type : linux_ 16:13:54 INFO - Initialising browser for kraken test... 16:13:54 INFO - TEST-INFO | started process 16490 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdU2_1h/profile http://localhost:51227/getInfo.html) 16:13:59 INFO - PROCESS | 16490 | __metrics Screen width/height:1600/1200 16:13:59 INFO - PROCESS | 16490 | colorDepth:24 16:13:59 INFO - PROCESS | 16490 | Browser inner width/height: 1024/697 16:13:59 INFO - PROCESS | 16490 | __metrics 16:14:01 INFO - PROCESS | 16490 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:02 INFO - TEST-INFO | 16490: exit 0 16:14:02 INFO - Browser initialized. 16:14:02 INFO - Running cycle 1/1 for kraken test... 16:14:02 INFO - TEST-INFO | started process 16579 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdU2_1h/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:14 INFO - PROCESS | 16579 | RSS: Main: 141787136 16:14:14 INFO - PROCESS | 16579 | 16:14:16 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51227/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:17 INFO - PROCESS | 16579 | RSS: Main: 177823744 16:14:17 INFO - PROCESS | 16579 | 16:14:19 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51227/tests/kraken/driver.html?testName=audio-dft) 16:14:20 INFO - PROCESS | 16579 | RSS: Main: 175726592 16:14:20 INFO - PROCESS | 16579 | 16:14:23 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51227/tests/kraken/driver.html?testName=audio-fft) 16:14:23 INFO - PROCESS | 16579 | RSS: Main: 172494848 16:14:23 INFO - PROCESS | 16579 | 16:14:25 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51227/tests/kraken/driver.html?testName=audio-oscillator) 16:14:26 INFO - PROCESS | 16579 | RSS: Main: 173391872 16:14:26 INFO - PROCESS | 16579 | 16:14:28 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51227/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:29 INFO - PROCESS | 16579 | RSS: Main: 170696704 16:14:29 INFO - PROCESS | 16579 | 16:14:32 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51227/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:32 INFO - PROCESS | 16579 | RSS: Main: 170860544 16:14:32 INFO - PROCESS | 16579 | 16:14:36 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51227/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:36 INFO - PROCESS | 16579 | RSS: Main: 171089920 16:14:36 INFO - PROCESS | 16579 | 16:14:39 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51227/tests/kraken/driver.html?testName=json-parse-financial) 16:14:39 INFO - PROCESS | 16579 | RSS: Main: 170864640 16:14:39 INFO - PROCESS | 16579 | 16:14:41 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51227/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:42 INFO - PROCESS | 16579 | RSS: Main: 176037888 16:14:42 INFO - PROCESS | 16579 | 16:14:43 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:44 INFO - PROCESS | 16579 | RSS: Main: 174100480 16:14:44 INFO - PROCESS | 16579 | 16:14:46 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:46 INFO - PROCESS | 16579 | RSS: Main: 179781632 16:14:46 INFO - PROCESS | 16579 | 16:14:49 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:49 INFO - PROCESS | 16579 | RSS: Main: 185270272 16:14:49 INFO - PROCESS | 16579 | 16:14:52 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:53 INFO - PROCESS | 16579 | RSS: Main: 185741312 16:14:53 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | Cycle 1(1): loaded http://localhost:51227/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51227/tests/kraken/driver.html?testName=ai-astar) 16:14:54 INFO - PROCESS | 16579 | RSS: Main: 248463360 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | __start_tp_report 16:14:54 INFO - PROCESS | 16579 | _x_x_mozilla_page_load 16:14:54 INFO - PROCESS | 16579 | _x_x_mozilla_page_load_details 16:14:54 INFO - PROCESS | 16579 | |i|pagename|runs| 16:14:54 INFO - PROCESS | 16579 | |0;ai-astar;110;109;104;110;109;109;98;109;108;110 16:14:54 INFO - PROCESS | 16579 | |1;audio-beat-detection;154;127;161;172;132;155;158;127;167;126 16:14:54 INFO - PROCESS | 16579 | |2;audio-dft;161;163;162;161;162;166;162;163;161;160 16:14:54 INFO - PROCESS | 16579 | |3;audio-fft;75;76;72;158;76;75;74;74;163;73 16:14:54 INFO - PROCESS | 16579 | |4;audio-oscillator;93;93;139;93;93;94;142;93;93;145 16:14:54 INFO - PROCESS | 16579 | |5;imaging-gaussian-blur;116;117;117;117;116;116;116;117;117;116 16:14:54 INFO - PROCESS | 16579 | |6;imaging-darkroom;145;145;145;145;146;146;145;145;145;145 16:14:54 INFO - PROCESS | 16579 | |7;imaging-desaturate;95;97;95;95;95;96;96;95;96;96 16:14:54 INFO - PROCESS | 16579 | |8;json-parse-financial;54;54;54;55;65;55;55;62;52;55 16:14:54 INFO - PROCESS | 16579 | |9;json-stringify-tinderbox;63;64;63;63;65;64;65;72;64;63 16:14:54 INFO - PROCESS | 16579 | |10;stanford-crypto-aes;77;78;79;79;79;78;78;79;78;78 16:14:54 INFO - PROCESS | 16579 | |11;stanford-crypto-ccm;116;112;112;114;113;123;112;114;116;111 16:14:54 INFO - PROCESS | 16579 | |12;stanford-crypto-pbkdf2;143;143;143;142;154;133;143;143;142;131 16:14:54 INFO - PROCESS | 16579 | |13;stanford-crypto-sha256-iterative;67;69;67;67;67;68;66;68;66;66 16:14:54 INFO - PROCESS | 16579 | __end_tp_report 16:14:54 INFO - PROCESS | 16579 | __start_cc_report 16:14:54 INFO - PROCESS | 16579 | _x_x_mozilla_cycle_collect,1072 16:14:54 INFO - PROCESS | 16579 | __end_cc_report 16:14:54 INFO - PROCESS | 16579 | __startTimestamp1460416494936__endTimestamp 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | ------- Summary: start ------- 16:14:54 INFO - PROCESS | 16579 | Number of tests: 14 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:3.81 (3.5%) stddev-sans-first:3.94 16:14:54 INFO - PROCESS | 16579 | Values: 110.0 109.0 104.0 110.0 109.0 109.0 98.0 109.0 108.0 110.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.50 stddev:17.99 (11.5%) stddev-sans-first:18.95 16:14:54 INFO - PROCESS | 16579 | Values: 154.0 127.0 161.0 172.0 132.0 155.0 158.0 127.0 167.0 126.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.66 (1.0%) stddev-sans-first:1.72 16:14:54 INFO - PROCESS | 16579 | Values: 161.0 163.0 162.0 161.0 162.0 166.0 162.0 163.0 161.0 160.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#3] audio-fft Cycles:10 Average:91.60 Median:74.50 stddev:36.35 (48.8%) stddev-sans-first:38.06 16:14:54 INFO - PROCESS | 16579 | Values: 75.0 76.0 72.0 158.0 76.0 75.0 74.0 74.0 163.0 73.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.64 (25.4%) stddev-sans-first:24.46 16:14:54 INFO - PROCESS | 16579 | Values: 93.0 93.0 139.0 93.0 93.0 94.0 142.0 93.0 93.0 145.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:14:54 INFO - PROCESS | 16579 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:14:54 INFO - PROCESS | 16579 | Values: 145.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 16:14:54 INFO - PROCESS | 16579 | Values: 95.0 97.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.00 stddev:4.07 (7.4%) stddev-sans-first:4.24 16:14:54 INFO - PROCESS | 16579 | Values: 54.0 54.0 54.0 55.0 65.0 55.0 55.0 62.0 52.0 55.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.00 stddev:2.72 (4.2%) stddev-sans-first:2.82 16:14:54 INFO - PROCESS | 16579 | Values: 63.0 64.0 63.0 63.0 65.0 64.0 65.0 72.0 64.0 63.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:0.67 (0.9%) stddev-sans-first:0.53 16:14:54 INFO - PROCESS | 16579 | Values: 77.0 78.0 79.0 79.0 79.0 78.0 78.0 79.0 78.0 78.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:3.66 16:14:54 INFO - PROCESS | 16579 | Values: 116.0 112.0 112.0 114.0 113.0 123.0 112.0 114.0 116.0 111.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.00 stddev:6.24 (4.4%) stddev-sans-first:6.60 16:14:54 INFO - PROCESS | 16579 | Values: 143.0 143.0 143.0 142.0 154.0 133.0 143.0 143.0 142.0 131.0 16:14:54 INFO - PROCESS | 16579 | 16:14:54 INFO - PROCESS | 16579 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 16:14:54 INFO - PROCESS | 16579 | Values: 67.0 69.0 67.0 67.0 67.0 68.0 66.0 68.0 66.0 66.0 16:14:54 INFO - PROCESS | 16579 | -------- Summary: end -------- 16:14:54 INFO - PROCESS | 16579 | 16:14:55 INFO - TEST-INFO | 16579: exit 0 16:14:55 INFO - TEST-OK | kraken | took 61224ms 16:14:55 INFO - SUITE-END | took 1175s 16:14:56 INFO - Completed test suite (00:19:35) 16:14:56 INFO - javascript benchmark 16:14:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3248.512723091537, 3321.8671253149873, 3354.8490317935675, 3356.8992930212103, 3401.302732939748, 5412.025835349636, 5420.430854760248, 5423.213634023069, 5427.0, 5478.945210547893, 5388.245645609618, 5433.1850222466555, 5434.592405569579, 5443.591730620199, 5443.8094666686675, 4878.902421951559, 4935.210366341377, 4994.475580064095, 5012.548870601645, 5046.192609182532, 4936.0, 5038.319826823368, 5038.899222015558, 5041.017001684673, 5041.04220198163, 4955.677880937727, 4955.826546070888, 4960.429550601691, 4975.0, 5038.345015148026, 5084.313617661605, 5090.669106508065, 5109.718965456898, 5114.693118412907, 5117.462666420047, 4804.23132298834, 4849.733264670442, 4975.601951843843, 4982.103221420143, 4996.7001979881325, 5211.687298762086, 5214.065293160088, 5221.869453263661, 5225.033368826779, 5277.7361131943635, 5680.971595142039, 5746.74139663712, 5777.364489906107, 5793.275840519935, 5795.449432303924, 5853.004989151812, 5862.589618726691, 5891.469767720926, 5892.646441213498, 5922.703864806743, 5492.093804522249, 5505.917411238835, 5508.0, 5520.144377621435, 5533.612647114664, 5871.383504732027, 5875.030619947661, 5878.441548052928, 5907.497862681635, 5919.289685237799, 5726.0, 5728.656280623176, 5734.569907256972, 5738.081906894877, 5738.68437235956, 5761.9135712964335, 5776.884462310814, 5782.161586569924, 5783.971080144656, 5790.739416726257, 5618.297712785902, 5738.397468265855, 5770.653760774367, 5842.649441033552, 5851.414858514115, 5768.596198266165, 5790.073588225948, 5795.478406943395, 5796.014677504834, 5796.971015144897, 4389.407429996973, 4420.823167073281, 4425.84509542171, 4435.379046933432, 4456.420665313489, 3921.450996860442, 3989.5611482736876, 4055.7769322686945, 4071.65635340337, 4098.610631989956, 5458.344998600114, 5498.340199176125, 5502.697351645618, 5503.972480137573, 5509.283793106871, 5717.971410143005, 5854.268216472941, 5866.090755932837, 5869.559783016291, 5877.0, 5432.619716619878, 5476.069068258405, 5496.258005169331, 5498.367687715964, 5539.058360078796, 5035.823746168867, 5038.193888977819, 5056.216286475602, 5060.240963855451, 5084.211947148198, 5965.194698715618, 6001.939980600138, 6052.576319657582, 6052.727627256784, 6054.182685337423, 5826.94173058264, 5895.911561326498, 5896.882062358814, 5902.321233058082, 5915.201447804491, 6073.423024812636, 6074.3318234994995, 6074.757009719739, 6077.908831367445, 6084.239470066242, 5669.943300566942, 5694.06048002075, 5783.913241301299, 5793.681347525927, 5823.854403639773, 5765.682887441063, 5812.564057695605, 5819.359870414166, 5819.738111784895, 5835.649861008353, 5614.522765564972, 5659.207710920392, 5665.688387138747, 5673.0639444492845, 5675.57433192504, 5596.86007849807, 5663.801766938137, 5698.344690360662, 5762.5389968801555, 5763.942360576509, 5590.832275031756, 5596.076647353141, 5611.102223644198, 5625.071863142535, 5628.155776633538, 5715.085586306171, 5722.227499287543, 5724.74238659253, 5736.799212027559, 5739.5695322850115, 5529.502344788988, 5539.833804985857, 5564.10974244119, 5626.127950167731, 5636.88726225465], "unit": "score", "name": "dojo.html", "value": 5378.0783525439865}, {"lowerIsBetter": false, "replicates": [533.9839804805857, 559.888022395521, 562.5879043600561, 606.8179546136158, 616.4575173847014, 29631.55552666709, 30210.0, 30247.69752302479, 30276.394472110573, 37901.0, 40803.0, 41325.79337103318, 41326.793366033206, 41402.0, 41569.16861662772, 8796.42823216492, 8997.95501022494, 9000.504972226558, 9002.54987250638, 9019.278457723367, 8724.302055835518, 8957.104289571023, 8957.95521022394, 8960.507172105532, 8967.506787126706, 8892.777680558005, 9186.632534698638, 9200.585973631169, 9200.907990920072, 9213.078692130766, 9111.772205694877, 9192.218661413788, 9202.677906273282, 9204.125608067223, 9206.815863682756, 9133.223675987549, 9273.443593384418, 9277.396969196981, 9284.118008789153, 9285.675001374988, 41110.794446027576, 41532.96167595804, 41585.1682966339, 41591.7920410399, 41601.79199103985, 3383.3571621391857, 3499.212677147647, 3545.131442796506, 3995.4805875236034, 4243.087736136746, 31045.0686479406, 31083.68916310853, 31109.68890311113, 31433.0, 32661.18347041319, 4296.6562674986235, 4300.0, 4349.151915376503, 4383.9342409863875, 4408.933865992013, 345105.0, 347686.0, 351441.0, 352315.0, 353430.0, 57856.13215801767, 58228.126578101364, 58532.41467585355, 58562.7071864638, 58605.0, 61315.0, 66915.66542167257, 67851.3214867845, 67862.0, 68071.0, 15216.695666086616, 15294.464693735667, 15294.770578441332, 15313.387464501518, 15328.463503777315, 13200.933995330153, 13201.801972970414, 13277.136986095873, 13309.667258318426, 13315.800262996063, 19841.900790496245, 20556.588868222552, 20593.58812823765, 20707.79292207059, 20712.171513139307, 7380.114386273682, 7461.232077800676, 7621.809454763676, 7703.768886933401, 7855.8821617675785, 886.6542048601051, 972.4505654305295, 981.9361741486781, 1016.5781200801732, 1044.3368461027303, 29393.265168370963, 29700.405991880474, 29875.850620746758, 30068.548971765442, 30136.54795178074, 1055.72551136705, 1066.1724409370397, 1155.9942200289113, 1156.7744289863565, 1211.836402085707, 15253.771193432107, 15258.618534536503, 15432.0, 15566.299516521784, 15633.687326253412, 332384.0, 335927.0, 336620.0, 337187.0, 338656.0, 51853.222201667006, 53319.46680533145, 53320.0, 53413.46586534085, 53525.0, 1234.4074844074894, 1315.3686230609362, 1324.9867501325057, 1335.7996300554994, 1352.2697743218946, 27116.593251100854, 27417.31456713598, 31417.37165256728, 31545.8422707885, 34167.89688004684, 50327.0, 50970.49029509806, 51008.74495627498, 51020.0, 51043.23435148402, 304940.0, 308940.0, 311330.0, 311475.0, 312233.0, 38018.429723553614, 46948.295775564075, 47345.289820652026, 48074.759626201645, 49054.50945490642, 44403.33394999013, 44730.77634611806, 44972.55027449683, 45605.315920261884, 45837.31244031409, 37124.443133352484, 38045.0, 38360.80819595996, 38361.616383835804, 38811.0, 36975.26049479049, 37463.063423414635, 37595.62404375921, 37761.62238377581, 37774.62225377821, 36611.63388366082, 37051.25897482089, 37747.0, 37974.0, 38169.23661526809, 33416.832915835264, 34285.657143428245, 34526.48210276798, 34653.9207647542, 34783.652163478044, 25836.741632583435, 26200.213993580222, 26250.606240906785, 26261.606075908494, 26416.73583264143], "unit": "score", "name": "ext.html", "value": 19429.92843281846}, {"lowerIsBetter": false, "replicates": [358.6843577651666, 362.3604338342824, 363.5855125157321, 364.8011833550715, 376.67417683703604, 17074.65850682987, 17555.297788088475, 19177.137028833702, 19187.32844350448, 19210.711839322423, 17009.2345844437, 17209.913950430262, 17431.389901353454, 17443.0, 17501.0, 5326.7070311132875, 5554.527865131468, 5572.0, 5573.749181286852, 5575.832725018256, 4189.329707246841, 5407.756650950717, 5667.263255776743, 5896.970515147418, 5911.556633252501, 5851.590388672795, 5859.384764599719, 5874.647521148745, 5878.823635290948, 5879.970600147015, 5691.686957217351, 5886.117082437626, 5944.405559444086, 5954.106883967396, 5978.0, 3765.7928813915223, 5000.499950005007, 5262.7631756571045, 5303.575713942875, 5307.761150748187, 20621.484462888548, 20765.68851467214, 20869.791302087087, 21117.5776484471, 21153.36539903805, 2269.3872654383226, 2347.5774360615083, 2379.0, 3065.478868592322, 3143.072793525915, 12253.853163754535, 13103.957530883916, 13552.051356405056, 13826.861731382658, 13891.79162312566, 1858.321712574914, 1915.5689969756831, 1939.4569520534274, 1994.7706013808452, 2000.1199472232172, 64566.67716661387, 66887.0, 66997.66501167463, 67213.66393168052, 67252.663736681, 9275.58259878307, 9355.29835262358, 9762.0, 9828.606855725691, 9839.606415743434, 13492.0, 13560.186388816703, 13562.728745425036, 13609.455621775216, 13614.523491677744, 8022.753628983894, 8055.275025247756, 8135.389845761473, 8177.345812334999, 8213.178682131738, 8153.1439198884445, 8167.469114507538, 8300.626471808782, 8314.584270786436, 8337.0, 5784.219130417424, 5891.116332550066, 5916.852078698067, 5954.702264886739, 5991.430814072656, 1665.383807991051, 1712.24661149094, 1740.7562941188244, 1751.6058886750634, 1764.2413762082429, 942.7407462947745, 991.3754334769194, 996.8006398720285, 1055.5988724284723, 1069.315637991686, 15870.285837137357, 16077.437289695039, 16086.517404477885, 16265.0, 16548.255328510248, 914.3142643017736, 944.551338114404, 949.6818565780541, 979.9706008819746, 987.2299606307092, 9387.718368448957, 9547.42715437076, 9571.707819444426, 9925.950370248247, 10059.144972677259, 456369.0, 477675.0, 480765.0, 484354.0, 492024.0, 76286.23713762792, 77819.61090194513, 78061.60969195118, 78790.60604696939, 78930.0, 1007.2294694558668, 1010.5503051142318, 1054.2672842374477, 1068.5031460370965, 1078.035158533124, 15365.769513457532, 15502.84497155014, 15524.30140643651, 15704.136272505122, 15859.207039647741, 34078.318433631684, 34717.0, 35016.0, 35297.0, 35544.82227588846, 49396.75301623469, 49413.25880111873, 49453.75273123611, 50287.994240115724, 50485.747571263375, 6644.468442524683, 6678.131842860591, 6725.865482690221, 6837.931620683729, 6888.965555172192, 12382.56661016896, 13052.804207936699, 13197.34013299312, 13252.072354935448, 13350.0, 11176.944115279372, 11444.885551144715, 11450.37022963745, 11568.13239007061, 11591.18861679708, 4691.741954192552, 8205.4409662164, 9558.904410955802, 11485.942570287429, 11541.076713862703, 11258.324500529994, 11277.492512837107, 11408.372539510407, 11446.484908179318, 11785.705357366134, 6446.226452825691, 6507.707153178213, 6709.899351509634, 6771.492138089565, 6912.239653638197, 8973.955130224307, 11483.425828708365, 11742.119341049627, 11747.765044698886, 11756.23584467007], "unit": "score", "name": "jquery.html", "value": 8687.772514759652}, {"lowerIsBetter": false, "replicates": [1334.0928168845182, 1411.2449839335954, 1441.9855801441988, 1553.9922300388496, 1710.6664200480911, 7462.253774622542, 8149.918500814997, 8334.0, 8376.664933402657, 8382.329413646909, 8413.284870785976, 8636.39545231834, 8664.696735614254, 8679.088695686956, 8681.696140635078, 2050.241410678051, 2351.3533778211, 2355.882205889707, 2370.4073981504625, 2423.2245681381964, 2405.7714517120844, 2411.445367565461, 2420.3586049696846, 2424.224248240555, 2426.296374051523, 2367.4318163640687, 2432.1609044879488, 2435.2450740270483, 2436.6954130733657, 2437.524682686877, 2102.8843413612244, 2292.64464008079, 2323.0, 2324.32594547581, 2325.9418514537188, 2336.883155842218, 2341.7424083350816, 2345.1323010486058, 2345.8006069484113, 2402.531506356261, 8447.535385553792, 8520.8721869172, 8521.573921303972, 8525.019622743403, 8527.530985795778, 4928.063667903087, 5033.144365457881, 5033.647644664875, 5041.445441001487, 5073.822416215452, 3182.5226216067545, 3216.9839150804332, 3263.4452143135723, 3348.8827891023698, 3377.7973321600784, 1023.687775228555, 2039.857209995301, 2045.3966080006435, 2065.6385132601736, 2067.266120527206, 11791.88208117925, 11883.227590206609, 11929.105317101164, 11930.701732456671, 11942.582009629621, 4230.61924426803, 4297.871063868089, 4339.34909763538, 4356.716813407118, 4430.712003719748, 8958.328125390623, 9019.639214431481, 9022.593983270768, 9034.36759426847, 9041.502717350477, 4502.909941801211, 5173.275741396207, 5200.947990520122, 5206.271122042917, 5215.217717342353, 4673.6728429009645, 4692.0850434165695, 4732.787024583902, 4735.810567577259, 4747.477777444478, 3513.789172649649, 3573.356795776733, 3576.338377400189, 3625.2386998730562, 3641.417373220325, 1039.8128336899279, 1044.1229367331478, 1051.984220236697, 1058.4125810175426, 1059.5814653212092, 1311.76388250114, 1311.9934400327936, 1331.7269959658247, 1344.7982802579495, 1345.7308538292184, 7586.468947173756, 7610.39116870649, 7681.039870016248, 7689.692412303557, 7706.07527096752, 479.60911856836566, 487.3323546740988, 489.2685435274288, 489.9436564795094, 508.1742168975415, 6297.149884765498, 6299.0, 6368.203974503187, 6410.358964103646, 6426.35736426363, 10423.270371073952, 10758.838617420744, 10772.892271077346, 10905.01854833053, 10919.344839309666, 10514.26400151982, 10647.30792498485, 10750.247482676294, 10751.408672523086, 10762.300450470695, 8188.222118898695, 8267.049289331684, 8276.006879174418, 8292.212239837207, 8358.498490090615, 7837.7648670539975, 7920.841583168189, 7923.920760792549, 7953.880691789744, 7977.162397948132, 9490.525473726148, 9581.089796469325, 9655.179309758749, 9674.226061915171, 9733.853992190265, 9721.319507634398, 9827.754306142404, 9954.55204515784, 10019.198464122706, 10119.949400252952, 6248.843778905563, 6661.966690166518, 6781.660916954034, 7123.786286411416, 7254.96372518134, 8081.313088387553, 8081.9595902022465, 8099.392545559224, 8131.715389961323, 8147.470414423044, 7155.534890232118, 7319.45104117204, 7397.556146631219, 7423.183449820407, 7465.925340746523, 7205.459590530626, 7215.891761623685, 7228.132624085143, 7229.349358557755, 7262.564246145248, 7403.962980185064, 7414.480986330905, 7460.216677248811, 7465.776026719207, 7469.178390376946, 7037.085178926707, 7051.048108505492, 7099.396551293198, 7104.467164962545, 7107.573545587281, 7259.419246460376, 7307.7807665770115, 7324.926750732638, 7328.303811137934, 7331.04696389466], "unit": "score", "name": "mootools.html", "value": 4739.815456571284}, {"lowerIsBetter": false, "replicates": [328.66640360034586, 333.1288680101534, 335.97648164628487, 337.1638336924428, 340.169985236024, 5998.190244317016, 6055.455009049185, 6063.393660633935, 6080.574359794816, 6082.270127584685, 5972.462478376945, 5973.133895585138, 5984.611000284989, 5987.042073268278, 6000.579959402833, 4352.0, 4485.394471746322, 4498.122866041123, 4579.152856721501, 4615.123126605942, 4624.0, 4633.582977532022, 4636.930446043295, 4647.907041859161, 4649.349091127245, 4598.126355992367, 4600.861974140781, 4607.216773148556, 4609.101225261075, 4615.515370886059, 4330.631896288819, 4447.11057788442, 4496.820127194908, 4523.819047238107, 4533.387992620987, 4005.639492445694, 4015.959840401588, 4016.879493615196, 4020.5175378954714, 4025.7584544927104, 5699.857503562403, 5712.057510510761, 5713.457221563945, 5713.685747283897, 5724.914126288109, 5343.305370301875, 5349.679019258857, 5351.57187425005, 5352.304200453916, 5352.384475785296, 6261.092141639482, 6298.842528936768, 6316.210473690789, 6331.398517140864, 6332.683365831736, 4365.301551751736, 4446.9777651111535, 4454.0, 4460.219461594241, 4467.888302792424, 6561.015847622847, 6579.111819904348, 6583.703733332011, 6586.506012049115, 6599.439047680905, 4553.521880202531, 4555.157295900269, 4562.1560011398, 4566.70316429431, 4567.543245675406, 4616.815327386867, 4623.098495793288, 4627.375304333939, 4627.814887404466, 4630.467496237909, 5306.310179676694, 5309.230161626542, 5316.813911513156, 5319.547838433777, 5320.388155362106, 6216.409441103088, 6374.808755737336, 6377.298497165308, 6389.6805159741825, 6391.265004524446, 1593.6414306781114, 1621.8945768525243, 1632.1023437109543, 1639.221369849312, 1644.777954976087, 997.7229146692246, 1081.2755453845941, 1081.4808891731855, 1083.1389045708681, 1092.2190633696946, 6010.038393856962, 6022.5483088768515, 6027.608205466719, 6029.909551356734, 6039.456448919531, 6446.903296450557, 6619.867602648016, 6622.139121914121, 6624.536282460182, 6637.369449902251, 6123.265208174958, 6129.448349648553, 6131.417515336036, 6133.742582770521, 6135.7852475164045, 3490.1798077451776, 3529.7529172957647, 3537.0, 3537.646235376442, 3541.9291614168087, 6621.768238111643, 6740.528163028541, 6758.7296508139125, 6760.42536384403, 6760.42536384403, 6666.566673166229, 6685.565438246498, 6687.0, 6741.191057073084, 6782.93217067823, 6727.831804204836, 6740.224874139537, 6741.59550426976, 6742.190937087483, 6750.1224840771365, 6511.902321465276, 6516.250631177475, 6516.609003459807, 6526.0, 6526.216853977553, 6264.31092579825, 6396.808095757135, 6415.3263907289065, 6454.096426500388, 6487.967560162169, 6843.863122737617, 6874.965625172043, 6878.209005964378, 6880.2431732508385, 6890.069840571458, 4500.482444518922, 4553.157665831699, 4559.270516717442, 4563.908721825611, 4566.634669226521, 6636.668166591748, 6638.83402914931, 6651.268360480247, 6652.501062420241, 6656.101426307387, 6356.300806911144, 6447.0, 6449.290578036318, 6450.838729031811, 6476.352364763675, 6438.67806609677, 6454.322296158835, 6459.741610335534, 6460.967695161494, 6470.158879345655, 6346.1432706585865, 6351.68241587928, 6359.109724638462, 6361.491080713439, 6362.913986716347, 6427.678616069272, 6449.806505804833, 6468.8059358219325, 6477.0, 6484.902726459201, 6020.4280593343565, 6118.694065296806, 6263.874722505433, 6310.05349197624, 6321.336259692666], "unit": "score", "name": "prototype.html", "value": 4806.5989874614315}, {"lowerIsBetter": false, "replicates": [652.4714980865498, 797.816502204493, 803.5741057239661, 817.8527864984308, 821.9794505137374, 13729.038967272294, 13818.861811381883, 13852.792208116874, 13867.930660346685, 13903.721925561495, 12707.93646031771, 12788.296643684595, 12806.487740490393, 12817.166884152546, 12820.294883781387, 668.3450218785594, 768.4467183627779, 779.166292067488, 780.5472825761074, 781.6677911887454, 776.5651235308218, 777.4829738224103, 780.1963977103593, 780.4731806030907, 781.2539025230919, 797.7646594254709, 808.4138999225573, 809.1908091908092, 809.955452450115, 811.0753740735566, 716.9533980291264, 789.4158322841114, 796.24356860982, 799.6321692021677, 806.3670019035088, 587.1369087441497, 590.0294016343091, 590.108935507387, 591.5149577346577, 591.5918016568597, 12343.382830858422, 12422.0, 12434.129610927239, 12438.253704777742, 12451.937740311241, 13118.147320424141, 13812.585622431343, 13918.652033699138, 14322.212278324689, 14453.277336133257, 11599.246049006872, 11679.357635330054, 12008.759824803543, 12124.151309408346, 12833.67915802103, 3818.1409182933894, 3855.248226595815, 3873.922521549553, 3948.506436695413, 3985.461962635065, 52945.47054529444, 52946.735266323805, 53179.734101329246, 53471.0, 53552.73223633896, 10499.94750026245, 10600.416977066181, 10641.946790266154, 10653.78692426147, 10698.51856666452, 18225.088745562934, 18249.90875045616, 18299.26802927868, 18324.54188645268, 18331.908340458212, 7658.693652253847, 7716.7684969451, 7776.183500732454, 7845.607719613997, 7854.410919181084, 4419.0, 4457.8216871324785, 4486.439195100613, 4521.8191272349395, 4535.160995215896, 3144.1039303798307, 3205.7916235444623, 3217.3886961477247, 3238.9028329150165, 3247.5453436518906, 589.3340525206489, 595.3659352789266, 600.5165841497549, 604.2567641800609, 604.3714536881682, 577.9739911703983, 591.973361198747, 626.4049153304379, 670.4468813229106, 704.4434896431864, 7979.521228726295, 8129.268365847102, 8247.092819789817, 8487.830243395221, 8680.95659521711, 621.4407033669643, 638.6295948349946, 645.3997782062632, 658.4238791057825, 668.3917634952268, 3784.243151369737, 3875.283072631516, 3878.3019056569524, 3895.8052097395016, 3934.6655534279907, 57166.42833571694, 57576.0, 58161.709191453774, 58219.0, 58445.41554584485, 48964.51035489671, 50143.0, 50414.0, 50682.74658626757, 50873.745631272344, 44632.330515042304, 45103.32345014827, 45449.54550454519, 45742.313865292046, 45879.77060114678, 7634.236576342321, 7775.028121484815, 7863.724769633035, 8000.4399692021, 8098.947136872169, 35165.64834351726, 35433.29133417266, 36102.63897360993, 37249.81375093107, 37558.0, 42587.36118958156, 43793.56206437895, 45291.0, 45758.313625296316, 45858.77070614626, 9277.814443710953, 9395.24838012971, 9667.178289845442, 9704.320697551104, 9726.36778609388, 10320.948395257976, 10438.739031524272, 10817.188710846875, 10925.235233533576, 10953.452327383759, 11091.389973551532, 11102.61140860066, 11238.66284011481, 11772.882271177521, 11937.28376297425, 10866.293690910066, 11338.829917551078, 11586.13104017219, 11875.584354547549, 11885.940570297093, 11157.72105697364, 11244.606438774603, 11311.095112391153, 11868.109891758326, 11953.402329883296, 8706.521141337287, 8889.0, 8941.105889411007, 9180.219681327162, 9523.857142143012, 9038.954805225932, 9155.26757859383, 9156.450612963243, 9226.123518265755, 9426.434413935185], "unit": "score", "name": "yui.html", "value": 6265.477253453782}], "name": "dromaeo_css", "value": 7113.768392206636}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 104.0, 110.0, 109.0, 109.0, 98.0, 109.0, 108.0, 110.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 161.0, 172.0, 132.0, 155.0, 158.0, 127.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 161.0, 162.0, 166.0, 162.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 72.0, 158.0, 76.0, 75.0, 74.0, 74.0, 163.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 93.0, 93.0, 94.0, 142.0, 93.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 54.0, 55.0, 65.0, 55.0, 55.0, 62.0, 52.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 64.0, 65.0, 72.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.3}, {"lowerIsBetter": true, "replicates": [116.0, 112.0, 112.0, 114.0, 113.0, 123.0, 112.0, 114.0, 116.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 143.0, 142.0, 154.0, 133.0, 143.0, 143.0, 142.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 67.0, 67.0, 68.0, 66.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1496.3999999999999}]} 16:14:56 INFO - Return code: 0 16:14:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:14:56 INFO - # TBPL SUCCESS # 16:14:56 INFO - Running post-action listener: _resource_record_post_action 16:14:56 INFO - Running post-run listener: _resource_record_post_run 16:14:57 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 494112768; Read time: 508; Write time: 1010308 16:14:57 INFO - install - Wall time: 16s; CPU: 18.0%; Read bytes: 0; Write bytes: 244977664; Read time: 0; Write time: 734040 16:14:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 249135104; Read time: 508; Write time: 276268 16:14:57 INFO - Running post-run listener: _upload_blobber_files 16:14:57 INFO - Blob upload gear active. 16:14:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:14:57 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:14:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:14:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:14:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:14:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:58 INFO - (blobuploader) - INFO - Done attempting. 16:14:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:14:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:59 INFO - (blobuploader) - INFO - Done attempting. 16:14:59 INFO - (blobuploader) - INFO - Iteration through files over. 16:14:59 INFO - Return code: 0 16:14:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:14:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:14:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ce204add36a8647a6c96a309db83f983d8bb4a127fce98afb5a87af735f97fb7c9f38a5467e4a42068732fa6875a6d1436d3de9835fb25397da88dabff8ecaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd0b65e23c99ccbdcf57acb73ab5acb1de119bd7ec9ed475572b3ed43934c5063d9f96b16b52627ab9df77d096f90a9c04806b293a88b1f55a607b0e243ed23d"} 16:14:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:14:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:14:59 INFO - Contents: 16:14:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ce204add36a8647a6c96a309db83f983d8bb4a127fce98afb5a87af735f97fb7c9f38a5467e4a42068732fa6875a6d1436d3de9835fb25397da88dabff8ecaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd0b65e23c99ccbdcf57acb73ab5acb1de119bd7ec9ed475572b3ed43934c5063d9f96b16b52627ab9df77d096f90a9c04806b293a88b1f55a607b0e243ed23d"} 16:14:59 INFO - Running post-run listener: copy_logs_to_upload_dir 16:14:59 INFO - Copying logs to upload dir... 16:14:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:14:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.526146 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-11 16:14:59.674397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 16:14:59.677564) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 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-Aurora/sha512/1ce204add36a8647a6c96a309db83f983d8bb4a127fce98afb5a87af735f97fb7c9f38a5467e4a42068732fa6875a6d1436d3de9835fb25397da88dabff8ecaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd0b65e23c99ccbdcf57acb73ab5acb1de119bd7ec9ed475572b3ed43934c5063d9f96b16b52627ab9df77d096f90a9c04806b293a88b1f55a607b0e243ed23d"} build_url:https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/ZKzJFQL_SYKgH5Jel0YTxg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ce204add36a8647a6c96a309db83f983d8bb4a127fce98afb5a87af735f97fb7c9f38a5467e4a42068732fa6875a6d1436d3de9835fb25397da88dabff8ecaa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd0b65e23c99ccbdcf57acb73ab5acb1de119bd7ec9ed475572b3ed43934c5063d9f96b16b52627ab9df77d096f90a9c04806b293a88b1f55a607b0e243ed23d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 16:14:59.704516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 16:14:59.704829) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460411177.774724-999509814 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 16:14:59.753644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 16:14:59.753946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 16:14:59.757270) ========= ========= Total master_lag: 0.36 =========