builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1456960985.48 results: success (0) buildid: 20160302124722 builduid: 51b451f0948547329e8addbdd0fef435 revision: 3a34e8b89130c938dd12596e3c6274d5fb994825 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.484292) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.484813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.485360) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006469 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.25 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.742855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.743169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.824784) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.825111) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.912823) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.913280) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.913681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:05.913992) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 15:23:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 60.6M=0s 2016-03-02 15:23:06 (60.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095853 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.096180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.096492) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018464 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.160787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.161122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a34e8b89130c938dd12596e3c6274d5fb994825 --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 3a34e8b89130c938dd12596e3c6274d5fb994825 --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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 15:23:06,335 truncating revision to first 12 chars 2016-03-02 15:23:06,335 Setting DEBUG logging. 2016-03-02 15:23:06,335 attempt 1/10 2016-03-02 15:23:06,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a34e8b89130?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 15:23:06,615 unpacking tar archive at: mozilla-aurora-3a34e8b89130/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.769577) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.769914) ========= echo 3a34e8b89130c938dd12596e3c6274d5fb994825 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3a34e8b89130c938dd12596e3c6274d5fb994825'] 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3a34e8b89130c938dd12596e3c6274d5fb994825 program finished with exit code 0 elapsedTime=0.004312 script_repo_revision: '3a34e8b89130c938dd12596e3c6274d5fb994825' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.825739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.826046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 15:23:06.839345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-02 15:23:06.839611) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:07 INFO - MultiFileLogger online at 20160302 15:23:07 in /builds/slave/test-pgo 15:23:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:23:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:23:07 INFO - {'append_to_log': False, 15:23:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:23:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:23:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:23:07 INFO - 'branch': 'Mozilla-Aurora', 15:23:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:07 INFO - 'config_files': ('talos/linux_config.py',), 15:23:07 INFO - 'default_actions': ('clobber', 15:23:07 INFO - 'read-buildbot-config', 15:23:07 INFO - 'download-and-extract', 15:23:07 INFO - 'populate-webroot', 15:23:07 INFO - 'create-virtualenv', 15:23:07 INFO - 'install', 15:23:07 INFO - 'run-tests'), 15:23:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:07 INFO - 'download_minidump_stackwalk': True, 15:23:07 INFO - 'download_symbols': 'ondemand', 15:23:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:07 INFO - 'installer_path': 'installer.exe', 15:23:07 INFO - 'log_level': 'info', 15:23:07 INFO - 'log_name': 'talos', 15:23:07 INFO - 'log_to_console': True, 15:23:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:07 INFO - 'opt_config_files': (), 15:23:07 INFO - 'pip_index': False, 15:23:07 INFO - 'sps_profile': False, 15:23:07 INFO - 'sps_profile_interval': 0, 15:23:07 INFO - 'suite': 'dromaeojs-e10s', 15:23:07 INFO - 'system_bits': '32', 15:23:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:07 INFO - 'title': 'talos-linux64-ix-010', 15:23:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:07 INFO - 'use_talos_json': True, 15:23:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:23:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:07 INFO - 'work_dir': 'build'} 15:23:07 INFO - ##### 15:23:07 INFO - ##### Running clobber step. 15:23:07 INFO - ##### 15:23:07 INFO - Running pre-action listener: _resource_record_pre_action 15:23:07 INFO - Running main action method: clobber 15:23:07 INFO - rmtree: /builds/slave/test-pgo/build 15:23:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:23:08 INFO - Running post-action listener: _resource_record_post_action 15:23:08 INFO - ##### 15:23:08 INFO - ##### Running read-buildbot-config step. 15:23:08 INFO - ##### 15:23:08 INFO - Running pre-action listener: _resource_record_pre_action 15:23:08 INFO - Running main action method: read_buildbot_config 15:23:08 INFO - Using buildbot properties: 15:23:08 INFO - { 15:23:08 INFO - "project": "", 15:23:08 INFO - "product": "firefox", 15:23:08 INFO - "script_repo_revision": "production", 15:23:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:23:08 INFO - "repository": "", 15:23:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:23:08 INFO - "buildid": "20160302124722", 15:23:08 INFO - "pgo_build": "True", 15:23:08 INFO - "basedir": "/builds/slave/test-pgo", 15:23:08 INFO - "buildnumber": 103, 15:23:08 INFO - "slavename": "talos-linux64-ix-010", 15:23:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:23:08 INFO - "platform": "ubuntu64_hw", 15:23:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:23:08 INFO - "branch": "mozilla-aurora", 15:23:08 INFO - "repo_path": "releases/mozilla-aurora", 15:23:08 INFO - "revision": "3a34e8b89130c938dd12596e3c6274d5fb994825", 15:23:08 INFO - "stage_platform": "linux64-pgo", 15:23:08 INFO - "builduid": "51b451f0948547329e8addbdd0fef435", 15:23:08 INFO - "slavebuilddir": "test" 15:23:08 INFO - } 15:23:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 15:23:08 INFO - Running post-action listener: _resource_record_post_action 15:23:08 INFO - ##### 15:23:08 INFO - ##### Running download-and-extract step. 15:23:08 INFO - ##### 15:23:08 INFO - Running pre-action listener: _resource_record_pre_action 15:23:08 INFO - Running main action method: download_and_extract 15:23:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:23:08 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:23:08 INFO - https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/test_packages.json 15:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/test_packages.json 15:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:23:10 INFO - Downloaded 1448 bytes. 15:23:10 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:23:10 INFO - Using the following test package requirements: 15:23:10 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:23:10 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:23:10 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:23:10 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'jsshell-linux-x86_64.zip'], 15:23:10 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:23:10 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:23:10 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:23:10 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:23:10 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:23:10 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:23:10 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:23:10 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:23:10 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:23:10 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:23:10 INFO - https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:11 INFO - Downloaded 23089483 bytes. 15:23:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:23:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:23:12 INFO - Return code: 0 15:23:12 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:23:12 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:23:12 INFO - https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:23:14 INFO - Downloaded 23089483 bytes. 15:23:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:23:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:23:16 INFO - Return code: 0 15:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:16 INFO - https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:23:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:23:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:23:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:23:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:23:17 INFO - Downloaded 10706668 bytes. 15:23:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:23:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:23:18 INFO - Return code: 0 15:23:18 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:23:18 INFO - https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:23:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:23:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:23:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:23:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:23:19 INFO - Downloaded 59963329 bytes. 15:23:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:23:19 INFO - mkdir: /builds/slave/test-pgo/properties 15:23:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:23:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:23:19 INFO - Contents: 15:23:19 INFO - build_url:https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:23:20 INFO - Running post-action listener: _resource_record_post_action 15:23:20 INFO - Running post-action listener: set_extra_try_arguments 15:23:20 INFO - ##### 15:23:20 INFO - ##### Running populate-webroot step. 15:23:20 INFO - ##### 15:23:20 INFO - Running pre-action listener: _resource_record_pre_action 15:23:20 INFO - Running main action method: populate_webroot 15:23:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:20 INFO - '--tppagecycles', 15:23:20 INFO - '7'], 15:23:20 INFO - 'tests': ['tsvgm']}}, 15:23:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:23:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:23:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:23:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'tests': ['damp', 'tps']}, 15:23:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['damp', 'tps']}, 15:23:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:23:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:20 INFO - 'other': {'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'other_l64': {'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'other_nol64': {'tests': ['a11yr', 15:23:20 INFO - 'ts_paint', 15:23:20 INFO - 'tpaint', 15:23:20 INFO - 'sessionrestore', 15:23:20 INFO - 'sessionrestore_no_auto_restore']}, 15:23:20 INFO - 'svgr': {'tests': ['tsvgx', 15:23:20 INFO - 'tsvgr_opacity', 15:23:20 INFO - 'tart', 15:23:20 INFO - 'tscrollx', 15:23:20 INFO - 'cart']}, 15:23:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['tsvgx', 15:23:20 INFO - 'tsvgr_opacity', 15:23:20 INFO - 'tart', 15:23:20 INFO - 'tscrollx', 15:23:20 INFO - 'cart']}, 15:23:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'tests': ['tp5o']}, 15:23:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'talos_options': ['--e10s'], 15:23:20 INFO - 'tests': ['tp5o']}, 15:23:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'talos_options': ['--xperf_path', 15:23:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:20 INFO - 'tests': ['tp5n']}, 15:23:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:23:20 INFO - 'talos_options': ['--e10s', 15:23:20 INFO - '--xperf_path', 15:23:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:20 INFO - 'tests': ['tp5n']}}, 15:23:20 INFO - 'talos.zip': {'path': '', 15:23:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:20 INFO - Running post-action listener: _resource_record_post_action 15:23:20 INFO - ##### 15:23:20 INFO - ##### Running create-virtualenv step. 15:23:20 INFO - ##### 15:23:20 INFO - Running pre-action listener: _resource_record_pre_action 15:23:20 INFO - Running main action method: create_virtualenv 15:23:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:23:20 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:23:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:23:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:20 INFO - Using real prefix '/usr' 15:23:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:23:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:23 INFO - Installing pip.................done. 15:23:23 INFO - Return code: 0 15:23:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:23 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:23:23 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:23:23 INFO - Using env: {'DISPLAY': ':0', 15:23:23 INFO - 'HOME': '/home/cltbld', 15:23:23 INFO - 'LANG': 'en_US.UTF-8', 15:23:23 INFO - 'LANGUAGE': 'en_US:en', 15:23:23 INFO - 'LOGNAME': 'cltbld', 15:23:23 INFO - 'MAIL': '/var/mail/cltbld', 15:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:23 INFO - 'MOZ_NO_REMOTE': '1', 15:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:23 INFO - 'NO_EM_RESTART': '1', 15:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:23 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:23 INFO - 'SHELL': '/bin/bash', 15:23:23 INFO - 'SHLVL': '1', 15:23:23 INFO - 'TERM': 'linux', 15:23:23 INFO - 'TMOUT': '86400', 15:23:23 INFO - 'USER': 'cltbld', 15:23:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:23 INFO - '_': '/tools/buildbot/bin/python'} 15:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:23 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:23:23 INFO - Cleaning up... 15:23:23 INFO - Return code: 0 15:23:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:23 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:23 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:23:23 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:23:23 INFO - Using env: {'DISPLAY': ':0', 15:23:23 INFO - 'HOME': '/home/cltbld', 15:23:23 INFO - 'LANG': 'en_US.UTF-8', 15:23:23 INFO - 'LANGUAGE': 'en_US:en', 15:23:23 INFO - 'LOGNAME': 'cltbld', 15:23:23 INFO - 'MAIL': '/var/mail/cltbld', 15:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:23 INFO - 'MOZ_NO_REMOTE': '1', 15:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:23 INFO - 'NO_EM_RESTART': '1', 15:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:23 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:23 INFO - 'SHELL': '/bin/bash', 15:23:23 INFO - 'SHLVL': '1', 15:23:23 INFO - 'TERM': 'linux', 15:23:23 INFO - 'TMOUT': '86400', 15:23:23 INFO - 'USER': 'cltbld', 15:23:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:23 INFO - '_': '/tools/buildbot/bin/python'} 15:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:23 INFO - Downloading/unpacking psutil>=0.7.1 15:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:25 INFO - Installing collected packages: psutil 15:23:25 INFO - Running setup.py install for psutil 15:23:25 INFO - building 'psutil._psutil_linux' extension 15:23:25 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:23:25 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:23:25 INFO - building 'psutil._psutil_posix' extension 15:23:25 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:23:25 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:23:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:25 INFO - Successfully installed psutil 15:23:25 INFO - Cleaning up... 15:23:25 INFO - Return code: 0 15:23:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:23: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:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:26 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:26 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:23:26 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:23:26 INFO - Using env: {'DISPLAY': ':0', 15:23:26 INFO - 'HOME': '/home/cltbld', 15:23:26 INFO - 'LANG': 'en_US.UTF-8', 15:23:26 INFO - 'LANGUAGE': 'en_US:en', 15:23:26 INFO - 'LOGNAME': 'cltbld', 15:23:26 INFO - 'MAIL': '/var/mail/cltbld', 15:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:26 INFO - 'MOZ_NO_REMOTE': '1', 15:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:26 INFO - 'NO_EM_RESTART': '1', 15:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:26 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:26 INFO - 'SHELL': '/bin/bash', 15:23:26 INFO - 'SHLVL': '1', 15:23:26 INFO - 'TERM': 'linux', 15:23:26 INFO - 'TMOUT': '86400', 15:23:26 INFO - 'USER': 'cltbld', 15:23:26 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:26 INFO - '_': '/tools/buildbot/bin/python'} 15:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:26 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:23:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:23:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:28 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:23:28 INFO - Installing collected packages: mozsystemmonitor 15:23:28 INFO - Running setup.py install for mozsystemmonitor 15:23:28 INFO - Successfully installed mozsystemmonitor 15:23:28 INFO - Cleaning up... 15:23:28 INFO - Return code: 0 15:23:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:23:28 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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:28 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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:28 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:28 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:23:28 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:23:28 INFO - Using env: {'DISPLAY': ':0', 15:23:28 INFO - 'HOME': '/home/cltbld', 15:23:28 INFO - 'LANG': 'en_US.UTF-8', 15:23:28 INFO - 'LANGUAGE': 'en_US:en', 15:23:28 INFO - 'LOGNAME': 'cltbld', 15:23:28 INFO - 'MAIL': '/var/mail/cltbld', 15:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:28 INFO - 'MOZ_NO_REMOTE': '1', 15:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:28 INFO - 'NO_EM_RESTART': '1', 15:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:28 INFO - 'SHELL': '/bin/bash', 15:23:28 INFO - 'SHLVL': '1', 15:23:28 INFO - 'TERM': 'linux', 15:23:28 INFO - 'TMOUT': '86400', 15:23:28 INFO - 'USER': 'cltbld', 15:23:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:28 INFO - '_': '/tools/buildbot/bin/python'} 15:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:28 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:23:30 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:23:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:30 INFO - Downloading docopt-0.6.1.tar.gz 15:23:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:31 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:31 INFO - Running setup.py install for blobuploader 15:23:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:31 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:23:31 INFO - Running setup.py install for requests 15:23:31 INFO - Running setup.py install for docopt 15:23:31 INFO - Successfully installed blobuploader requests docopt 15:23:31 INFO - Cleaning up... 15:23:31 INFO - Return code: 0 15:23:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:31 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:31 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:23:31 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:23:31 INFO - Using env: {'DISPLAY': ':0', 15:23:31 INFO - 'HOME': '/home/cltbld', 15:23:31 INFO - 'LANG': 'en_US.UTF-8', 15:23:31 INFO - 'LANGUAGE': 'en_US:en', 15:23:31 INFO - 'LOGNAME': 'cltbld', 15:23:31 INFO - 'MAIL': '/var/mail/cltbld', 15:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:31 INFO - 'MOZ_NO_REMOTE': '1', 15:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:31 INFO - 'NO_EM_RESTART': '1', 15:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:31 INFO - 'SHELL': '/bin/bash', 15:23:31 INFO - 'SHLVL': '1', 15:23:31 INFO - 'TERM': 'linux', 15:23:31 INFO - 'TMOUT': '86400', 15:23:31 INFO - 'USER': 'cltbld', 15:23:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:31 INFO - '_': '/tools/buildbot/bin/python'} 15:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:23:31 INFO - Running setup.py (path:/tmp/pip-zEk_XN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:23:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:23:31 INFO - Running setup.py (path:/tmp/pip-JdyH9k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:23:32 INFO - Running setup.py (path:/tmp/pip-tZBbit-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:23:32 INFO - Running setup.py (path:/tmp/pip-qQZpVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:23:32 INFO - Running setup.py (path:/tmp/pip-_G_q9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:23:32 INFO - Running setup.py (path:/tmp/pip-TrbKux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:23:32 INFO - Running setup.py (path:/tmp/pip-f2ONg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:23:32 INFO - Running setup.py (path:/tmp/pip-PMKGaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:23:32 INFO - Running setup.py (path:/tmp/pip-CqgVCC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:23:32 INFO - Running setup.py (path:/tmp/pip-Fs8Ywi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:23:32 INFO - Running setup.py (path:/tmp/pip-eJhLed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:23:32 INFO - Running setup.py (path:/tmp/pip-XgW33V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:23:32 INFO - Running setup.py (path:/tmp/pip-pvHVRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:23:32 INFO - Running setup.py (path:/tmp/pip-afnOyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:23:32 INFO - Running setup.py (path:/tmp/pip-hvteyc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:23:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:23:32 INFO - Running setup.py (path:/tmp/pip-eaQyyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:23:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:23:33 INFO - Running setup.py (path:/tmp/pip-AKNark-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:23:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:23:33 INFO - Running setup.py install for manifestparser 15:23:33 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Running setup.py install for mozcrash 15:23:33 INFO - Running setup.py install for mozdebug 15:23:33 INFO - Running setup.py install for mozdevice 15:23:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Running setup.py install for mozfile 15:23:33 INFO - Running setup.py install for mozhttpd 15:23:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Running setup.py install for mozinfo 15:23:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Running setup.py install for mozInstall 15:23:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:23:33 INFO - Running setup.py install for mozleak 15:23:33 INFO - Running setup.py install for mozlog 15:23:34 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Running setup.py install for moznetwork 15:23:34 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Running setup.py install for mozprocess 15:23:34 INFO - Running setup.py install for mozprofile 15:23:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Running setup.py install for mozrunner 15:23:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Running setup.py install for mozscreenshot 15:23:34 INFO - Running setup.py install for moztest 15:23:34 INFO - Running setup.py install for mozversion 15:23:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:23:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:23:34 INFO - Cleaning up... 15:23:34 INFO - Return code: 0 15:23:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:23:34 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:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:34 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:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:34 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:34 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:23:34 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:23:34 INFO - Using env: {'DISPLAY': ':0', 15:23:34 INFO - 'HOME': '/home/cltbld', 15:23:34 INFO - 'LANG': 'en_US.UTF-8', 15:23:34 INFO - 'LANGUAGE': 'en_US:en', 15:23:34 INFO - 'LOGNAME': 'cltbld', 15:23:34 INFO - 'MAIL': '/var/mail/cltbld', 15:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:34 INFO - 'MOZ_NO_REMOTE': '1', 15:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:34 INFO - 'NO_EM_RESTART': '1', 15:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:34 INFO - 'SHELL': '/bin/bash', 15:23:34 INFO - 'SHLVL': '1', 15:23:34 INFO - 'TERM': 'linux', 15:23:34 INFO - 'TMOUT': '86400', 15:23:34 INFO - 'USER': 'cltbld', 15:23:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:34 INFO - '_': '/tools/buildbot/bin/python'} 15:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:23:35 INFO - Running setup.py (path:/tmp/pip-kz2u9F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:23:35 INFO - Running setup.py (path:/tmp/pip-PuacGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:23:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:23:35 INFO - Running setup.py (path:/tmp/pip-f7c2Up-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:23:35 INFO - Running setup.py (path:/tmp/pip-ogfX3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:23:35 INFO - Running setup.py (path:/tmp/pip-W3GWSW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:23:35 INFO - Running setup.py (path:/tmp/pip-TumWvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:23:35 INFO - Running setup.py (path:/tmp/pip-rReU6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:23:35 INFO - Running setup.py (path:/tmp/pip-IKEBwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:23:35 INFO - Running setup.py (path:/tmp/pip-opPEVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:23:35 INFO - Running setup.py (path:/tmp/pip-yMs0pF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:23:35 INFO - Running setup.py (path:/tmp/pip-X240za-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:23:35 INFO - Running setup.py (path:/tmp/pip-lb_ud6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:23:35 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:23:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:23:35 INFO - Running setup.py (path:/tmp/pip-snlKeW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:23:36 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:23:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:23:36 INFO - Running setup.py (path:/tmp/pip-jeoyxW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:23:36 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:23:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:23:36 INFO - Running setup.py (path:/tmp/pip-kZ5PGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:23:36 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:23:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:23:36 INFO - Running setup.py (path:/tmp/pip-1zrhck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:23:36 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:23:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:23:36 INFO - Running setup.py (path:/tmp/pip-djzNFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:23:36 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:23:36 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:23:36 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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:23:36 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:23:36 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:23:36 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:23:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:36 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:23:38 INFO - Downloading blessings-1.6.tar.gz 15:23:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:23:38 INFO - Installing collected packages: blessings 15:23:38 INFO - Running setup.py install for blessings 15:23:38 INFO - Successfully installed blessings 15:23:38 INFO - Cleaning up... 15:23:38 INFO - Return code: 0 15:23:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:23:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:23:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:23:38 INFO - Reading from file tmpfile_stdout 15:23:38 INFO - Current package versions: 15:23:38 INFO - argparse == 1.2.1 15:23:38 INFO - blessings == 1.6 15:23:38 INFO - blobuploader == 1.2.4 15:23:38 INFO - docopt == 0.6.1 15:23:38 INFO - manifestparser == 1.1 15:23:38 INFO - mozInstall == 1.12 15:23:38 INFO - mozcrash == 0.16 15:23:38 INFO - mozdebug == 0.1 15:23:38 INFO - mozdevice == 0.48 15:23:38 INFO - mozfile == 1.2 15:23:38 INFO - mozhttpd == 0.7 15:23:38 INFO - mozinfo == 0.9 15:23:38 INFO - mozleak == 0.1 15:23:38 INFO - mozlog == 3.1 15:23:38 INFO - moznetwork == 0.27 15:23:38 INFO - mozprocess == 0.22 15:23:38 INFO - mozprofile == 0.28 15:23:38 INFO - mozrunner == 6.11 15:23:38 INFO - mozscreenshot == 0.1 15:23:38 INFO - mozsystemmonitor == 0.0 15:23:38 INFO - moztest == 0.7 15:23:38 INFO - mozversion == 1.4 15:23:38 INFO - psutil == 3.1.1 15:23:38 INFO - requests == 1.2.3 15:23:38 INFO - wsgiref == 0.1.2 15:23:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:38 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:38 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:23:38 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:23:38 INFO - Using env: {'DISPLAY': ':0', 15:23:38 INFO - 'HOME': '/home/cltbld', 15:23:38 INFO - 'LANG': 'en_US.UTF-8', 15:23:38 INFO - 'LANGUAGE': 'en_US:en', 15:23:38 INFO - 'LOGNAME': 'cltbld', 15:23:38 INFO - 'MAIL': '/var/mail/cltbld', 15:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:38 INFO - 'MOZ_NO_REMOTE': '1', 15:23:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:38 INFO - 'NO_EM_RESTART': '1', 15:23:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:38 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:38 INFO - 'SHELL': '/bin/bash', 15:23:38 INFO - 'SHLVL': '1', 15:23:38 INFO - 'TERM': 'linux', 15:23:38 INFO - 'TMOUT': '86400', 15:23:38 INFO - 'USER': 'cltbld', 15:23:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:38 INFO - '_': '/tools/buildbot/bin/python'} 15:23:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 INFO - Cleaning up... 15:23:39 INFO - Return code: 0 15:23:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:39 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 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23:39 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:23:39 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:23:39 INFO - Using env: {'DISPLAY': ':0', 15:23:39 INFO - 'HOME': '/home/cltbld', 15:23:39 INFO - 'LANG': 'en_US.UTF-8', 15:23:39 INFO - 'LANGUAGE': 'en_US:en', 15:23:39 INFO - 'LOGNAME': 'cltbld', 15:23:39 INFO - 'MAIL': '/var/mail/cltbld', 15:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:39 INFO - 'MOZ_NO_REMOTE': '1', 15:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:39 INFO - 'NO_EM_RESTART': '1', 15:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:39 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:39 INFO - 'SHELL': '/bin/bash', 15:23:39 INFO - 'SHLVL': '1', 15:23:39 INFO - 'TERM': 'linux', 15:23:39 INFO - 'TMOUT': '86400', 15:23:39 INFO - 'USER': 'cltbld', 15:23:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:39 INFO - '_': '/tools/buildbot/bin/python'} 15:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:39 INFO - Downloading/unpacking jsonschema 15:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:39 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:23:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:23:41 INFO - Downloading/unpacking functools32 (from jsonschema) 15:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:41 INFO - Downloading functools32-3.2.3-2.tar.gz 15:23:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:23:41 INFO - warning: no files found matching '*.txt' 15:23:41 INFO - no previously-included directories found matching 'build' 15:23:41 INFO - no previously-included directories found matching 'dist' 15:23:41 INFO - no previously-included directories found matching '.git*' 15:23:41 INFO - Installing collected packages: jsonschema, functools32 15:23:41 INFO - Running setup.py install for functools32 15:23:41 INFO - warning: no files found matching '*.txt' 15:23:41 INFO - no previously-included directories found matching 'build' 15:23:41 INFO - no previously-included directories found matching 'dist' 15:23:41 INFO - no previously-included directories found matching '.git*' 15:23:41 INFO - Successfully installed jsonschema functools32 15:23:41 INFO - Cleaning up... 15:23:41 INFO - Return code: 0 15:23:41 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:23: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:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb51df2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c47230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, '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': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', '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:23: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', 'flake8'] in /builds/slave/test-pgo/build 15:23: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 flake8 15:23:41 INFO - Using env: {'DISPLAY': ':0', 15:23:41 INFO - 'HOME': '/home/cltbld', 15:23:41 INFO - 'LANG': 'en_US.UTF-8', 15:23:41 INFO - 'LANGUAGE': 'en_US:en', 15:23:41 INFO - 'LOGNAME': 'cltbld', 15:23:41 INFO - 'MAIL': '/var/mail/cltbld', 15:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:41 INFO - 'MOZ_NO_REMOTE': '1', 15:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:41 INFO - 'NO_EM_RESTART': '1', 15:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:23:41 INFO - 'PWD': '/builds/slave/test-pgo', 15:23:41 INFO - 'SHELL': '/bin/bash', 15:23:41 INFO - 'SHLVL': '1', 15:23:41 INFO - 'TERM': 'linux', 15:23:41 INFO - 'TMOUT': '86400', 15:23:41 INFO - 'USER': 'cltbld', 15:23:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:41 INFO - '_': '/tools/buildbot/bin/python'} 15:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:41 INFO - Downloading/unpacking flake8 15:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:23:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:23:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:23:44 INFO - no previously-included directories found matching 'docs/_build' 15:23:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:23:44 INFO - Running setup.py install for pep8 15:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:23:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:23:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:23:44 INFO - no previously-included directories found matching 'docs/_build' 15:23:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:23:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:23:44 INFO - Cleaning up... 15:23:44 INFO - Return code: 0 15:23:44 INFO - Running post-action listener: _resource_record_post_action 15:23:44 INFO - Running post-action listener: _start_resource_monitoring 15:23:44 INFO - Starting resource monitoring. 15:23:44 INFO - ##### 15:23:44 INFO - ##### Running install step. 15:23:44 INFO - ##### 15:23:44 INFO - Running pre-action listener: _resource_record_pre_action 15:23:44 INFO - Running main action method: install 15:23:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:23:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:23:44 INFO - Reading from file tmpfile_stdout 15:23:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:23:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:23:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:23:44 INFO - Reading from file tmpfile_stdout 15:23:44 INFO - Output received: 15:23:44 INFO - Usage: mozinstall [options] installer 15:23:44 INFO - Options: 15:23:44 INFO - -h, --help show this help message and exit 15:23:44 INFO - -d DEST, --destination=DEST 15:23:44 INFO - Directory to install application into. [default: 15:23:44 INFO - "/builds/slave/test-pgo"] 15:23:44 INFO - --app=APP Application being installed. [default: firefox] 15:23:44 INFO - mkdir: /builds/slave/test-pgo/build/application 15:23:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:23:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:23:59 INFO - Reading from file tmpfile_stdout 15:23:59 INFO - Output received: 15:23:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:23:59 INFO - Running post-action listener: _resource_record_post_action 15:23:59 INFO - ##### 15:23:59 INFO - ##### Running run-tests step. 15:23:59 INFO - ##### 15:23:59 INFO - Running pre-action listener: _resource_record_pre_action 15:23:59 INFO - Running main action method: run_tests 15:23:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:23:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:23:59 INFO - Python 2.7.3 15:23:59 INFO - Return code: 0 15:23:59 INFO - grabbing minidump binary from tooltool 15:23:59 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:23:59 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 0x1cd97f0>, '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 0x1c452d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:23:59 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:23:59 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:23:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:59 INFO - Return code: 0 15:23:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:23:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:23:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:23:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:23:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:23:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:23:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:24:00 INFO - Return code: 0 15:24:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:24:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:24:00 INFO - Using env: {'DISPLAY': ':0', 15:24:00 INFO - 'HOME': '/home/cltbld', 15:24:00 INFO - 'LANG': 'en_US.UTF-8', 15:24:00 INFO - 'LANGUAGE': 'en_US:en', 15:24:00 INFO - 'LOGNAME': 'cltbld', 15:24:00 INFO - 'MAIL': '/var/mail/cltbld', 15:24:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:24:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:00 INFO - 'MOZ_NO_REMOTE': '1', 15:24:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:00 INFO - 'NO_EM_RESTART': '1', 15:24:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:24:00 INFO - 'PWD': '/builds/slave/test-pgo', 15:24:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:24:00 INFO - 'SHELL': '/bin/bash', 15:24:00 INFO - 'SHLVL': '1', 15:24:00 INFO - 'TERM': 'linux', 15:24:00 INFO - 'TMOUT': '86400', 15:24:00 INFO - 'USER': 'cltbld', 15:24:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246', 15:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:00 INFO - '_': '/tools/buildbot/bin/python'} 15:24:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:24:01 INFO - mozversion application_buildid: 20160302124722 15:24:01 INFO - mozversion application_changeset: 3a34e8b89130c938dd12596e3c6274d5fb994825 15:24:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:24:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:01 INFO - mozversion application_name: Firefox 15:24:01 INFO - mozversion application_remotingname: firefox-dev 15:24:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:24:01 INFO - mozversion application_vendor: Mozilla 15:24:01 INFO - mozversion application_version: 46.0a2 15:24:01 INFO - mozversion platform_buildid: 20160302124722 15:24:01 INFO - mozversion platform_changeset: 3a34e8b89130c938dd12596e3c6274d5fb994825 15:24:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:24:01 INFO - mozversion platform_version: 46.0a2 15:24:01 INFO - using testdate: 1456961041 15:24:01 INFO - actual date: 1456961041 15:24:01 INFO - starting webserver on 'localhost:51285' 15:24:01 INFO - SUITE-START | Running 3 tests 15:24:01 INFO - TEST-START | dromaeo_css 15:24:01 INFO - operating with platform_type : linux_ 15:24:01 INFO - Initialising browser for dromaeo_css test... 15:24:01 INFO - TEST-INFO | started process 29789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3eV6Dd/profile http://localhost:51285/getInfo.html) 15:24:05 INFO - PROCESS | 29789 | 15:24:05 INFO - PROCESS | 29789 | (process:29869): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:06 INFO - PROCESS | 29789 | __metrics Screen width/height:1600/1200 15:24:06 INFO - PROCESS | 29789 | colorDepth:24 15:24:06 INFO - PROCESS | 29789 | Browser inner width/height: 1024/697 15:24:06 INFO - PROCESS | 29789 | __metrics 15:24:07 INFO - TEST-INFO | 29789: exit 0 15:24:07 INFO - Browser initialized. 15:24:07 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:07 INFO - TEST-INFO | started process 29918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3eV6Dd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:08 INFO - PROCESS | 29918 | 15:24:08 INFO - PROCESS | 29918 | (process:29979): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:19 INFO - PROCESS | 29918 | RSS: Main: 141742080 15:24:19 INFO - PROCESS | 29918 | 15:25:08 INFO - PROCESS | 29918 | 1456961108750 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:27:16 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51285/tests/dromaeo/cssquery-ext.html) 15:27:17 INFO - PROCESS | 29918 | RSS: Main: 145629184 15:27:17 INFO - PROCESS | 29918 | 15:30:19 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-ext.html (next: http://localhost:51285/tests/dromaeo/cssquery-jquery.html) 15:30:20 INFO - PROCESS | 29918 | RSS: Main: 144699392 15:30:20 INFO - PROCESS | 29918 | 15:33:21 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51285/tests/dromaeo/cssquery-mootools.html) 15:33:22 INFO - PROCESS | 29918 | RSS: Main: 143257600 15:33:22 INFO - PROCESS | 29918 | 15:36:24 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51285/tests/dromaeo/cssquery-prototype.html) 15:36:24 INFO - PROCESS | 29918 | RSS: Main: 142876672 15:36:24 INFO - PROCESS | 29918 | 15:39:26 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51285/tests/dromaeo/cssquery-yui.html) 15:39:27 INFO - PROCESS | 29918 | RSS: Main: 143499264 15:39:27 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | Cycle 1(1): loaded http://localhost:51285/tests/dromaeo/cssquery-yui.html (next: http://localhost:51285/tests/dromaeo/cssquery-dojo.html) 15:42:29 INFO - PROCESS | 29918 | RSS: Main: 146878464 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | __start_tp_report 15:42:29 INFO - PROCESS | 29918 | _x_x_mozilla_page_load 15:42:29 INFO - PROCESS | 29918 | _x_x_mozilla_page_load_details 15:42:29 INFO - PROCESS | 29918 | |i|pagename|runs| 15:42:29 INFO - PROCESS | 29918 | |0;dojo.html;3343.5987681478227;3370.106921665759;3372.5447064646264;3397.4733916242985;3399.3031428557147;5460.071787796074;5495;5517.144842549406;5533.584981126416;5538.418466061066;5454.4545545445435;5501.367342755584;5530.198121272413;5531.695756733378;5573.5819813514045;5008.173651347523;5055.216441451563;5086.593072554206;5122.974385128069;5188.351456067991;5002.849914502571;5045.722485263309;5162.6128040397125;5163.457836927125;5177.197534382158;5064.670796398241;5143.254228136918;5158.045761534128;5159.948400515985;5160.174372100465;5144.356955380577;5190.662606930538;5211.1922651989;5220.373555173365;5227.268182454441;4982.651214414992;5020.895403011368;5028.723420211887;5050.570701490377;5105.876707124464;5409.377921539034;5418.810341638064;5425.457454254582;5438.619296649236;5462.399136095027;5929.466348028655;5963.403659634046;5989.281286245635;5997.370276121032;6003.249593800775;5903.291605007426;5998.1602575639445;6020.066889632114;6066.120412540201;6097.756089756404;5666.575006874501;5697.715114244313;5704.885902281972;5717.42825717425;5740.6268592541355;6176.969115154396;6187.81436556904;6193.349698281706;6221;6228.6574238416415;5830.82507524775;5908.615939963888;5939.07944268639;6021.638701677914;6055.1220073090035;6073.39266073398;6097.298810636834;6105.053716673922;6129.264488261437;6132.325444201134;5888.4700376966275;6013.609115407572;6022.126791615279;6081.057436097412;6092.147099406086;5910.734016969247;5960.7019649017375;5970.701464926823;6003.6998150093195;6089.939100609025;4528.909421811545;4566.885827854264;4572.039871626929;4573.0396616710195;4606.078784243165;4054.7769872657286;4111.259973204852;4116.650084742771;4134.958650413518;4138.586141385837;5649.6327738696855;5655.745491452894;5716.942830571724;5747.568932330092;5779.739911703983;6020.277566692025;6035.215421995113;6036.396360363929;6039.54703397247;6065.878682426415;5496.697681627469;5599.216109744639;5685.857853553694;5686.09022556389;5696.715164241771;5093.0577843099145;5134;5170.663906846043;5171.534561889448;5171.560417364491;6099.390060993954;6133.754649814046;6140.815775526741;6151.692415379213;6160.9383906161265;5949.970250148895;5971.91042134377;6008.918394688823;6017.849553761191;6056.878862422639;6143.907841382472;6148.600340977822;6152.569320147726;6153.015517517176;6170.10533472653;5975.521958243243;5977.462028417463;5978.850528736816;5989.850253743517;6009.399060093956;5966.552508561788;6004.189434426471;6046.27444706638;6060.545459090674;6091.451769340603;5860.238169037998;5954.97022514902;5973.074173503114;5983.102534619842;5986.790462333972;5873.559483038704;5893.263342082239;5907.054871220756;5939.584229104094;5975.103734439869;5638.830835074954;5683.062294721325;5756.510696590669;5799.623024503394;5813.09896965971;5825.330087040044;5908;5924.4667979882015;5937.5249980000635;5973.880522389441;5792.160136780228;5799.9130013049;5810.070388737781;5827.912581311199;5830.2420685310635 15:42:29 INFO - PROCESS | 29918 | |1;ext.html;511.91041567725637;576.4005434348278;589.2369381650764;600.9218801555799;604.1029071828337;30839.38321233574;38193;38489;38557.42163867544;38575.807120964426;42291.3656295155;42760;42931.78534107333;42958.785206074004;43063.78468107663;8845.601947912359;9010.774730631754;9029.142231487998;9055.185033346997;9055.456672599632;8949.731508054769;9073.546322683873;9080.273578113734;9083.545822708871;9119.680811171611;9059.637614495412;9078.364514483988;9085.273178145766;9135.634574617008;9150.359474836763;9041.954790226073;9046.592903319366;9061.13919177677;9100.8634870477;9114.77213069672;9014.86477702835;9058.456492610465;9114.088591140833;9152.31357648179;9155.633774649006;41587;41661.58338416607;42162.156756865;42273.78863105665;42393.576064239576;3574.964250357515;3580.6061333253583;3601.45978103284;3628.2562074774874;4218.346156345771;28390.858045709847;28774.280642984093;28858.711412885812;29026.85486572575;29560.113196604136;4102.220578090153;4116.629503344713;4140.192662430827;4166.8749937501925;4199.475065616798;298309;300884;300907;301173;301411;43920.3411948821;44171.337429938576;44331.55668443274;44359.112817743466;65177.67411162914;43452;43555;43665.34501982473;43717.78141109274;43807;14623.195724235056;14719.705605887822;14775.92612036933;14778.48275310359;14791.92604036973;12283.815742763687;12292.262464252173;12335.629931102081;12341.568045118378;12358.814617780741;15060.623484412978;15102.320395582225;15166.090034597959;15240.161791101596;15278.236088195768;6016.729247183887;6107.297660769068;6127.785527506516;6216.658083805343;6231.813045608639;1018.6689325968941;1064.6486659402378;1065.3075500924306;1067.5836423794726;1109.3343993603773;31443.685563144532;31865;33593;34066.82966585151;34139.658603414144;1144.1075960750627;1164.1443538998828;1178.8938995490446;1194.9581764638197;1253.367049639926;15316.15761133126;17857.196426160855;17936;17968.55154826586;17998.37005704794;307426;467373;473147;477113.45773084345;485758;56343;57151;57209.14186287209;57317.426825732044;57397;1491.7986071880375;1498.4530646314017;1501.2493753123438;1511.7203317386318;1515.3559737111684;29878;30159;30698;31411.685883140875;31606.209844754067;50132;50839;51013.999999998516;51030;51116;317346;319951;320105;320299;320391;35979.46030809592;50939.74530127326;51046.74476627593;51776.48223517867;52074.21888671597;46994.29508557443;47324.7633761829;47479.52520474751;47560.33538826124;47702.284465733734;40023.39964900471;40681.38977915274;43178;44865.327020094075;45016.324755128044;40309.596904030586;40799.59200407958;41072.383914240716;42818;44292.7785361084;38795.22409551737;39221.41167882427;39301.41047884341;39406.2118757629;44119.77940110279;32301.35397292088;33277.1593128259;35131;35475.29049418945;35690.10774730652;27586.310342241606;28382.29044273827;28387.290317742223;28399.148025559265;28430.004949827486 15:42:29 INFO - PROCESS | 29918 | |2;jquery.html;372.2331996088057;373.6487701560533;374.3523703992095;375.2850819189445;377.8696349759333;15704.214789260548;16424.260908259126;17729;18020.729689054657;18544.258229670813;10007.59969601215;10196.133328667072;17194.82805171951;17269.91365043173;17835.37576184834;5156.587473002161;5274.367075950891;5282.656627319231;5299.28459657947;5693.316801983747;3997.5202975642965;4090.141070375225;5604.355499117612;5658.434156584329;5666.603337766358;5392.865178370553;5505.834824955237;5511.035568775468;5564.8052318168875;5570.442955704438;5460.672359658433;5804.477597016267;6125.632462052291;6150.323464418932;6174.783882564134;5243.2659427680155;5444.210589464545;5446.101393270105;5454.61817672763;5474.343078830526;19846.900765496226;19884.60230795376;19941.50146246341;21154.365369038955;21362.359129226148;2230.2194232018824;2272.091163534599;2319.4433335999406;2321.303608917318;2366.8343215974887;9618.51907404627;9729.221662267002;9982.90017099827;10805.675829725122;12374.62876113718;1687.190148728605;1851.3612803582741;1924.1341396371688;1933.8936358500277;2035.0943829995658;58817.7059114706;59417.40582594162;59968.400315997154;60040.699796501176;61625;10542.525586348633;10628.574857005788;10630.46847657614;10644.095251903675;10747.623833165959;13618.659533511543;13665.521706740217;13686.794698079337;13708.52020179309;13771.655708607364;7795.688172473151;7855.921440785519;8054.677812887536;8098.392620553482;8124.7562573122905;7910.2089791020435;8025.23760242776;8028.919710802934;8096.878546821685;8115.3507719382305;4454.354118652777;4516.683832131785;4523;4565.520620334817;4633.837815676435;1727.93952211672;1792.8386445219992;1821.8815776974454;1826.5433641589602;1886.104100552254;1010.9191264698953;1022.4580972084807;1042.1506472225112;1066.5573786878358;1157.0743405275746;17159.399421020455;17505.64988700219;17686.823131768775;17932.641347172983;18195.545111372056;996.6013594562088;1037.5590374091132;1040.4069680282319;1049.2550289294686;1078.2290662176424;10331.12185464229;10351.896481035094;10362.171026317876;10475.790484190426;10480.423576703355;397684;399733;401085;596791;601969;75614;81047;81400.59299703463;81734;82992.58503707564;1162.9418529073512;1193.093249130667;1248.4818800197997;1248.9250644961332;1249.0257599072738;16454.34182632729;16481.587960301087;16511;16512.917435412746;16927.915360423613;33819.830900846326;34121.82939085289;34494.31011379708;35544;35765.82117089398;45671;46355.304670429294;46480.535194648975;46957;46958;7654.387648987956;7880.3301719354495;7903.604819758874;7906.9209307906185;8003.39974501903;7844.803879903048;10632.734181645521;11832.881671183179;12033.63899083029;12136.150469467053;3291.851866665958;8564.700235491728;9141.680041198526;9302.860457093013;10543.683689489328;10040;10219.897801021894;10523.105536029523;10948.233623646269;11073.83389249178;9604.855927161238;10091.7477063074;10357.067863892285;10528.526216320437;10669.199810014436;7365.9631701841145;7391.889121663287;7759.534427934342;7828.725994590162;7908.485948413335;9424.764380890532;9580.56887440053;10246.180305575685;10435;10482.37105773656 15:42:29 INFO - PROCESS | 29918 | |3;mootools.html;1520.5134357005759;1548.1021007815468;1770.4511601403558;1860.0699650174913;1908.8663793534458;7852.293293603575;7952.125266220718;7990.360771138309;8085.91914080859;8115.553644549547;8119.634616442259;8122.878156827653;8164.755057348274;8187.754367368989;8195.754127376173;2386.6777984972023;2406.458546826959;2424.0788500369836;2426.296374051523;2428.101602407112;2406.4585468269674;2418.9758102419014;2454.5336386086674;2455.4966231922504;2459.692538432696;2304.758000409958;2359.9410014749683;2360.5396947595227;2411.9276421707377;2417.697787776528;2385.904563817454;2389.80881529479;2399.256230568529;2400.243923164198;2405.8195635327334;2398.4963157736897;2412.1195763546357;2417.395651087228;2419.552382809186;2420.9394765130837;7942.841143177104;8085.636146373427;8119.512829230265;8149.551774652392;8230.794230144234;4862.6353023523025;4962.206047032493;4971.229459433794;4982.377202849644;5000.349954505891;3017.396520695848;3050.4814181588963;3076.077176846937;3098.4887493563533;3134.0127859724116;939.1406862720603;945.0313428735533;2040.2349119080345;2072.4611600983703;2134.679798030292;10642.574297028186;10884.836727449094;10909.890901090967;10945.616903408421;11012.284201526954;4333.978330108329;4350.1734670412525;4391.209582275221;4408.360787685768;4451.376807246988;9469.431834089839;9523.857142142873;9548.37935534202;9561.139497445125;9583.377080489747;4928.926066109011;4937.23472861707;4963.329950456714;4966.180580204225;5000.474950130257;4442.777861106932;4497.280435130363;4501;4516.525764794649;4520;3761.6614504694708;3858.7684738915755;3905.2189562087697;3911.8239679214503;3915.941260881089;1180.2328486483855;1196.5871774237874;1201.2132053504968;1220.8718084601167;1234.8086046662781;1186.2704436771496;1202.7233736240714;1245.4333278358324;1400.8879289656802;1420.2117824607235;7117.82205444868;7336.486445948733;7411.0736157980255;7415.3326200642205;7421.369183619345;640.4492136762381;652.9347065293433;653.9247986481521;658.1279804259375;801.8373358630009;5621.0444224481935;5705.828825135252;5742.54059675225;5744.281964754406;5751.396103409165;9378.95310523443;9665.081817227352;9698.272629552812;9983.550740216708;10005.249606279413;9762.121409073075;9801.362911410879;9834;9870.25973052024;9931.950340248253;7540.622968851536;7660.80847978805;7716.884246736304;7755.68977240904;7814.374850011872;7171.103612048494;7211.6033618151505;7225.096862892138;7263.128424589083;7311.817204569928;8491.72624106389;8626.18051285152;8878.422902511316;8937.59780809878;8954.597043132944;8887.822243555222;8903;8921.955390223267;8953.462792232487;9087.636494540144;7346.11846578414;7393.963030184815;7402.481826272109;7429.517081389692;7446.218147094693;7842.568658723825;7862.606869656609;7906.683732650629;7907.209279072277;7963.601819908866;7161.462890283354;7176.318249766264;7187.8562428752175;7285.854282914206;7320.450966177452;6995.580265184105;7157.105361829771;7200.603966781878;7209.927900721135;7240.674169662272;7228.819279518054;7258;7286.7085316586745;7297.744578939712;7302.452316076209;6633.038209459698;6676.499262555425;6689.565178263398;6689.5986240825705;6704.195496540447;6467.708953097216;6553.934460655332;6554.115194448879;6558.278589355072;6570.638614876228 15:42:29 INFO - PROCESS | 29918 | |4;prototype.html;355.3851836323161;355.7829723868439;357.2533405183168;357.4370366672492;364.2314715949348;6397.680115994199;6404.199475065617;6441.613503189806;6475.708593113315;6526.379993900572;6248.968755156217;6375.426211640963;6406.775762848301;6435.356464353574;6443.48452123829;4912.754362281889;4939.160342741725;4948.406191257054;4951.0592987332475;4964.304997300381;4950.801967921278;4954.851354459354;4961.156603377434;4962.280469331945;4964.056829202458;4691.601213896823;4806.471288158317;4809.446913604946;4823;4840.878978025542;4787.473377928425;4790.520947905216;4801.73590452525;4810.879728006793;4825.951740482603;4200.642945349649;4208.452901122834;4209.368594710787;4212.557681443435;4218.704690671654;6061.636301821904;6124.142620033199;6138.447539721402;6168.475679567242;6176.598521096114;5655.717214139277;5660.377358490563;5669.8582535436535;5672.716364181774;5682.687452190128;6768.76309329176;6788.151481064867;6809.182898052265;6819.113515243036;6824.078749368871;4663.440387153563;4678.789454474557;4679.438467383901;4694.155052090657;4713.787879545429;6961.095057642525;7040.507164498487;7075.2570980047385;7109.289071092901;7119.359257666835;4768.61851051915;4774.785134668949;4776.522347765265;4793.400824896888;4815.036992601494;4847.612191024709;4850.957044235506;4852.708837469763;4855.44162421319;4871.244957031666;5516.200150978086;5654;5655.575831812631;5658.745356458887;5667.688277144796;6842.726290948306;6907.516473846783;6914.861702765917;6915.412189963909;6924.965375173092;1641.359869650837;1669.8580620647137;1742.7995780485153;1778.3509019208154;1785.544686105035;1205.1684337806885;1205.9155859089778;1208.190512356723;1224.9755004899853;1225.7180848404917;6509.804705858832;6544.803655890331;6546.378094081055;6546.934530654633;6548.934510654833;6873.312668733087;6960.234374218832;6963.199232088375;6973.267806880306;6977.2673869243;6387.041943708481;6473.514486413444;6512.869742605121;6540.607563546202;6552.803415897531;3793.639604237593;3799.544054713452;3820.2168555446065;3838.846446142123;3844.8462061517225;7129.287071292829;7143.89284160738;7146.714131434788;7196.064511613561;7206.315400036988;7008.229094799568;7149.53528020677;7152.4278057755255;7181.856362872713;7183.46124040699;7112.217656057829;7144.857102857914;7158.713651453988;7172.892406613905;7175.067241258707;6911.516193866381;6927.203371612128;6941.201761797458;6967.860642787217;6974.965125174342;6709.396154345937;6874.9656251718425;6875.518713689994;6876.037354770237;6878.174619045746;7137.429005679637;7174.784756457315;7175.605341706257;7182;7201.603911784692;4866.853994380174;4870.147724148331;4883.389576302962;4884.194107972145;4885.560299573055;6892.517523773287;6949.3745562899585;6960.443164546926;6989.720411183495;7010.509264351446;6708.597484150967;6738.056672066013;6740.966295168493;6796.694148763218;6811.65941702903;6744.69648865812;6758.797236082925;6775.661216939232;6786.59280443175;6799.490038247251;6524.706388212447;6628.83427914306;6641.800745977628;6659.267480577036;6674.798536263519;6763.628000459825;6786.287439818748;6820.215675197416;6825.795226143224;6828.624425656637;6576.145101136822;6647.601143931186;6665.866682666223;6667.633280169637;6670.132362938385 15:42:29 INFO - PROCESS | 29918 | |5;yui.html;864.6238886084553;880.2341962492633;888.804463018136;918.8070505193909;920.3649481857518;14551.41794328227;14748.115113093208;14816.555503334917;14898.106113633175;14923.552293431187;13424.530141445051;13434.39545220465;13529.458821647147;13619.591412257623;13629.931850340734;859.9656013759442;873.2620935309653;896.2158111652304;902.0979020979021;903.850864607339;893.8212357528488;894.6421431427416;895.6372669069037;897.0670502677208;900.2842740021666;908.7546362482126;911.421247507834;917.40368760306;918.3984490158956;921.5898924978387;911.3848152497104;918.283738683821;918.554501066982;918.9586468608928;919.4345477531336;682.6654939079865;683.4703105093542;685.1777866560147;687.041577000087;688.7486067585295;15060.924695376563;15163.241837908061;15172.089674619448;15242.771358429633;15243.16162611056;13520;13565.864341356559;13717.17696938177;13742;13763.862361376358;11106.278091924;11277.605283815026;11895.702607434796;12082.456289466994;12092.879071209263;3932.8623498177426;3950.6246906543834;3975.3043217436834;3991.501062367204;4012.0371110933456;47496.7625161872;48231;48334.51665483335;48364.516354836356;48821.75589122032;11414.828777568344;11437.542498300141;11597;11804.58683946075;11986.52053917851;19443.708344374845;19560.804391956182;19622;19715.40853774389;19728.30950916711;8259.752207433787;8293.626786794608;8351.665933362598;8520.957395212985;8634.050254472004;4680.602148817321;4695.5304469552775;4748.501407352247;4780.402449693788;4840.975795121002;3269.1336795749144;3293.720033797154;3297.3075654112426;3307.6030876295;3322.086426232757;602.2141105856899;603.4629180029777;609.5793902207463;610.6519284008161;615.1388056720538;656.2944834303144;661.7749965011919;697.3444961736053;719.0652152202116;723.8914162875611;8690.913090869137;9114.81770364589;9167.679131230376;9186.816263674822;9187.77030574241;658.2397331082511;691.3225039461356;733.336330620789;788.286600626434;791.8851766493826;4347;4457.7548234846745;4469.642428605769;4684.133435314409;4721.220998535272;61504.69247653733;62779.6861015692;62907.37092629106;62924.37075629185;63014.36985630085;53865.46134538683;53993;54348.45651543513;54407.72796136073;54565.72717136389;48109;48854.755726221854;48859.75570122198;48950.51049489531;49477;9007.90992090097;9078.773030674285;9330.533473326443;9345.345825792401;9421.481818499775;33659.32681346408;33800.1549961253;33931.49102763411;34005.319893601496;34600.82699586486;38905.805470973595;40801.1839763209;44388.33417498805;44422.3336649944;44607.33089003603;10374.533146008598;10485.737856553342;10520.21098417637;10762.623308184176;11314;12056.539080540257;12066.818997714865;12130.454129564367;12162.939185304016;12217.266963982189;11790.292582445081;11938.164328496921;12110.212836165621;12141.271523708605;12453.128281020241;11346.262492937933;11497.965183133558;11803.881961180277;11836.58571950012;12199.024078073555;11575.536978520764;12708.745825083632;12958.28729419891;12976.351182441029;13105.14816536922;10219.335743176669;10269.897301027193;10366.896331036593;10461.529231184462;10483.213758967955;10440.321379110334;10671.786564268827;10675.946620266848;11057.22599418033;11127.72180695489 15:42:29 INFO - PROCESS | 29918 | __end_tp_report 15:42:29 INFO - PROCESS | 29918 | __start_cc_report 15:42:29 INFO - PROCESS | 29918 | _x_x_mozilla_cycle_collect,302 15:42:29 INFO - PROCESS | 29918 | __end_cc_report 15:42:29 INFO - PROCESS | 29918 | __startTimestamp1456962149987__endTimestamp 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | ------- Summary: start ------- 15:42:29 INFO - PROCESS | 29918 | Number of tests: 6 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | [#0] dojo.html Cycles:165 Average:5582.83 Median:5813.10 stddev:624.57 (10.7%) stddev-sans-first:601.27 15:42:29 INFO - PROCESS | 29918 | Values: 3343.6 3370.1 3372.5 3397.5 3399.3 5460.1 5495.0 5517.1 5533.6 5538.4 5454.5 5501.4 5530.2 5531.7 5573.6 5008.2 5055.2 5086.6 5123.0 5188.4 5002.8 5045.7 5162.6 5163.5 5177.2 5064.7 5143.3 5158.0 5159.9 5160.2 5144.4 5190.7 5211.2 5220.4 5227.3 4982.7 5020.9 5028.7 5050.6 5105.9 5409.4 5418.8 5425.5 5438.6 5462.4 5929.5 5963.4 5989.3 5997.4 6003.2 5903.3 5998.2 6020.1 6066.1 6097.8 5666.6 5697.7 5704.9 5717.4 5740.6 6177.0 6187.8 6193.3 6221.0 6228.7 5830.8 5908.6 5939.1 6021.6 6055.1 6073.4 6097.3 6105.1 6129.3 6132.3 5888.5 6013.6 6022.1 6081.1 6092.1 5910.7 5960.7 5970.7 6003.7 6089.9 4528.9 4566.9 4572.0 4573.0 4606.1 4054.8 4111.3 4116.7 4135.0 4138.6 5649.6 5655.7 5716.9 5747.6 5779.7 6020.3 6035.2 6036.4 6039.5 6065.9 5496.7 5599.2 5685.9 5686.1 5696.7 5093.1 5134.0 5170.7 5171.5 5171.6 6099.4 6133.8 6140.8 6151.7 6160.9 5950.0 5971.9 6008.9 6017.8 6056.9 6143.9 6148.6 6152.6 6153.0 6170.1 5975.5 5977.5 5978.9 5989.9 6009.4 5966.6 6004.2 6046.3 6060.5 6091.5 5860.2 5955.0 5973.1 5983.1 5986.8 5873.6 5893.3 5907.1 5939.6 5975.1 5638.8 5683.1 5756.5 5799.6 5813.1 5825.3 5908.0 5924.5 5937.5 5973.9 5792.2 5799.9 5810.1 5827.9 5830.2 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | [#1] ext.html Cycles:180 Average:52310.76 Median:22594.51 stddev:95317.09 (421.9%) stddev-sans-first:95505.14 15:42:29 INFO - PROCESS | 29918 | Values: 511.9 576.4 589.2 600.9 604.1 30839.4 38193.0 38489.0 38557.4 38575.8 42291.4 42760.0 42931.8 42958.8 43063.8 8845.6 9010.8 9029.1 9055.2 9055.5 8949.7 9073.5 9080.3 9083.5 9119.7 9059.6 9078.4 9085.3 9135.6 9150.4 9042.0 9046.6 9061.1 9100.9 9114.8 9014.9 9058.5 9114.1 9152.3 9155.6 41587.0 41661.6 42162.2 42273.8 42393.6 3575.0 3580.6 3601.5 3628.3 4218.3 28390.9 28774.3 28858.7 29026.9 29560.1 4102.2 4116.6 4140.2 4166.9 4199.5 298309.0 300884.0 300907.0 301173.0 301411.0 43920.3 44171.3 44331.6 44359.1 65177.7 43452.0 43555.0 43665.3 43717.8 43807.0 14623.2 14719.7 14775.9 14778.5 14791.9 12283.8 12292.3 12335.6 12341.6 12358.8 15060.6 15102.3 15166.1 15240.2 15278.2 6016.7 6107.3 6127.8 6216.7 6231.8 1018.7 1064.6 1065.3 1067.6 1109.3 31443.7 31865.0 33593.0 34066.8 34139.7 1144.1 1164.1 1178.9 1195.0 1253.4 15316.2 17857.2 17936.0 17968.6 17998.4 307426.0 467373.0 473147.0 477113.5 485758.0 56343.0 57151.0 57209.1 57317.4 57397.0 1491.8 1498.5 1501.2 1511.7 1515.4 29878.0 30159.0 30698.0 31411.7 31606.2 50132.0 50839.0 51014.0 51030.0 51116.0 317346.0 319951.0 320105.0 320299.0 320391.0 35979.5 50939.7 51046.7 51776.5 52074.2 46994.3 47324.8 47479.5 47560.3 47702.3 40023.4 40681.4 43178.0 44865.3 45016.3 40309.6 40799.6 41072.4 42818.0 44292.8 38795.2 39221.4 39301.4 39406.2 44119.8 32301.4 33277.2 35131.0 35475.3 35690.1 27586.3 28382.3 28387.3 28399.1 28430.0 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | [#2] jquery.html Cycles:180 Average:26551.12 Median:34308.07 stddev:80248.86 (233.9%) stddev-sans-first:80449.90 15:42:29 INFO - PROCESS | 29918 | Values: 372.2 373.6 374.4 375.3 377.9 15704.2 16424.3 17729.0 18020.7 18544.3 10007.6 10196.1 17194.8 17269.9 17835.4 5156.6 5274.4 5282.7 5299.3 5693.3 3997.5 4090.1 5604.4 5658.4 5666.6 5392.9 5505.8 5511.0 5564.8 5570.4 5460.7 5804.5 6125.6 6150.3 6174.8 5243.3 5444.2 5446.1 5454.6 5474.3 19846.9 19884.6 19941.5 21154.4 21362.4 2230.2 2272.1 2319.4 2321.3 2366.8 9618.5 9729.2 9982.9 10805.7 12374.6 1687.2 1851.4 1924.1 1933.9 2035.1 58817.7 59417.4 59968.4 60040.7 61625.0 10542.5 10628.6 10630.5 10644.1 10747.6 13618.7 13665.5 13686.8 13708.5 13771.7 7795.7 7855.9 8054.7 8098.4 8124.8 7910.2 8025.2 8028.9 8096.9 8115.4 4454.4 4516.7 4523.0 4565.5 4633.8 1727.9 1792.8 1821.9 1826.5 1886.1 1010.9 1022.5 1042.2 1066.6 1157.1 17159.4 17505.6 17686.8 17932.6 18195.5 996.6 1037.6 1040.4 1049.3 1078.2 10331.1 10351.9 10362.2 10475.8 10480.4 397684.0 399733.0 401085.0 596791.0 601969.0 75614.0 81047.0 81400.6 81734.0 82992.6 1162.9 1193.1 1248.5 1248.9 1249.0 16454.3 16481.6 16511.0 16512.9 16927.9 33819.8 34121.8 34494.3 35544.0 35765.8 45671.0 46355.3 46480.5 46957.0 46958.0 7654.4 7880.3 7903.6 7906.9 8003.4 7844.8 10632.7 11832.9 12033.6 12136.2 3291.9 8564.7 9141.7 9302.9 10543.7 10040.0 10219.9 10523.1 10948.2 11073.8 9604.9 10091.7 10357.1 10528.5 10669.2 7366.0 7391.9 7759.5 7828.7 7908.5 9424.8 9580.6 10246.2 10435.0 10482.4 15:42:29 INFO - PROCESS | 29918 | 15:42:29 INFO - PROCESS | 29918 | [#3] mootools.html Cycles:180 Average:5679.67 Median:6564.46 stddev:2914.50 (44.4%) stddev-sans-first:2905.90 15:42:29 INFO - PROCESS | 29918 | Values: 1520.5 1548.1 1770.5 1860.1 1908.9 7852.3 7952.1 7990.4 8085.9 8115.6 8119.6 8122.9 8164.8 8187.8 8195.8 2386.7 2406.5 2424.1 2426.3 2428.1 2406.5 2419.0 2454.5 2455.5 2459.7 2304.8 2359.9 2360.5 2411.9 2417.7 2385.9 2389.8 2399.3 2400.2 2405.8 2398.5 2412.1 2417.4 2419.6 2420.9 7942.8 8085.6 8119.5 8149.6 8230.8 4862.6 4962.2 4971.2 4982.4 5000.3 3017.4 3050.5 3076.1 3098.5 3134.0 939.1 945.0 2040.2 2072.5 2134.7 10642.6 10884.8 10909.9 10945.6 11012.3 4334.0 4350.2 4391.2 4408.4 4451.4 9469.4 9523.9 9548.4 9561.1 9583.4 4928.9 4937.2 4963.3 4966.2 5000.5 4442.8 4497.3 4501.0 4516.5 4520.0 3761.7 3858.8 3905.2 3911.8 3915.9 1180.2 1196.6 1201.2 1220.9 1234.8 1186.3 1202.7 1245.4 1400.9 1420.2 7117.8 7336.5 7411.1 7415.3 7421.4 640.4 652.9 653.9 658.1 801.8 5621.0 5705.8 5742.5 5744.3 5751.4 9379.0 9665.1 9698.3 9983.6 10005.2 9762.1 9801.4 9834.0 9870.3 9932.0 7540.6 7660.8 7716.9 7755.7 7814.4 7171.1 7211.6 7225.1 7263.1 7311.8 8491.7 8626.2 8878.4 8937.6 8954.6 8887.8 8903.0 8922.0 8953.5 9087.6 7346.1 7394.0 7402.5 7429.5 7446.2 7842.6 7862.6 7906.7 7907.2 7963.6 7161.5 7176.3 7187.9 7285.9 7320.5 6995.6 7157.1 7200.6 7209.9 7240.7 7228.8 7258.0 7286.7 7297.7 7302.5 6633.0 6676.5 6689.6 6689.6 6704.2 6467.7 6553.9 6554.1 6558.3 6570.6 15:42:30 INFO - PROCESS | 29918 | 15:42:30 INFO - PROCESS | 29918 | [#4] prototype.html Cycles:180 Average:5667.29 Median:6492.76 stddev:1696.55 (26.1%) stddev-sans-first:1653.80 15:42:30 INFO - PROCESS | 29918 | Values: 355.4 355.8 357.3 357.4 364.2 6397.7 6404.2 6441.6 6475.7 6526.4 6249.0 6375.4 6406.8 6435.4 6443.5 4912.8 4939.2 4948.4 4951.1 4964.3 4950.8 4954.9 4961.2 4962.3 4964.1 4691.6 4806.5 4809.4 4823.0 4840.9 4787.5 4790.5 4801.7 4810.9 4826.0 4200.6 4208.5 4209.4 4212.6 4218.7 6061.6 6124.1 6138.4 6168.5 6176.6 5655.7 5660.4 5669.9 5672.7 5682.7 6768.8 6788.2 6809.2 6819.1 6824.1 4663.4 4678.8 4679.4 4694.2 4713.8 6961.1 7040.5 7075.3 7109.3 7119.4 4768.6 4774.8 4776.5 4793.4 4815.0 4847.6 4851.0 4852.7 4855.4 4871.2 5516.2 5654.0 5655.6 5658.7 5667.7 6842.7 6907.5 6914.9 6915.4 6925.0 1641.4 1669.9 1742.8 1778.4 1785.5 1205.2 1205.9 1208.2 1225.0 1225.7 6509.8 6544.8 6546.4 6546.9 6548.9 6873.3 6960.2 6963.2 6973.3 6977.3 6387.0 6473.5 6512.9 6540.6 6552.8 3793.6 3799.5 3820.2 3838.8 3844.8 7129.3 7143.9 7146.7 7196.1 7206.3 7008.2 7149.5 7152.4 7181.9 7183.5 7112.2 7144.9 7158.7 7172.9 7175.1 6911.5 6927.2 6941.2 6967.9 6975.0 6709.4 6875.0 6875.5 6876.0 6878.2 7137.4 7174.8 7175.6 7182.0 7201.6 4866.9 4870.1 4883.4 4884.2 4885.6 6892.5 6949.4 6960.4 6989.7 7010.5 6708.6 6738.1 6741.0 6796.7 6811.7 6744.7 6758.8 6775.7 6786.6 6799.5 6524.7 6628.8 6641.8 6659.3 6674.8 6763.6 6786.3 6820.2 6825.8 6828.6 6576.1 6647.6 6665.9 6667.6 6670.1 15:42:30 INFO - PROCESS | 29918 | 15:42:30 INFO - PROCESS | 29918 | [#5] yui.html Cycles:180 Average:14490.47 Median:24532.54 stddev:16476.11 (67.2%) stddev-sans-first:16490.56 15:42:30 INFO - PROCESS | 29918 | Values: 864.6 880.2 888.8 918.8 920.4 14551.4 14748.1 14816.6 14898.1 14923.6 13424.5 13434.4 13529.5 13619.6 13629.9 860.0 873.3 896.2 902.1 903.9 893.8 894.6 895.6 897.1 900.3 908.8 911.4 917.4 918.4 921.6 911.4 918.3 918.6 919.0 919.4 682.7 683.5 685.2 687.0 688.7 15060.9 15163.2 15172.1 15242.8 15243.2 13520.0 13565.9 13717.2 13742.0 13763.9 11106.3 11277.6 11895.7 12082.5 12092.9 3932.9 3950.6 3975.3 3991.5 4012.0 47496.8 48231.0 48334.5 48364.5 48821.8 11414.8 11437.5 11597.0 11804.6 11986.5 19443.7 19560.8 19622.0 19715.4 19728.3 8259.8 8293.6 8351.7 8521.0 8634.1 4680.6 4695.5 4748.5 4780.4 4841.0 3269.1 3293.7 3297.3 3307.6 3322.1 602.2 603.5 609.6 610.7 615.1 656.3 661.8 697.3 719.1 723.9 8690.9 9114.8 9167.7 9186.8 9187.8 658.2 691.3 733.3 788.3 791.9 4347.0 4457.8 4469.6 4684.1 4721.2 61504.7 62779.7 62907.4 62924.4 63014.4 53865.5 53993.0 54348.5 54407.7 54565.7 48109.0 48854.8 48859.8 48950.5 49477.0 9007.9 9078.8 9330.5 9345.3 9421.5 33659.3 33800.2 33931.5 34005.3 34600.8 38905.8 40801.2 44388.3 44422.3 44607.3 10374.5 10485.7 10520.2 10762.6 11314.0 12056.5 12066.8 12130.5 12162.9 12217.3 11790.3 11938.2 12110.2 12141.3 12453.1 11346.3 11498.0 11803.9 11836.6 12199.0 11575.5 12708.7 12958.3 12976.4 13105.1 10219.3 10269.9 10366.9 10461.5 10483.2 10440.3 10671.8 10675.9 11057.2 11127.7 15:42:30 INFO - PROCESS | 29918 | -------- Summary: end -------- 15:42:30 INFO - PROCESS | 29918 | 15:42:30 INFO - TEST-INFO | 29918: exit 0 15:42:30 INFO - TEST-OK | dromaeo_css | took 1109548ms 15:42:30 INFO - TEST-START | kraken 15:42:30 INFO - operating with platform_type : linux_ 15:42:30 INFO - Initialising browser for kraken test... 15:42:30 INFO - TEST-INFO | started process 30163 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWf2ji1/profile http://localhost:51285/getInfo.html) 15:42:34 INFO - PROCESS | 30163 | 15:42:34 INFO - PROCESS | 30163 | (process:30244): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:42:35 INFO - PROCESS | 30163 | __metrics Screen width/height:1600/1200 15:42:35 INFO - PROCESS | 30163 | colorDepth:24 15:42:35 INFO - PROCESS | 30163 | Browser inner width/height: 1024/697 15:42:35 INFO - PROCESS | 30163 | __metrics 15:42:36 INFO - TEST-INFO | 30163: exit 0 15:42:36 INFO - Browser initialized. 15:42:36 INFO - Running cycle 1/1 for kraken test... 15:42:36 INFO - TEST-INFO | started process 30293 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWf2ji1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:37 INFO - PROCESS | 30293 | 15:42:37 INFO - PROCESS | 30293 | (process:30359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:42:48 INFO - PROCESS | 30293 | RSS: Main: 141410304 15:42:48 INFO - PROCESS | 30293 | 15:42:50 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51285/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:51 INFO - PROCESS | 30293 | RSS: Main: 146931712 15:42:51 INFO - PROCESS | 30293 | 15:42:54 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51285/tests/kraken/driver.html?testName=audio-dft) 15:42:54 INFO - PROCESS | 30293 | RSS: Main: 147251200 15:42:54 INFO - PROCESS | 30293 | 15:42:57 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51285/tests/kraken/driver.html?testName=audio-fft) 15:42:58 INFO - PROCESS | 30293 | RSS: Main: 147558400 15:42:58 INFO - PROCESS | 30293 | 15:43:00 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51285/tests/kraken/driver.html?testName=audio-oscillator) 15:43:00 INFO - PROCESS | 30293 | RSS: Main: 145272832 15:43:00 INFO - PROCESS | 30293 | 15:43:02 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51285/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:03 INFO - PROCESS | 30293 | RSS: Main: 147017728 15:43:03 INFO - PROCESS | 30293 | 15:43:06 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51285/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:07 INFO - PROCESS | 30293 | RSS: Main: 145850368 15:43:07 INFO - PROCESS | 30293 | 15:43:10 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51285/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:11 INFO - PROCESS | 30293 | RSS: Main: 145850368 15:43:11 INFO - PROCESS | 30293 | 15:43:13 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51285/tests/kraken/driver.html?testName=json-parse-financial) 15:43:14 INFO - PROCESS | 30293 | RSS: Main: 145768448 15:43:14 INFO - PROCESS | 30293 | 15:43:15 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51285/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:16 INFO - PROCESS | 30293 | RSS: Main: 146468864 15:43:16 INFO - PROCESS | 30293 | 15:43:18 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:18 INFO - PROCESS | 30293 | RSS: Main: 146042880 15:43:18 INFO - PROCESS | 30293 | 15:43:20 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:21 INFO - PROCESS | 30293 | RSS: Main: 147873792 15:43:21 INFO - PROCESS | 30293 | 15:43:23 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:24 INFO - PROCESS | 30293 | RSS: Main: 147841024 15:43:24 INFO - PROCESS | 30293 | 15:43:26 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:27 INFO - PROCESS | 30293 | RSS: Main: 145850368 15:43:27 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | Cycle 1(1): loaded http://localhost:51285/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51285/tests/kraken/driver.html?testName=ai-astar) 15:43:29 INFO - PROCESS | 30293 | RSS: Main: 147189760 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | __start_tp_report 15:43:29 INFO - PROCESS | 30293 | _x_x_mozilla_page_load 15:43:29 INFO - PROCESS | 30293 | _x_x_mozilla_page_load_details 15:43:29 INFO - PROCESS | 30293 | |i|pagename|runs| 15:43:29 INFO - PROCESS | 30293 | |0;ai-astar;111;107;112;111;112;121;111;112;112;111 15:43:29 INFO - PROCESS | 30293 | |1;audio-beat-detection;151;133;157;160;129;159;158;127;173;129 15:43:29 INFO - PROCESS | 30293 | |2;audio-dft;163;161;161;163;162;161;162;163;163;161 15:43:29 INFO - PROCESS | 30293 | |3;audio-fft;74;72;72;162;77;74;72;76;149;77 15:43:29 INFO - PROCESS | 30293 | |4;audio-oscillator;95;95;138;96;95;96;140;98;96;150 15:43:29 INFO - PROCESS | 30293 | |5;imaging-gaussian-blur;111;109;110;109;110;113;109;110;110;110 15:43:29 INFO - PROCESS | 30293 | |6;imaging-darkroom;147;146;148;146;148;147;147;147;147;146 15:43:29 INFO - PROCESS | 30293 | |7;imaging-desaturate;96;96;97;98;97;97;97;96;97;96 15:43:29 INFO - PROCESS | 30293 | |8;json-parse-financial;55;55;61;56;58;55;56;62;53;53 15:43:29 INFO - PROCESS | 30293 | |9;json-stringify-tinderbox;64;64;65;64;64;65;66;63;65;64 15:43:29 INFO - PROCESS | 30293 | |10;stanford-crypto-aes;79;81;79;80;86;79;78;78;80;80 15:43:29 INFO - PROCESS | 30293 | |11;stanford-crypto-ccm;112;117;126;114;109;116;120;125;111;109 15:43:29 INFO - PROCESS | 30293 | |12;stanford-crypto-pbkdf2;151;143;133;131;149;140;138;138;137;150 15:43:29 INFO - PROCESS | 30293 | |13;stanford-crypto-sha256-iterative;65;67;66;67;65;66;66;64;66;68 15:43:29 INFO - PROCESS | 30293 | __end_tp_report 15:43:29 INFO - PROCESS | 30293 | __start_cc_report 15:43:29 INFO - PROCESS | 30293 | _x_x_mozilla_cycle_collect,729 15:43:29 INFO - PROCESS | 30293 | __end_cc_report 15:43:29 INFO - PROCESS | 30293 | __startTimestamp1456962209478__endTimestamp 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | ------- Summary: start ------- 15:43:29 INFO - PROCESS | 30293 | Number of tests: 14 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:3.69 15:43:29 INFO - PROCESS | 30293 | Values: 111.0 107.0 112.0 111.0 112.0 121.0 111.0 112.0 112.0 111.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:157.50 stddev:16.55 (10.5%) stddev-sans-first:17.51 15:43:29 INFO - PROCESS | 30293 | Values: 151.0 133.0 157.0 160.0 129.0 159.0 158.0 127.0 173.0 129.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 15:43:29 INFO - PROCESS | 30293 | Values: 163.0 161.0 161.0 163.0 162.0 161.0 162.0 163.0 163.0 161.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#3] audio-fft Cycles:10 Average:90.50 Median:74.00 stddev:34.45 (46.6%) stddev-sans-first:36.02 15:43:29 INFO - PROCESS | 30293 | Values: 74.0 72.0 72.0 162.0 77.0 74.0 72.0 76.0 149.0 77.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.50 stddev:22.83 (23.9%) stddev-sans-first:23.57 15:43:29 INFO - PROCESS | 30293 | Values: 95.0 95.0 138.0 96.0 95.0 96.0 140.0 98.0 96.0 150.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.22 15:43:29 INFO - PROCESS | 30293 | Values: 111.0 109.0 110.0 109.0 110.0 113.0 109.0 110.0 110.0 110.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:43:29 INFO - PROCESS | 30293 | Values: 147.0 146.0 148.0 146.0 148.0 147.0 147.0 147.0 147.0 146.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:43:29 INFO - PROCESS | 30293 | Values: 96.0 96.0 97.0 98.0 97.0 97.0 97.0 96.0 97.0 96.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.21 15:43:29 INFO - PROCESS | 30293 | Values: 55.0 55.0 61.0 56.0 58.0 55.0 56.0 62.0 53.0 53.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 15:43:29 INFO - PROCESS | 30293 | Values: 64.0 64.0 65.0 64.0 64.0 65.0 66.0 63.0 65.0 64.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.00 stddev:2.31 (2.9%) stddev-sans-first:2.42 15:43:29 INFO - PROCESS | 30293 | Values: 79.0 81.0 79.0 80.0 86.0 79.0 78.0 78.0 80.0 80.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:116.50 stddev:6.15 (5.3%) stddev-sans-first:6.36 15:43:29 INFO - PROCESS | 30293 | Values: 112.0 117.0 126.0 114.0 109.0 116.0 120.0 125.0 111.0 109.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:141.50 stddev:7.06 (5.0%) stddev-sans-first:6.49 15:43:29 INFO - PROCESS | 30293 | Values: 151.0 143.0 133.0 131.0 149.0 140.0 138.0 138.0 137.0 150.0 15:43:29 INFO - PROCESS | 30293 | 15:43:29 INFO - PROCESS | 30293 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 15:43:29 INFO - PROCESS | 30293 | Values: 65.0 67.0 66.0 67.0 65.0 66.0 66.0 64.0 66.0 68.0 15:43:29 INFO - PROCESS | 30293 | -------- Summary: end -------- 15:43:29 INFO - PROCESS | 30293 | 15:43:30 INFO - TEST-INFO | 30293: exit 0 15:43:30 INFO - TEST-OK | kraken | took 59819ms 15:43:30 INFO - TEST-START | v8_7 15:43:30 INFO - operating with platform_type : linux_ 15:43:30 INFO - Initialising browser for v8_7 test... 15:43:30 INFO - TEST-INFO | started process 30587 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDG_OaS/profile http://localhost:51285/getInfo.html) 15:43:34 INFO - PROCESS | 30587 | 15:43:34 INFO - PROCESS | 30587 | (process:30668): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:43:35 INFO - PROCESS | 30587 | __metrics Screen width/height:1600/1200 15:43:35 INFO - PROCESS | 30587 | colorDepth:24 15:43:35 INFO - PROCESS | 30587 | Browser inner width/height: 1024/697 15:43:35 INFO - PROCESS | 30587 | __metrics 15:43:36 INFO - TEST-INFO | 30587: exit 0 15:43:36 INFO - Browser initialized. 15:43:36 INFO - Running cycle 1/1 for v8_7 test... 15:43:36 INFO - TEST-INFO | started process 30717 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDG_OaS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:37 INFO - PROCESS | 30717 | 15:43:37 INFO - PROCESS | 30717 | (process:30782): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:43:48 INFO - PROCESS | 30717 | RSS: Main: 141705216 15:43:48 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | Cycle 1(1): loaded http://localhost:51285/tests/v8_7/run.html (next: http://localhost:51285/tests/v8_7/run.html) 15:44:10 INFO - PROCESS | 30717 | RSS: Main: 145424384 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | __start_tp_report 15:44:10 INFO - PROCESS | 30717 | _x_x_mozilla_page_load 15:44:10 INFO - PROCESS | 30717 | _x_x_mozilla_page_load_details 15:44:10 INFO - PROCESS | 30717 | |i|pagename|runs| 15:44:10 INFO - PROCESS | 30717 | |0;Richards;167.61649346295675 15:44:10 INFO - PROCESS | 30717 | |1;DeltaBlue;170.01020061203673 15:44:10 INFO - PROCESS | 30717 | |2;Encrypt;278.2415136338342 15:44:10 INFO - PROCESS | 30717 | |3;Decrypt;5208.333333333333 15:44:10 INFO - PROCESS | 30717 | |4;RayTrace;951.4747859181732 15:44:10 INFO - PROCESS | 30717 | |5;Earley;550.05500550055 15:44:10 INFO - PROCESS | 30717 | |6;Boyer;11363.636363636364 15:44:10 INFO - PROCESS | 30717 | |7;RegExp;38735.84905660377 15:44:10 INFO - PROCESS | 30717 | |8;Splay;515.1983513652756 15:44:10 INFO - PROCESS | 30717 | |9;NavierStokes;4830.917874396136 15:44:10 INFO - PROCESS | 30717 | __end_tp_report 15:44:10 INFO - PROCESS | 30717 | __startTimestamp1456962250773__endTimestamp 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | ------- Summary: start ------- 15:44:10 INFO - PROCESS | 30717 | Number of tests: 10 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 167.6 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#1] DeltaBlue Cycles:1 Average:170.01 Median:170.01 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 170.0 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 278.2 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 5208.3 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 951.5 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#5] Earley Cycles:1 Average:550.06 Median:550.06 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 550.1 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#6] Boyer Cycles:1 Average:11363.64 Median:11363.64 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 11363.6 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#7] RegExp Cycles:1 Average:38735.85 Median:38735.85 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 38735.8 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#8] Splay Cycles:1 Average:515.20 Median:515.20 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 515.2 15:44:10 INFO - PROCESS | 30717 | 15:44:10 INFO - PROCESS | 30717 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:44:10 INFO - PROCESS | 30717 | Values: 4830.9 15:44:10 INFO - PROCESS | 30717 | -------- Summary: end -------- 15:44:10 INFO - PROCESS | 30717 | 15:44:11 INFO - TEST-INFO | 30717: exit 0 15:44:11 INFO - TEST-OK | v8_7 | took 41103ms 15:44:11 INFO - SUITE-END | took 1210s 15:44:11 INFO - Completed test suite (00:20:10) 15:44:11 INFO - Working with test: dromaeo_css 15:44:11 INFO - Generating results file: dromaeo_css 15:44:11 INFO - Working with test: kraken 15:44:11 INFO - Generating results file: kraken 15:44:11 INFO - javascript benchmark 15:44:11 INFO - Working with test: v8_7 15:44:11 INFO - Generating results file: v8_7 15:44:11 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:44:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 15:44:11 INFO - process_Request line: dromaeo_css 7278.11 graph.html#tests=[[72,52,43]] 15:44:11 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:44:11 INFO - process_Request line: kraken 1499.40 graph.html#tests=[[232,52,43]] 15:44:11 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:44:11 INFO - process_Request line: v8_7 22007.97 graph.html#tests=[[230,52,43]] 15:44:11 INFO - RETURN: dromaeo_css: 7278.11 15:44:11 INFO - RETURN: kraken: 1499.40 15:44:11 INFO - RETURN: v8_7: 22007.97 15:44:11 INFO - javascript benchmark 15:44:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3343.5987681478227, 3370.106921665759, 3372.5447064646264, 3397.4733916242985, 3399.3031428557147, 5460.071787796074, 5495.0, 5517.144842549406, 5533.584981126416, 5538.418466061066, 5454.4545545445435, 5501.367342755584, 5530.198121272413, 5531.695756733378, 5573.5819813514045, 5008.173651347523, 5055.216441451563, 5086.593072554206, 5122.974385128069, 5188.351456067991, 5002.849914502571, 5045.722485263309, 5162.6128040397125, 5163.457836927125, 5177.197534382158, 5064.670796398241, 5143.254228136918, 5158.045761534128, 5159.948400515985, 5160.174372100465, 5144.356955380577, 5190.662606930538, 5211.1922651989, 5220.373555173365, 5227.268182454441, 4982.651214414992, 5020.895403011368, 5028.723420211887, 5050.570701490377, 5105.876707124464, 5409.377921539034, 5418.810341638064, 5425.457454254582, 5438.619296649236, 5462.399136095027, 5929.466348028655, 5963.403659634046, 5989.281286245635, 5997.370276121032, 6003.249593800775, 5903.291605007426, 5998.1602575639445, 6020.066889632114, 6066.120412540201, 6097.756089756404, 5666.575006874501, 5697.715114244313, 5704.885902281972, 5717.42825717425, 5740.6268592541355, 6176.969115154396, 6187.81436556904, 6193.349698281706, 6221.0, 6228.6574238416415, 5830.82507524775, 5908.615939963888, 5939.07944268639, 6021.638701677914, 6055.1220073090035, 6073.39266073398, 6097.298810636834, 6105.053716673922, 6129.264488261437, 6132.325444201134, 5888.4700376966275, 6013.609115407572, 6022.126791615279, 6081.057436097412, 6092.147099406086, 5910.734016969247, 5960.7019649017375, 5970.701464926823, 6003.6998150093195, 6089.939100609025, 4528.909421811545, 4566.885827854264, 4572.039871626929, 4573.0396616710195, 4606.078784243165, 4054.7769872657286, 4111.259973204852, 4116.650084742771, 4134.958650413518, 4138.586141385837, 5649.6327738696855, 5655.745491452894, 5716.942830571724, 5747.568932330092, 5779.739911703983, 6020.277566692025, 6035.215421995113, 6036.396360363929, 6039.54703397247, 6065.878682426415, 5496.697681627469, 5599.216109744639, 5685.857853553694, 5686.09022556389, 5696.715164241771, 5093.0577843099145, 5134.0, 5170.663906846043, 5171.534561889448, 5171.560417364491, 6099.390060993954, 6133.754649814046, 6140.815775526741, 6151.692415379213, 6160.9383906161265, 5949.970250148895, 5971.91042134377, 6008.918394688823, 6017.849553761191, 6056.878862422639, 6143.907841382472, 6148.600340977822, 6152.569320147726, 6153.015517517176, 6170.10533472653, 5975.521958243243, 5977.462028417463, 5978.850528736816, 5989.850253743517, 6009.399060093956, 5966.552508561788, 6004.189434426471, 6046.27444706638, 6060.545459090674, 6091.451769340603, 5860.238169037998, 5954.97022514902, 5973.074173503114, 5983.102534619842, 5986.790462333972, 5873.559483038704, 5893.263342082239, 5907.054871220756, 5939.584229104094, 5975.103734439869, 5638.830835074954, 5683.062294721325, 5756.510696590669, 5799.623024503394, 5813.09896965971, 5825.330087040044, 5908.0, 5924.4667979882015, 5937.5249980000635, 5973.880522389441, 5792.160136780228, 5799.9130013049, 5810.070388737781, 5827.912581311199, 5830.2420685310635], "unit": "score", "name": "dojo.html", "value": 5542.01304892458}, {"lowerIsBetter": false, "replicates": [511.91041567725637, 576.4005434348278, 589.2369381650764, 600.9218801555799, 604.1029071828337, 30839.38321233574, 38193.0, 38489.0, 38557.42163867544, 38575.807120964426, 42291.3656295155, 42760.0, 42931.78534107333, 42958.785206074004, 43063.78468107663, 8845.601947912359, 9010.774730631754, 9029.142231487998, 9055.185033346997, 9055.456672599632, 8949.731508054769, 9073.546322683873, 9080.273578113734, 9083.545822708871, 9119.680811171611, 9059.637614495412, 9078.364514483988, 9085.273178145766, 9135.634574617008, 9150.359474836763, 9041.954790226073, 9046.592903319366, 9061.13919177677, 9100.8634870477, 9114.77213069672, 9014.86477702835, 9058.456492610465, 9114.088591140833, 9152.31357648179, 9155.633774649006, 41587.0, 41661.58338416607, 42162.156756865, 42273.78863105665, 42393.576064239576, 3574.964250357515, 3580.6061333253583, 3601.45978103284, 3628.2562074774874, 4218.346156345771, 28390.858045709847, 28774.280642984093, 28858.711412885812, 29026.85486572575, 29560.113196604136, 4102.220578090153, 4116.629503344713, 4140.192662430827, 4166.8749937501925, 4199.475065616798, 298309.0, 300884.0, 300907.0, 301173.0, 301411.0, 43920.3411948821, 44171.337429938576, 44331.55668443274, 44359.112817743466, 65177.67411162914, 43452.0, 43555.0, 43665.34501982473, 43717.78141109274, 43807.0, 14623.195724235056, 14719.705605887822, 14775.92612036933, 14778.48275310359, 14791.92604036973, 12283.815742763687, 12292.262464252173, 12335.629931102081, 12341.568045118378, 12358.814617780741, 15060.623484412978, 15102.320395582225, 15166.090034597959, 15240.161791101596, 15278.236088195768, 6016.729247183887, 6107.297660769068, 6127.785527506516, 6216.658083805343, 6231.813045608639, 1018.6689325968941, 1064.6486659402378, 1065.3075500924306, 1067.5836423794726, 1109.3343993603773, 31443.685563144532, 31865.0, 33593.0, 34066.82966585151, 34139.658603414144, 1144.1075960750627, 1164.1443538998828, 1178.8938995490446, 1194.9581764638197, 1253.367049639926, 15316.15761133126, 17857.196426160855, 17936.0, 17968.55154826586, 17998.37005704794, 307426.0, 467373.0, 473147.0, 477113.45773084345, 485758.0, 56343.0, 57151.0, 57209.14186287209, 57317.426825732044, 57397.0, 1491.7986071880375, 1498.4530646314017, 1501.2493753123438, 1511.7203317386318, 1515.3559737111684, 29878.0, 30159.0, 30698.0, 31411.685883140875, 31606.209844754067, 50132.0, 50839.0, 51013.999999998516, 51030.0, 51116.0, 317346.0, 319951.0, 320105.0, 320299.0, 320391.0, 35979.46030809592, 50939.74530127326, 51046.74476627593, 51776.48223517867, 52074.21888671597, 46994.29508557443, 47324.7633761829, 47479.52520474751, 47560.33538826124, 47702.284465733734, 40023.39964900471, 40681.38977915274, 43178.0, 44865.327020094075, 45016.324755128044, 40309.596904030586, 40799.59200407958, 41072.383914240716, 42818.0, 44292.7785361084, 38795.22409551737, 39221.41167882427, 39301.41047884341, 39406.2118757629, 44119.77940110279, 32301.35397292088, 33277.1593128259, 35131.0, 35475.29049418945, 35690.10774730652, 27586.310342241606, 28382.29044273827, 28387.290317742223, 28399.148025559265, 28430.004949827486], "unit": "score", "name": "ext.html", "value": 19443.596312348276}, {"lowerIsBetter": false, "replicates": [372.2331996088057, 373.6487701560533, 374.3523703992095, 375.2850819189445, 377.8696349759333, 15704.214789260548, 16424.260908259126, 17729.0, 18020.729689054657, 18544.258229670813, 10007.59969601215, 10196.133328667072, 17194.82805171951, 17269.91365043173, 17835.37576184834, 5156.587473002161, 5274.367075950891, 5282.656627319231, 5299.28459657947, 5693.316801983747, 3997.5202975642965, 4090.141070375225, 5604.355499117612, 5658.434156584329, 5666.603337766358, 5392.865178370553, 5505.834824955237, 5511.035568775468, 5564.8052318168875, 5570.442955704438, 5460.672359658433, 5804.477597016267, 6125.632462052291, 6150.323464418932, 6174.783882564134, 5243.2659427680155, 5444.210589464545, 5446.101393270105, 5454.61817672763, 5474.343078830526, 19846.900765496226, 19884.60230795376, 19941.50146246341, 21154.365369038955, 21362.359129226148, 2230.2194232018824, 2272.091163534599, 2319.4433335999406, 2321.303608917318, 2366.8343215974887, 9618.51907404627, 9729.221662267002, 9982.90017099827, 10805.675829725122, 12374.62876113718, 1687.190148728605, 1851.3612803582741, 1924.1341396371688, 1933.8936358500277, 2035.0943829995658, 58817.7059114706, 59417.40582594162, 59968.400315997154, 60040.699796501176, 61625.0, 10542.525586348633, 10628.574857005788, 10630.46847657614, 10644.095251903675, 10747.623833165959, 13618.659533511543, 13665.521706740217, 13686.794698079337, 13708.52020179309, 13771.655708607364, 7795.688172473151, 7855.921440785519, 8054.677812887536, 8098.392620553482, 8124.7562573122905, 7910.2089791020435, 8025.23760242776, 8028.919710802934, 8096.878546821685, 8115.3507719382305, 4454.354118652777, 4516.683832131785, 4523.0, 4565.520620334817, 4633.837815676435, 1727.93952211672, 1792.8386445219992, 1821.8815776974454, 1826.5433641589602, 1886.104100552254, 1010.9191264698953, 1022.4580972084807, 1042.1506472225112, 1066.5573786878358, 1157.0743405275746, 17159.399421020455, 17505.64988700219, 17686.823131768775, 17932.641347172983, 18195.545111372056, 996.6013594562088, 1037.5590374091132, 1040.4069680282319, 1049.2550289294686, 1078.2290662176424, 10331.12185464229, 10351.896481035094, 10362.171026317876, 10475.790484190426, 10480.423576703355, 397684.0, 399733.0, 401085.0, 596791.0, 601969.0, 75614.0, 81047.0, 81400.59299703463, 81734.0, 82992.58503707564, 1162.9418529073512, 1193.093249130667, 1248.4818800197997, 1248.9250644961332, 1249.0257599072738, 16454.34182632729, 16481.587960301087, 16511.0, 16512.917435412746, 16927.915360423613, 33819.830900846326, 34121.82939085289, 34494.31011379708, 35544.0, 35765.82117089398, 45671.0, 46355.304670429294, 46480.535194648975, 46957.0, 46958.0, 7654.387648987956, 7880.3301719354495, 7903.604819758874, 7906.9209307906185, 8003.39974501903, 7844.803879903048, 10632.734181645521, 11832.881671183179, 12033.63899083029, 12136.150469467053, 3291.851866665958, 8564.700235491728, 9141.680041198526, 9302.860457093013, 10543.683689489328, 10040.0, 10219.897801021894, 10523.105536029523, 10948.233623646269, 11073.83389249178, 9604.855927161238, 10091.7477063074, 10357.067863892285, 10528.526216320437, 10669.199810014436, 7365.9631701841145, 7391.889121663287, 7759.534427934342, 7828.725994590162, 7908.485948413335, 9424.764380890532, 9580.56887440053, 10246.180305575685, 10435.0, 10482.37105773656], "unit": "score", "name": "jquery.html", "value": 8498.835131686323}, {"lowerIsBetter": false, "replicates": [1520.5134357005759, 1548.1021007815468, 1770.4511601403558, 1860.0699650174913, 1908.8663793534458, 7852.293293603575, 7952.125266220718, 7990.360771138309, 8085.91914080859, 8115.553644549547, 8119.634616442259, 8122.878156827653, 8164.755057348274, 8187.754367368989, 8195.754127376173, 2386.6777984972023, 2406.458546826959, 2424.0788500369836, 2426.296374051523, 2428.101602407112, 2406.4585468269674, 2418.9758102419014, 2454.5336386086674, 2455.4966231922504, 2459.692538432696, 2304.758000409958, 2359.9410014749683, 2360.5396947595227, 2411.9276421707377, 2417.697787776528, 2385.904563817454, 2389.80881529479, 2399.256230568529, 2400.243923164198, 2405.8195635327334, 2398.4963157736897, 2412.1195763546357, 2417.395651087228, 2419.552382809186, 2420.9394765130837, 7942.841143177104, 8085.636146373427, 8119.512829230265, 8149.551774652392, 8230.794230144234, 4862.6353023523025, 4962.206047032493, 4971.229459433794, 4982.377202849644, 5000.349954505891, 3017.396520695848, 3050.4814181588963, 3076.077176846937, 3098.4887493563533, 3134.0127859724116, 939.1406862720603, 945.0313428735533, 2040.2349119080345, 2072.4611600983703, 2134.679798030292, 10642.574297028186, 10884.836727449094, 10909.890901090967, 10945.616903408421, 11012.284201526954, 4333.978330108329, 4350.1734670412525, 4391.209582275221, 4408.360787685768, 4451.376807246988, 9469.431834089839, 9523.857142142873, 9548.37935534202, 9561.139497445125, 9583.377080489747, 4928.926066109011, 4937.23472861707, 4963.329950456714, 4966.180580204225, 5000.474950130257, 4442.777861106932, 4497.280435130363, 4501.0, 4516.525764794649, 4520.0, 3761.6614504694708, 3858.7684738915755, 3905.2189562087697, 3911.8239679214503, 3915.941260881089, 1180.2328486483855, 1196.5871774237874, 1201.2132053504968, 1220.8718084601167, 1234.8086046662781, 1186.2704436771496, 1202.7233736240714, 1245.4333278358324, 1400.8879289656802, 1420.2117824607235, 7117.82205444868, 7336.486445948733, 7411.0736157980255, 7415.3326200642205, 7421.369183619345, 640.4492136762381, 652.9347065293433, 653.9247986481521, 658.1279804259375, 801.8373358630009, 5621.0444224481935, 5705.828825135252, 5742.54059675225, 5744.281964754406, 5751.396103409165, 9378.95310523443, 9665.081817227352, 9698.272629552812, 9983.550740216708, 10005.249606279413, 9762.121409073075, 9801.362911410879, 9834.0, 9870.25973052024, 9931.950340248253, 7540.622968851536, 7660.80847978805, 7716.884246736304, 7755.68977240904, 7814.374850011872, 7171.103612048494, 7211.6033618151505, 7225.096862892138, 7263.128424589083, 7311.817204569928, 8491.72624106389, 8626.18051285152, 8878.422902511316, 8937.59780809878, 8954.597043132944, 8887.822243555222, 8903.0, 8921.955390223267, 8953.462792232487, 9087.636494540144, 7346.11846578414, 7393.963030184815, 7402.481826272109, 7429.517081389692, 7446.218147094693, 7842.568658723825, 7862.606869656609, 7906.683732650629, 7907.209279072277, 7963.601819908866, 7161.462890283354, 7176.318249766264, 7187.8562428752175, 7285.854282914206, 7320.450966177452, 6995.580265184105, 7157.105361829771, 7200.603966781878, 7209.927900721135, 7240.674169662272, 7228.819279518054, 7258.0, 7286.7085316586745, 7297.744578939712, 7302.452316076209, 6633.038209459698, 6676.499262555425, 6689.565178263398, 6689.5986240825705, 6704.195496540447, 6467.708953097216, 6553.934460655332, 6554.115194448879, 6558.278589355072, 6570.638614876228], "unit": "score", "name": "mootools.html", "value": 4674.505713883801}, {"lowerIsBetter": false, "replicates": [355.3851836323161, 355.7829723868439, 357.2533405183168, 357.4370366672492, 364.2314715949348, 6397.680115994199, 6404.199475065617, 6441.613503189806, 6475.708593113315, 6526.379993900572, 6248.968755156217, 6375.426211640963, 6406.775762848301, 6435.356464353574, 6443.48452123829, 4912.754362281889, 4939.160342741725, 4948.406191257054, 4951.0592987332475, 4964.304997300381, 4950.801967921278, 4954.851354459354, 4961.156603377434, 4962.280469331945, 4964.056829202458, 4691.601213896823, 4806.471288158317, 4809.446913604946, 4823.0, 4840.878978025542, 4787.473377928425, 4790.520947905216, 4801.73590452525, 4810.879728006793, 4825.951740482603, 4200.642945349649, 4208.452901122834, 4209.368594710787, 4212.557681443435, 4218.704690671654, 6061.636301821904, 6124.142620033199, 6138.447539721402, 6168.475679567242, 6176.598521096114, 5655.717214139277, 5660.377358490563, 5669.8582535436535, 5672.716364181774, 5682.687452190128, 6768.76309329176, 6788.151481064867, 6809.182898052265, 6819.113515243036, 6824.078749368871, 4663.440387153563, 4678.789454474557, 4679.438467383901, 4694.155052090657, 4713.787879545429, 6961.095057642525, 7040.507164498487, 7075.2570980047385, 7109.289071092901, 7119.359257666835, 4768.61851051915, 4774.785134668949, 4776.522347765265, 4793.400824896888, 4815.036992601494, 4847.612191024709, 4850.957044235506, 4852.708837469763, 4855.44162421319, 4871.244957031666, 5516.200150978086, 5654.0, 5655.575831812631, 5658.745356458887, 5667.688277144796, 6842.726290948306, 6907.516473846783, 6914.861702765917, 6915.412189963909, 6924.965375173092, 1641.359869650837, 1669.8580620647137, 1742.7995780485153, 1778.3509019208154, 1785.544686105035, 1205.1684337806885, 1205.9155859089778, 1208.190512356723, 1224.9755004899853, 1225.7180848404917, 6509.804705858832, 6544.803655890331, 6546.378094081055, 6546.934530654633, 6548.934510654833, 6873.312668733087, 6960.234374218832, 6963.199232088375, 6973.267806880306, 6977.2673869243, 6387.041943708481, 6473.514486413444, 6512.869742605121, 6540.607563546202, 6552.803415897531, 3793.639604237593, 3799.544054713452, 3820.2168555446065, 3838.846446142123, 3844.8462061517225, 7129.287071292829, 7143.89284160738, 7146.714131434788, 7196.064511613561, 7206.315400036988, 7008.229094799568, 7149.53528020677, 7152.4278057755255, 7181.856362872713, 7183.46124040699, 7112.217656057829, 7144.857102857914, 7158.713651453988, 7172.892406613905, 7175.067241258707, 6911.516193866381, 6927.203371612128, 6941.201761797458, 6967.860642787217, 6974.965125174342, 6709.396154345937, 6874.9656251718425, 6875.518713689994, 6876.037354770237, 6878.174619045746, 7137.429005679637, 7174.784756457315, 7175.605341706257, 7182.0, 7201.603911784692, 4866.853994380174, 4870.147724148331, 4883.389576302962, 4884.194107972145, 4885.560299573055, 6892.517523773287, 6949.3745562899585, 6960.443164546926, 6989.720411183495, 7010.509264351446, 6708.597484150967, 6738.056672066013, 6740.966295168493, 6796.694148763218, 6811.65941702903, 6744.69648865812, 6758.797236082925, 6775.661216939232, 6786.59280443175, 6799.490038247251, 6524.706388212447, 6628.83427914306, 6641.800745977628, 6659.267480577036, 6674.798536263519, 6763.628000459825, 6786.287439818748, 6820.215675197416, 6825.795226143224, 6828.624425656637, 6576.145101136822, 6647.601143931186, 6665.866682666223, 6667.633280169637, 6670.132362938385], "unit": "score", "name": "prototype.html", "value": 5119.131453438985}, {"lowerIsBetter": false, "replicates": [864.6238886084553, 880.2341962492633, 888.804463018136, 918.8070505193909, 920.3649481857518, 14551.41794328227, 14748.115113093208, 14816.555503334917, 14898.106113633175, 14923.552293431187, 13424.530141445051, 13434.39545220465, 13529.458821647147, 13619.591412257623, 13629.931850340734, 859.9656013759442, 873.2620935309653, 896.2158111652304, 902.0979020979021, 903.850864607339, 893.8212357528488, 894.6421431427416, 895.6372669069037, 897.0670502677208, 900.2842740021666, 908.7546362482126, 911.421247507834, 917.40368760306, 918.3984490158956, 921.5898924978387, 911.3848152497104, 918.283738683821, 918.554501066982, 918.9586468608928, 919.4345477531336, 682.6654939079865, 683.4703105093542, 685.1777866560147, 687.041577000087, 688.7486067585295, 15060.924695376563, 15163.241837908061, 15172.089674619448, 15242.771358429633, 15243.16162611056, 13520.0, 13565.864341356559, 13717.17696938177, 13742.0, 13763.862361376358, 11106.278091924, 11277.605283815026, 11895.702607434796, 12082.456289466994, 12092.879071209263, 3932.8623498177426, 3950.6246906543834, 3975.3043217436834, 3991.501062367204, 4012.0371110933456, 47496.7625161872, 48231.0, 48334.51665483335, 48364.516354836356, 48821.75589122032, 11414.828777568344, 11437.542498300141, 11597.0, 11804.58683946075, 11986.52053917851, 19443.708344374845, 19560.804391956182, 19622.0, 19715.40853774389, 19728.30950916711, 8259.752207433787, 8293.626786794608, 8351.665933362598, 8520.957395212985, 8634.050254472004, 4680.602148817321, 4695.5304469552775, 4748.501407352247, 4780.402449693788, 4840.975795121002, 3269.1336795749144, 3293.720033797154, 3297.3075654112426, 3307.6030876295, 3322.086426232757, 602.2141105856899, 603.4629180029777, 609.5793902207463, 610.6519284008161, 615.1388056720538, 656.2944834303144, 661.7749965011919, 697.3444961736053, 719.0652152202116, 723.8914162875611, 8690.913090869137, 9114.81770364589, 9167.679131230376, 9186.816263674822, 9187.77030574241, 658.2397331082511, 691.3225039461356, 733.336330620789, 788.286600626434, 791.8851766493826, 4347.0, 4457.7548234846745, 4469.642428605769, 4684.133435314409, 4721.220998535272, 61504.69247653733, 62779.6861015692, 62907.37092629106, 62924.37075629185, 63014.36985630085, 53865.46134538683, 53993.0, 54348.45651543513, 54407.72796136073, 54565.72717136389, 48109.0, 48854.755726221854, 48859.75570122198, 48950.51049489531, 49477.0, 9007.90992090097, 9078.773030674285, 9330.533473326443, 9345.345825792401, 9421.481818499775, 33659.32681346408, 33800.1549961253, 33931.49102763411, 34005.319893601496, 34600.82699586486, 38905.805470973595, 40801.1839763209, 44388.33417498805, 44422.3336649944, 44607.33089003603, 10374.533146008598, 10485.737856553342, 10520.21098417637, 10762.623308184176, 11314.0, 12056.539080540257, 12066.818997714865, 12130.454129564367, 12162.939185304016, 12217.266963982189, 11790.292582445081, 11938.164328496921, 12110.212836165621, 12141.271523708605, 12453.128281020241, 11346.262492937933, 11497.965183133558, 11803.881961180277, 11836.58571950012, 12199.024078073555, 11575.536978520764, 12708.745825083632, 12958.28729419891, 12976.351182441029, 13105.14816536922, 10219.335743176669, 10269.897301027193, 10366.896331036593, 10461.529231184462, 10483.213758967955, 10440.321379110334, 10671.786564268827, 10675.946620266848, 11057.22599418033, 11127.72180695489], "unit": "score", "name": "yui.html", "value": 6781.704735775609}], "name": "dromaeo_css", "value": 7278.105125136966}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 111.0, 112.0, 121.0, 111.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [151.0, 133.0, 157.0, 160.0, 129.0, 159.0, 158.0, 127.0, 173.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 163.0, 162.0, 161.0, 162.0, 163.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 162.0, 77.0, 74.0, 72.0, 76.0, 149.0, 77.0], "unit": "score", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 138.0, 96.0, 95.0, 96.0, 140.0, 98.0, 96.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 109.0, 110.0, 113.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 98.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 61.0, 56.0, 58.0, 55.0, 56.0, 62.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 66.0, 63.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 79.0, 80.0, 86.0, 79.0, 78.0, 78.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [112.0, 117.0, 126.0, 114.0, 109.0, 116.0, 120.0, 125.0, 111.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [151.0, 143.0, 133.0, 131.0, 149.0, 140.0, 138.0, 138.0, 137.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 64.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1499.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [170.01020061203673], "unit": "score", "name": "DeltaBlue", "value": 388.9060759999999}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [550.05500550055], "unit": "score", "name": "Earley", "value": 1211.629734}, {"lowerIsBetter": false, "replicates": [11363.636363636364], "unit": "score", "name": "Boyer", "value": 58.64874400000003}, {"lowerIsBetter": false, "replicates": [38735.84905660377], "unit": "score", "name": "RegExp", "value": 23.517878714076947}, {"lowerIsBetter": false, "replicates": [515.1983513652756], "unit": "score", "name": "Splay", "value": 158.174031}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22007.971655133995}]} 15:44:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22007.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7278.11"}}} 15:44:12 INFO - Return code: 0 15:44:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:44:12 INFO - # TBPL SUCCESS # 15:44:12 INFO - Running post-action listener: _resource_record_post_action 15:44:12 INFO - Running post-run listener: _resource_record_post_run 15:44:13 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 266240; Write bytes: 528699392; Read time: 280; Write time: 505396 15:44:13 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 260112384; Read time: 0; Write time: 309392 15:44:13 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 266240; Write bytes: 268587008; Read time: 280; Write time: 196004 15:44:13 INFO - Running post-run listener: _upload_blobber_files 15:44:13 INFO - Blob upload gear active. 15:44:13 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:44:13 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 15:44:13 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'] 15:44:13 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 15:44:13 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:14 INFO - (blobuploader) - INFO - Done attempting. 15:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:15 INFO - (blobuploader) - INFO - Done attempting. 15:44:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:15 INFO - Return code: 0 15:44:15 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:44:15 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/274d16c7e6d26e0a14e0cb6d16a9a3d8a393c1501bc77190443b6e5aee7fc54cdf3d1c19f0124812422d09f32b65e7174729358029968c2c0013c5a5d07cf807", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8aefc61fe3162693d00443f1bfd3ead037be318c187d1f8a50b6360db3a138bf20dc01925bd4ef5841c6391658dd39e0c41a68417fb2c50f6587ee5b236c0ca"} 15:44:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:44:15 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:44:15 INFO - Contents: 15:44:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/274d16c7e6d26e0a14e0cb6d16a9a3d8a393c1501bc77190443b6e5aee7fc54cdf3d1c19f0124812422d09f32b65e7174729358029968c2c0013c5a5d07cf807", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8aefc61fe3162693d00443f1bfd3ead037be318c187d1f8a50b6360db3a138bf20dc01925bd4ef5841c6391658dd39e0c41a68417fb2c50f6587ee5b236c0ca"} 15:44:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:15 INFO - Copying logs to upload dir... 15:44:15 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:44:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.728251 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-03-02 15:44:15.580579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 15:44:15.584718) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/274d16c7e6d26e0a14e0cb6d16a9a3d8a393c1501bc77190443b6e5aee7fc54cdf3d1c19f0124812422d09f32b65e7174729358029968c2c0013c5a5d07cf807", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8aefc61fe3162693d00443f1bfd3ead037be318c187d1f8a50b6360db3a138bf20dc01925bd4ef5841c6391658dd39e0c41a68417fb2c50f6587ee5b236c0ca"} build_url:https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/AKmItfE_T1qvBpMnQ3s3Qw/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/274d16c7e6d26e0a14e0cb6d16a9a3d8a393c1501bc77190443b6e5aee7fc54cdf3d1c19f0124812422d09f32b65e7174729358029968c2c0013c5a5d07cf807", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a8aefc61fe3162693d00443f1bfd3ead037be318c187d1f8a50b6360db3a138bf20dc01925bd4ef5841c6391658dd39e0c41a68417fb2c50f6587ee5b236c0ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 15:44:15.609415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:44:15.609745) ========= 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=eca2ab57546de7b41f256b19000001ef-1456960452.826420-1085802246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 15:44:15.695717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 15:44:15.696304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 15:44:15.696769) ========= ========= Total master_lag: 0.65 =========