builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1453637052.76 results: success (0) buildid: 20160124013032 builduid: 1a05985f496c434e83c784e3b3832f61 revision: 221b4255e3e858fcb4baa1e2989cdab63324ac23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:12.755400) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:12.755890) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:12.756320) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006493 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:12.892508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:12.892842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.145244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.145558) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.267578) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.267880) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.268282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.268656) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-24 04:04:14-- 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% 218M=0s 2016-01-24 04:04:14 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197311 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.500857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.501189) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018096 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.551073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:13.551445) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 221b4255e3e858fcb4baa1e2989cdab63324ac23 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 221b4255e3e858fcb4baa1e2989cdab63324ac23 --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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-24 04:04:14,488 truncating revision to first 12 chars 2016-01-24 04:04:14,488 Setting DEBUG logging. 2016-01-24 04:04:14,488 attempt 1/10 2016-01-24 04:04:14,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/221b4255e3e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-24 04:04:14,751 unpacking tar archive at: mozilla-inbound-221b4255e3e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535078 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:14.111121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:14.111491) ========= echo 221b4255e3e858fcb4baa1e2989cdab63324ac23 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'221b4255e3e858fcb4baa1e2989cdab63324ac23'] 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 221b4255e3e858fcb4baa1e2989cdab63324ac23 program finished with exit code 0 elapsedTime=0.004706 script_repo_revision: '221b4255e3e858fcb4baa1e2989cdab63324ac23' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:14.169020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:14.169773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-24 04:04:14.185766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-24 04:04:14.186069) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:04:15 INFO - MultiFileLogger online at 20160124 04:04:15 in /builds/slave/test-pgo 04:04:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:04:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:04:15 INFO - {'append_to_log': False, 04:04:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:04:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:04:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:04:15 INFO - 'branch': 'Mozilla-Inbound', 04:04:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:15 INFO - 'config_files': ('talos/linux_config.py',), 04:04:15 INFO - 'default_actions': ('clobber', 04:04:15 INFO - 'read-buildbot-config', 04:04:15 INFO - 'download-and-extract', 04:04:15 INFO - 'populate-webroot', 04:04:15 INFO - 'create-virtualenv', 04:04:15 INFO - 'install', 04:04:15 INFO - 'run-tests'), 04:04:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:15 INFO - 'download_minidump_stackwalk': True, 04:04:15 INFO - 'download_symbols': 'ondemand', 04:04:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:15 INFO - 'installer_path': 'installer.exe', 04:04:15 INFO - 'log_level': 'info', 04:04:15 INFO - 'log_name': 'talos', 04:04:15 INFO - 'log_to_console': True, 04:04:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:04:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:04:15 INFO - 'opt_config_files': (), 04:04:15 INFO - 'pip_index': False, 04:04:15 INFO - 'sps_profile': False, 04:04:15 INFO - 'sps_profile_interval': 0, 04:04:15 INFO - 'suite': 'dromaeojs-e10s', 04:04:15 INFO - 'system_bits': '32', 04:04:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:15 INFO - 'title': 'talos-linux64-ix-055', 04:04:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:15 INFO - 'use_talos_json': True, 04:04:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:04:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:15 INFO - 'work_dir': 'build'} 04:04:15 INFO - ##### 04:04:15 INFO - ##### Running clobber step. 04:04:15 INFO - ##### 04:04:15 INFO - Running pre-action listener: _resource_record_pre_action 04:04:15 INFO - Running main action method: clobber 04:04:15 INFO - rmtree: /builds/slave/test-pgo/build 04:04:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:04:16 INFO - Running post-action listener: _resource_record_post_action 04:04:16 INFO - ##### 04:04:16 INFO - ##### Running read-buildbot-config step. 04:04:16 INFO - ##### 04:04:16 INFO - Running pre-action listener: _resource_record_pre_action 04:04:16 INFO - Running main action method: read_buildbot_config 04:04:16 INFO - Using buildbot properties: 04:04:16 INFO - { 04:04:16 INFO - "project": "", 04:04:16 INFO - "product": "firefox", 04:04:16 INFO - "script_repo_revision": "production", 04:04:16 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:04:16 INFO - "repository": "", 04:04:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:04:16 INFO - "buildid": "20160124013032", 04:04:16 INFO - "pgo_build": "True", 04:04:16 INFO - "basedir": "/builds/slave/test-pgo", 04:04:16 INFO - "buildnumber": 339, 04:04:16 INFO - "slavename": "talos-linux64-ix-055", 04:04:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:04:16 INFO - "platform": "ubuntu64_hw", 04:04:16 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:04:16 INFO - "branch": "mozilla-inbound", 04:04:16 INFO - "repo_path": "integration/mozilla-inbound", 04:04:16 INFO - "revision": "221b4255e3e858fcb4baa1e2989cdab63324ac23", 04:04:16 INFO - "stage_platform": "linux64-pgo", 04:04:16 INFO - "builduid": "1a05985f496c434e83c784e3b3832f61", 04:04:16 INFO - "slavebuilddir": "test" 04:04:16 INFO - } 04:04:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:04:16 INFO - Running post-action listener: _resource_record_post_action 04:04:16 INFO - ##### 04:04:16 INFO - ##### Running download-and-extract step. 04:04:16 INFO - ##### 04:04:16 INFO - Running pre-action listener: _resource_record_pre_action 04:04:16 INFO - Running main action method: download_and_extract 04:04:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:04: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')]} 04:04:16 INFO - https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/test_packages.json 04:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/test_packages.json 04:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:04:22 INFO - Downloaded 1448 bytes. 04:04:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:04:22 INFO - Using the following test package requirements: 04:04:22 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:22 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:04:22 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:04:22 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'jsshell-linux-x86_64.zip'], 04:04:22 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:04:22 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:22 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:04:22 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:04:22 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:04:22 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:04:22 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:04:22 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:04:22 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:04:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:22 INFO - https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:04:24 INFO - Downloaded 22491924 bytes. 04:04:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:04:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:04:25 INFO - Return code: 0 04:04:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:04: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')]} 04:04:25 INFO - https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:04:27 INFO - Downloaded 22491924 bytes. 04:04:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:04:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:04:29 INFO - Return code: 0 04:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:29 INFO - https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:04:29 INFO - Downloaded 10706572 bytes. 04:04:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:04:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:04:30 INFO - Return code: 0 04:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:30 INFO - https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:04:31 INFO - Downloaded 55989382 bytes. 04:04:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:04:31 INFO - mkdir: /builds/slave/test-pgo/properties 04:04:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:04:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:04:31 INFO - Contents: 04:04:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:04:31 INFO - Running post-action listener: _resource_record_post_action 04:04:31 INFO - Running post-action listener: set_extra_try_arguments 04:04:31 INFO - ##### 04:04:31 INFO - ##### Running populate-webroot step. 04:04:31 INFO - ##### 04:04:31 INFO - Running pre-action listener: _resource_record_pre_action 04:04:31 INFO - Running main action method: populate_webroot 04:04:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:04:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:04:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:04:31 INFO - '--tppagecycles', 04:04:31 INFO - '7'], 04:04:31 INFO - 'tests': ['tsvgm']}}, 04:04:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:04:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:04:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:04:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:04:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:04:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'tests': ['damp', 'tps']}, 04:04:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['damp', 'tps']}, 04:04:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:04:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:04:31 INFO - 'other': {'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'other_l64': {'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:04:31 INFO - 'ts_paint', 04:04:31 INFO - 'tpaint', 04:04:31 INFO - 'sessionrestore', 04:04:31 INFO - 'sessionrestore_no_auto_restore']}, 04:04:31 INFO - 'svgr': {'tests': ['tsvgx', 04:04:31 INFO - 'tsvgr_opacity', 04:04:31 INFO - 'tart', 04:04:31 INFO - 'tscrollx', 04:04:31 INFO - 'cart']}, 04:04:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['tsvgx', 04:04:31 INFO - 'tsvgr_opacity', 04:04:31 INFO - 'tart', 04:04:31 INFO - 'tscrollx', 04:04:31 INFO - 'cart']}, 04:04:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'tests': ['tp5o']}, 04:04:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'talos_options': ['--e10s'], 04:04:31 INFO - 'tests': ['tp5o']}, 04:04:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'talos_options': ['--xperf_path', 04:04:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:31 INFO - 'tests': ['tp5n']}, 04:04:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:04:31 INFO - 'talos_options': ['--e10s', 04:04:31 INFO - '--xperf_path', 04:04:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:04:31 INFO - 'tests': ['tp5n']}}, 04:04:31 INFO - 'talos.zip': {'path': '', 04:04:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:04:31 INFO - Running post-action listener: _resource_record_post_action 04:04:31 INFO - ##### 04:04:31 INFO - ##### Running create-virtualenv step. 04:04:31 INFO - ##### 04:04:31 INFO - Running pre-action listener: _resource_record_pre_action 04:04:31 INFO - Running main action method: create_virtualenv 04:04:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:04:31 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 04:04:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:04:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:04:31 INFO - Using real prefix '/usr' 04:04:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:04:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:04:34 INFO - Installing pip.................done. 04:04:34 INFO - Return code: 0 04:04:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:04: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')]} 04:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:34 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:34 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 04:04:34 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 04:04:34 INFO - Using env: {'DISPLAY': ':0', 04:04:34 INFO - 'HOME': '/home/cltbld', 04:04:34 INFO - 'LANG': 'en_US.UTF-8', 04:04:34 INFO - 'LANGUAGE': 'en_US:en', 04:04:34 INFO - 'LOGNAME': 'cltbld', 04:04:34 INFO - 'MAIL': '/var/mail/cltbld', 04:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:34 INFO - 'MOZ_NO_REMOTE': '1', 04:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:34 INFO - 'NO_EM_RESTART': '1', 04:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:34 INFO - 'SHELL': '/bin/bash', 04:04:34 INFO - 'SHLVL': '1', 04:04:34 INFO - 'TERM': 'linux', 04:04:34 INFO - 'TMOUT': '86400', 04:04:34 INFO - 'USER': 'cltbld', 04:04:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:34 INFO - '_': '/tools/buildbot/bin/python'} 04:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:34 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 04:04:34 INFO - Cleaning up... 04:04:34 INFO - Return code: 0 04:04:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:04: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')]} 04:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:34 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:34 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 04:04:34 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 04:04:34 INFO - Using env: {'DISPLAY': ':0', 04:04:34 INFO - 'HOME': '/home/cltbld', 04:04:34 INFO - 'LANG': 'en_US.UTF-8', 04:04:34 INFO - 'LANGUAGE': 'en_US:en', 04:04:34 INFO - 'LOGNAME': 'cltbld', 04:04:34 INFO - 'MAIL': '/var/mail/cltbld', 04:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:34 INFO - 'MOZ_NO_REMOTE': '1', 04:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:34 INFO - 'NO_EM_RESTART': '1', 04:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:34 INFO - 'SHELL': '/bin/bash', 04:04:34 INFO - 'SHLVL': '1', 04:04:34 INFO - 'TERM': 'linux', 04:04:34 INFO - 'TMOUT': '86400', 04:04:34 INFO - 'USER': 'cltbld', 04:04:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:34 INFO - '_': '/tools/buildbot/bin/python'} 04:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:34 INFO - Downloading/unpacking psutil>=0.7.1 04:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:36 INFO - Installing collected packages: psutil 04:04:36 INFO - Running setup.py install for psutil 04:04:36 INFO - building 'psutil._psutil_linux' extension 04:04:36 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 04:04:36 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 04:04:36 INFO - building 'psutil._psutil_posix' extension 04:04:36 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 04:04:36 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 04:04:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:04:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:04:36 INFO - Successfully installed psutil 04:04:36 INFO - Cleaning up... 04:04:37 INFO - Return code: 0 04:04:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:04:37 INFO - Using env: {'DISPLAY': ':0', 04:04:37 INFO - 'HOME': '/home/cltbld', 04:04:37 INFO - 'LANG': 'en_US.UTF-8', 04:04:37 INFO - 'LANGUAGE': 'en_US:en', 04:04:37 INFO - 'LOGNAME': 'cltbld', 04:04:37 INFO - 'MAIL': '/var/mail/cltbld', 04:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:37 INFO - 'MOZ_NO_REMOTE': '1', 04:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:37 INFO - 'NO_EM_RESTART': '1', 04:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:37 INFO - 'SHELL': '/bin/bash', 04:04:37 INFO - 'SHLVL': '1', 04:04:37 INFO - 'TERM': 'linux', 04:04:37 INFO - 'TMOUT': '86400', 04:04:37 INFO - 'USER': 'cltbld', 04:04:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:37 INFO - '_': '/tools/buildbot/bin/python'} 04:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:04:37 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 04:04:37 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 04:04:37 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 04:04:37 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 04:04:37 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 04:04:37 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 04:04:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:04:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:04:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:04:39 INFO - Installing collected packages: mozsystemmonitor 04:04:39 INFO - Running setup.py install for mozsystemmonitor 04:04:39 INFO - Successfully installed mozsystemmonitor 04:04:39 INFO - Cleaning up... 04:04:39 INFO - Return code: 0 04:04:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:04: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')]} 04:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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')]} 04:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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', '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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:04: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 blobuploader==1.2.4 04:04:39 INFO - Using env: {'DISPLAY': ':0', 04:04:39 INFO - 'HOME': '/home/cltbld', 04:04:39 INFO - 'LANG': 'en_US.UTF-8', 04:04:39 INFO - 'LANGUAGE': 'en_US:en', 04:04:39 INFO - 'LOGNAME': 'cltbld', 04:04:39 INFO - 'MAIL': '/var/mail/cltbld', 04:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:39 INFO - 'MOZ_NO_REMOTE': '1', 04:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:39 INFO - 'NO_EM_RESTART': '1', 04:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:39 INFO - 'SHELL': '/bin/bash', 04:04:39 INFO - 'SHLVL': '1', 04:04:39 INFO - 'TERM': 'linux', 04:04:39 INFO - 'TMOUT': '86400', 04:04:39 INFO - 'USER': 'cltbld', 04:04:39 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:39 INFO - '_': '/tools/buildbot/bin/python'} 04:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:04:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:04:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04: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 04:04:41 INFO - Downloading docopt-0.6.1.tar.gz 04:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:41 INFO - Running setup.py install for blobuploader 04:04:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:04:41 INFO - Running setup.py install for requests 04:04:42 INFO - Running setup.py install for docopt 04:04:42 INFO - Successfully installed blobuploader requests docopt 04:04:42 INFO - Cleaning up... 04:04:42 INFO - Return code: 0 04:04:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:42 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:42 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 04:04:42 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 04:04:42 INFO - Using env: {'DISPLAY': ':0', 04:04:42 INFO - 'HOME': '/home/cltbld', 04:04:42 INFO - 'LANG': 'en_US.UTF-8', 04:04:42 INFO - 'LANGUAGE': 'en_US:en', 04:04:42 INFO - 'LOGNAME': 'cltbld', 04:04:42 INFO - 'MAIL': '/var/mail/cltbld', 04:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:42 INFO - 'MOZ_NO_REMOTE': '1', 04:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:42 INFO - 'NO_EM_RESTART': '1', 04:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:42 INFO - 'SHELL': '/bin/bash', 04:04:42 INFO - 'SHLVL': '1', 04:04:42 INFO - 'TERM': 'linux', 04:04:42 INFO - 'TMOUT': '86400', 04:04:42 INFO - 'USER': 'cltbld', 04:04:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:42 INFO - '_': '/tools/buildbot/bin/python'} 04:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:04:42 INFO - Running setup.py (path:/tmp/pip-9sW1uH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:04:42 INFO - Running setup.py (path:/tmp/pip-37DkEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:04:42 INFO - Running setup.py (path:/tmp/pip-zV6xN5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:04:42 INFO - Running setup.py (path:/tmp/pip-xuRiUa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:04:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:04:42 INFO - Running setup.py (path:/tmp/pip-auO056-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:04:43 INFO - Running setup.py (path:/tmp/pip-3yCYOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:04:43 INFO - Running setup.py (path:/tmp/pip-NV6Kjw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:04:43 INFO - Running setup.py (path:/tmp/pip-tjQRdn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:04:43 INFO - Running setup.py (path:/tmp/pip-WIGvMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:04:43 INFO - Running setup.py (path:/tmp/pip-LbueMg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:04:43 INFO - Running setup.py (path:/tmp/pip-yKpWAv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:04:43 INFO - Running setup.py (path:/tmp/pip-RhamLe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:04:43 INFO - Running setup.py (path:/tmp/pip-kqVFmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:04:43 INFO - Running setup.py (path:/tmp/pip-6E7SE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:04:43 INFO - Running setup.py (path:/tmp/pip-5dGIo1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:04:43 INFO - Running setup.py (path:/tmp/pip-Na_JDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:04:43 INFO - Running setup.py (path:/tmp/pip-yIZPhO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:04:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:43 INFO - Running setup.py install for manifestparser 04:04:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:04:43 INFO - Running setup.py install for mozcrash 04:04:44 INFO - Running setup.py install for mozdebug 04:04:44 INFO - Running setup.py install for mozdevice 04:04:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Running setup.py install for mozfile 04:04:44 INFO - Running setup.py install for mozhttpd 04:04:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Running setup.py install for mozinfo 04:04:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Running setup.py install for mozInstall 04:04:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Running setup.py install for mozleak 04:04:44 INFO - Running setup.py install for mozlog 04:04:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:04:44 INFO - Running setup.py install for moznetwork 04:04:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Running setup.py install for mozprocess 04:04:45 INFO - Running setup.py install for mozprofile 04:04:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Running setup.py install for mozrunner 04:04:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Running setup.py install for mozscreenshot 04:04:45 INFO - Running setup.py install for moztest 04:04:45 INFO - Running setup.py install for mozversion 04:04:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:04:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:45 INFO - Cleaning up... 04:04:45 INFO - Return code: 0 04:04:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:45 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:45 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 04:04:45 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 04:04:45 INFO - Using env: {'DISPLAY': ':0', 04:04:45 INFO - 'HOME': '/home/cltbld', 04:04:45 INFO - 'LANG': 'en_US.UTF-8', 04:04:45 INFO - 'LANGUAGE': 'en_US:en', 04:04:45 INFO - 'LOGNAME': 'cltbld', 04:04:45 INFO - 'MAIL': '/var/mail/cltbld', 04:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:45 INFO - 'MOZ_NO_REMOTE': '1', 04:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:45 INFO - 'NO_EM_RESTART': '1', 04:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:45 INFO - 'SHELL': '/bin/bash', 04:04:45 INFO - 'SHLVL': '1', 04:04:45 INFO - 'TERM': 'linux', 04:04:45 INFO - 'TMOUT': '86400', 04:04:45 INFO - 'USER': 'cltbld', 04:04:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:45 INFO - '_': '/tools/buildbot/bin/python'} 04:04:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:04:45 INFO - Running setup.py (path:/tmp/pip-8_HpbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:04:45 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)) 04:04:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:04:45 INFO - Running setup.py (path:/tmp/pip-VBphQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:04:46 INFO - Running setup.py (path:/tmp/pip-Eyn9Zv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:04:46 INFO - Running setup.py (path:/tmp/pip-MYYSUj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:04:46 INFO - Running setup.py (path:/tmp/pip-u6SYFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:04:46 INFO - Running setup.py (path:/tmp/pip-OW3SWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:04:46 INFO - Running setup.py (path:/tmp/pip-ms45zi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:04:46 INFO - Running setup.py (path:/tmp/pip-VGYBdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:04:46 INFO - Running setup.py (path:/tmp/pip-8vvgrJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:04:46 INFO - Running setup.py (path:/tmp/pip-sBL7ga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:04:46 INFO - Running setup.py (path:/tmp/pip-0JbEnr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:04:46 INFO - Running setup.py (path:/tmp/pip-UsiPTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:04:46 INFO - Running setup.py (path:/tmp/pip-DVs24S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:04:46 INFO - Running setup.py (path:/tmp/pip-oibRkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:04:46 INFO - Running setup.py (path:/tmp/pip-Srnwqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:04:46 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)) 04:04:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:04:46 INFO - Running setup.py (path:/tmp/pip-F7_d4r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:04:47 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)) 04:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:04:47 INFO - Running setup.py (path:/tmp/pip-pmsDhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:04:47 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)) 04:04:47 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)) 04:04:47 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)) 04:04:47 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)) 04:04:47 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)) 04:04:47 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)) 04:04:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:48 INFO - Downloading blessings-1.6.tar.gz 04:04:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:48 INFO - Installing collected packages: blessings 04:04:48 INFO - Running setup.py install for blessings 04:04:49 INFO - Successfully installed blessings 04:04:49 INFO - Cleaning up... 04:04:49 INFO - Return code: 0 04:04:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:04:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:04:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:04:49 INFO - Reading from file tmpfile_stdout 04:04:49 INFO - Current package versions: 04:04:49 INFO - argparse == 1.2.1 04:04:49 INFO - blessings == 1.6 04:04:49 INFO - blobuploader == 1.2.4 04:04:49 INFO - docopt == 0.6.1 04:04:49 INFO - manifestparser == 1.1 04:04:49 INFO - mozInstall == 1.12 04:04:49 INFO - mozcrash == 0.16 04:04:49 INFO - mozdebug == 0.1 04:04:49 INFO - mozdevice == 0.48 04:04:49 INFO - mozfile == 1.2 04:04:49 INFO - mozhttpd == 0.7 04:04:49 INFO - mozinfo == 0.9 04:04:49 INFO - mozleak == 0.1 04:04:49 INFO - mozlog == 3.1 04:04:49 INFO - moznetwork == 0.27 04:04:49 INFO - mozprocess == 0.22 04:04:49 INFO - mozprofile == 0.28 04:04:49 INFO - mozrunner == 6.11 04:04:49 INFO - mozscreenshot == 0.1 04:04:49 INFO - mozsystemmonitor == 0.0 04:04:49 INFO - moztest == 0.7 04:04:49 INFO - mozversion == 1.4 04:04:49 INFO - psutil == 3.1.1 04:04:49 INFO - requests == 1.2.3 04:04:49 INFO - wsgiref == 0.1.2 04:04:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:04:49 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')]} 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:49 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')]} 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:49 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:49 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 04:04:49 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 04:04:49 INFO - Using env: {'DISPLAY': ':0', 04:04:49 INFO - 'HOME': '/home/cltbld', 04:04:49 INFO - 'LANG': 'en_US.UTF-8', 04:04:49 INFO - 'LANGUAGE': 'en_US:en', 04:04:49 INFO - 'LOGNAME': 'cltbld', 04:04:49 INFO - 'MAIL': '/var/mail/cltbld', 04:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:49 INFO - 'MOZ_NO_REMOTE': '1', 04:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:49 INFO - 'NO_EM_RESTART': '1', 04:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:49 INFO - 'SHELL': '/bin/bash', 04:04:49 INFO - 'SHLVL': '1', 04:04:49 INFO - 'TERM': 'linux', 04:04:49 INFO - 'TMOUT': '86400', 04:04:49 INFO - 'USER': 'cltbld', 04:04:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:49 INFO - '_': '/tools/buildbot/bin/python'} 04:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 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)) 04:04:49 INFO - Cleaning up... 04:04:49 INFO - Return code: 0 04:04:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:04:49 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')]} 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:49 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')]} 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:49 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:49 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 04:04:49 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 04:04:49 INFO - Using env: {'DISPLAY': ':0', 04:04:49 INFO - 'HOME': '/home/cltbld', 04:04:49 INFO - 'LANG': 'en_US.UTF-8', 04:04:49 INFO - 'LANGUAGE': 'en_US:en', 04:04:49 INFO - 'LOGNAME': 'cltbld', 04:04:49 INFO - 'MAIL': '/var/mail/cltbld', 04:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:49 INFO - 'MOZ_NO_REMOTE': '1', 04:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:49 INFO - 'NO_EM_RESTART': '1', 04:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:49 INFO - 'SHELL': '/bin/bash', 04:04:49 INFO - 'SHLVL': '1', 04:04:49 INFO - 'TERM': 'linux', 04:04:49 INFO - 'TMOUT': '86400', 04:04:49 INFO - 'USER': 'cltbld', 04:04:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:49 INFO - '_': '/tools/buildbot/bin/python'} 04:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:49 INFO - Downloading/unpacking jsonschema 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:51 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 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 04:04:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:51 INFO - warning: no files found matching '*.txt' 04:04:51 INFO - no previously-included directories found matching 'build' 04:04:51 INFO - no previously-included directories found matching 'dist' 04:04:51 INFO - no previously-included directories found matching '.git*' 04:04:51 INFO - Installing collected packages: jsonschema, functools32 04:04:51 INFO - Running setup.py install for functools32 04:04:51 INFO - warning: no files found matching '*.txt' 04:04:51 INFO - no previously-included directories found matching 'build' 04:04:51 INFO - no previously-included directories found matching 'dist' 04:04:51 INFO - no previously-included directories found matching '.git*' 04:04:51 INFO - Successfully installed jsonschema functools32 04:04:51 INFO - Cleaning up... 04:04:52 INFO - Return code: 0 04:04:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:04:52 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')]} 04:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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')]} 04:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:52 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 0x7f40070a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27a5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, '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': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', '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 04:04:52 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 04:04:52 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 04:04:52 INFO - Using env: {'DISPLAY': ':0', 04:04:52 INFO - 'HOME': '/home/cltbld', 04:04:52 INFO - 'LANG': 'en_US.UTF-8', 04:04:52 INFO - 'LANGUAGE': 'en_US:en', 04:04:52 INFO - 'LOGNAME': 'cltbld', 04:04:52 INFO - 'MAIL': '/var/mail/cltbld', 04:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:52 INFO - 'MOZ_NO_REMOTE': '1', 04:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:52 INFO - 'NO_EM_RESTART': '1', 04:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:04:52 INFO - 'SHELL': '/bin/bash', 04:04:52 INFO - 'SHLVL': '1', 04:04:52 INFO - 'TERM': 'linux', 04:04:52 INFO - 'TMOUT': '86400', 04:04:52 INFO - 'USER': 'cltbld', 04:04:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:52 INFO - '_': '/tools/buildbot/bin/python'} 04:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:52 INFO - Downloading/unpacking flake8 04:04:52 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 04:04:52 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 04:04:52 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 04:04:52 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 04:04:52 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 04:04:52 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 04:04:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 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 04:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:54 INFO - no previously-included directories found matching 'docs/_build' 04:04:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:04:54 INFO - Running setup.py install for pep8 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:54 INFO - no previously-included directories found matching 'docs/_build' 04:04:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:04:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:04:54 INFO - Cleaning up... 04:04:54 INFO - Return code: 0 04:04:54 INFO - Running post-action listener: _resource_record_post_action 04:04:54 INFO - Running post-action listener: _start_resource_monitoring 04:04:54 INFO - Starting resource monitoring. 04:04:54 INFO - ##### 04:04:54 INFO - ##### Running install step. 04:04:54 INFO - ##### 04:04:54 INFO - Running pre-action listener: _resource_record_pre_action 04:04:54 INFO - Running main action method: install 04:04:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:04:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:04:55 INFO - Reading from file tmpfile_stdout 04:04:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:04:55 INFO - Reading from file tmpfile_stdout 04:04:55 INFO - Output received: 04:04:55 INFO - Usage: mozinstall [options] installer 04:04:55 INFO - Options: 04:04:55 INFO - -h, --help show this help message and exit 04:04:55 INFO - -d DEST, --destination=DEST 04:04:55 INFO - Directory to install application into. [default: 04:04:55 INFO - "/builds/slave/test-pgo"] 04:04:55 INFO - --app=APP Application being installed. [default: firefox] 04:04:55 INFO - mkdir: /builds/slave/test-pgo/build/application 04:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:05:11 INFO - Reading from file tmpfile_stdout 04:05:11 INFO - Output received: 04:05:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:05:11 INFO - Running post-action listener: _resource_record_post_action 04:05:11 INFO - ##### 04:05:11 INFO - ##### Running run-tests step. 04:05:11 INFO - ##### 04:05:11 INFO - Running pre-action listener: _resource_record_pre_action 04:05:11 INFO - Running main action method: run_tests 04:05:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:05:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:05:11 INFO - Python 2.7.3 04:05:11 INFO - Return code: 0 04:05:11 INFO - grabbing minidump binary from tooltool 04:05:11 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')]} 04:05:11 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 0x28377f0>, '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 0x27a32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a3760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:05:11 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 04:05:11 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 04:05:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:05:11 INFO - Return code: 0 04:05:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:05:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:05:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:05:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:05:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:05:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:05:12 INFO - Return code: 0 04:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 04:05:12 INFO - Using env: {'DISPLAY': ':0', 04:05:12 INFO - 'HOME': '/home/cltbld', 04:05:12 INFO - 'LANG': 'en_US.UTF-8', 04:05:12 INFO - 'LANGUAGE': 'en_US:en', 04:05:12 INFO - 'LOGNAME': 'cltbld', 04:05:12 INFO - 'MAIL': '/var/mail/cltbld', 04:05:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:12 INFO - 'MOZ_NO_REMOTE': '1', 04:05:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:05:12 INFO - 'NO_EM_RESTART': '1', 04:05:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:05:12 INFO - 'PWD': '/builds/slave/test-pgo', 04:05:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:05:12 INFO - 'SHELL': '/bin/bash', 04:05:12 INFO - 'SHLVL': '1', 04:05:12 INFO - 'TERM': 'linux', 04:05:12 INFO - 'TMOUT': '86400', 04:05:12 INFO - 'USER': 'cltbld', 04:05:12 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591', 04:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:12 INFO - '_': '/tools/buildbot/bin/python'} 04:05:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 04:05:12 INFO - mozversion application_buildid: 20160124013032 04:05:12 INFO - mozversion application_changeset: 221b4255e3e858fcb4baa1e2989cdab63324ac23 04:05:12 INFO - mozversion application_display_name: Nightly 04:05:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:05:12 INFO - mozversion application_name: Firefox 04:05:12 INFO - mozversion application_remotingname: firefox 04:05:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:05:12 INFO - mozversion application_vendor: Mozilla 04:05:12 INFO - mozversion application_version: 46.0a1 04:05:12 INFO - mozversion platform_buildid: 20160124013032 04:05:12 INFO - mozversion platform_changeset: 221b4255e3e858fcb4baa1e2989cdab63324ac23 04:05:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:05:12 INFO - mozversion platform_version: 46.0a1 04:05:12 INFO - using testdate: 1453637112 04:05:12 INFO - actual date: 1453637112 04:05:12 INFO - starting webserver on 'localhost:36455' 04:05:12 INFO - SUITE-START | Running 3 tests 04:05:12 INFO - TEST-START | dromaeo_css 04:05:12 INFO - operating with platform_type : linux_ 04:05:12 INFO - Initialising browser for dromaeo_css test... 04:05:12 INFO - TEST-INFO | started process 13613 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCYWfHF/profile http://localhost:36455/getInfo.html) 04:05:16 INFO - PROCESS | 13613 | 04:05:16 INFO - PROCESS | 13613 | (process:13698): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:16 INFO - PROCESS | 13613 | __metrics Screen width/height:1600/1200 04:05:16 INFO - PROCESS | 13613 | colorDepth:24 04:05:16 INFO - PROCESS | 13613 | Browser inner width/height: 1024/697 04:05:16 INFO - PROCESS | 13613 | __metrics 04:05:17 INFO - PROCESS | 13613 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:05:17 INFO - TEST-INFO | 13613: exit 0 04:05:17 INFO - Browser initialized. 04:05:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:05:17 INFO - TEST-INFO | started process 13747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCYWfHF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:19 INFO - PROCESS | 13747 | 04:05:19 INFO - PROCESS | 13747 | (process:13807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:29 INFO - PROCESS | 13747 | RSS: Main: 152211456 04:05:29 INFO - PROCESS | 13747 | 04:06:19 INFO - PROCESS | 13747 | 1453637179361 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] 04:08:28 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36455/tests/dromaeo/cssquery-ext.html) 04:08:29 INFO - PROCESS | 13747 | RSS: Main: 161136640 04:08:29 INFO - PROCESS | 13747 | 04:11:31 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-ext.html (next: http://localhost:36455/tests/dromaeo/cssquery-jquery.html) 04:11:31 INFO - PROCESS | 13747 | RSS: Main: 158068736 04:11:31 INFO - PROCESS | 13747 | 04:14:33 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36455/tests/dromaeo/cssquery-mootools.html) 04:14:34 INFO - PROCESS | 13747 | RSS: Main: 156450816 04:14:34 INFO - PROCESS | 13747 | 04:17:35 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36455/tests/dromaeo/cssquery-prototype.html) 04:17:36 INFO - PROCESS | 13747 | RSS: Main: 154402816 04:17:36 INFO - PROCESS | 13747 | 04:20:38 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36455/tests/dromaeo/cssquery-yui.html) 04:20:39 INFO - PROCESS | 13747 | RSS: Main: 154681344 04:20:39 INFO - PROCESS | 13747 | 04:23:41 INFO - PROCESS | 13747 | Cycle 1(1): loaded http://localhost:36455/tests/dromaeo/cssquery-yui.html (next: http://localhost:36455/tests/dromaeo/cssquery-dojo.html) 04:23:42 INFO - PROCESS | 13747 | RSS: Main: 158588928 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | __start_tp_report 04:23:42 INFO - PROCESS | 13747 | _x_x_mozilla_page_load 04:23:42 INFO - PROCESS | 13747 | _x_x_mozilla_page_load_details 04:23:42 INFO - PROCESS | 13747 | |i|pagename|runs| 04:23:42 INFO - PROCESS | 13747 | |0;dojo.html;3192.776505644604;3196.0411876437065;3228.903132906011;3243.5459035734984;3247.772655914086;5226.08543504887;5270.393904700961;5270.683758974459;5278.947210527894;5280.735963201843;5248.921266181011;5264.8157314494;5270.077736396134;5293.073712100387;5311.9468805311935;4566.3607095006555;4846.539578740014;4965.0566392385335;4969.428515720684;4973.353464049668;4790.329353890458;4890.951090489103;4930.876728081808;4950.282209079682;4950.6287028472825;4812.061647978646;4857.878553036167;4869.099216644932;4886.315915771795;4930.975345123269;4813.326134341195;4829.830955916526;4848.369711937461;4869.951300486985;4899.265110233458;4769;4827.565519103263;4833.2266837306215;4835.032993401333;4850.078485087822;5111.131107711661;5116.641835071547;5162;5172.172452407597;5198.870028249324;5571.387147413781;5688.232088668018;5695.886082278331;5703.173039909231;5749.195112684228;5610.635308704921;5733.254676892019;5737.282839645044;5739.053056245714;5777.884442311172;5330.840074797762;5341;5341.1187154119525;5348.545373643206;5376.784928602851;5824.388439213906;5828.184054232411;5839.299284085937;5844.1818145459665;5856.326522449973;5532.834014979557;5614.9157762633595;5616.410276920946;5630;5716.056850619684;5737.340205876294;5752.798652047159;5755.539556835443;5767.452092051249;5770.307563092456;5697.4302569742695;5709.65742055478;5714.114312281603;5716.056850619601;5723.971380143156;5544.611877168641;5642.435756424325;5651.802186923438;5664.85837854057;5743.9425605744245;4428.623566996841;4436.0906014267;4443.333499974965;4446.221911165533;4471.530489298577;3900.2199560088097;3941.6649584785614;3958.5447673517338;3979.10470144221;4009.979950100231;5347.331583552056;5436.456354364532;5444.863878402993;5464.3442786865835;5512.80705175325;5748.396418376094;5759.819237056394;5767.134929760569;5768.798092066758;5769.105788602773;5262.394824595221;5289.047971365191;5419.403865574784;5428.782848686087;5437.45625437461;4862.586680132157;4865.416150062015;4885.462599114095;4916.754162291871;4933.9013219736125;5917;5984.640921544634;5990.670513121733;6008.759649614054;6015.4586087252355;5590.357108932362;5670.4329567044615;5703.08750599902;5784.509060766233;5835.387284335254;5928.584999050197;5935.109733540004;5951.880962380642;6003.969980150071;6062.120992455981;5650;5684.403137670485;5686.203931449518;5687.800926967537;5718.971405142947;5694.117411801178;5699.059655156852;5717.5425965921795;5782.5663075268685;5805.3033635962265;5182.196759502283;5563.972180139073;5571.9721401392735;5588.748506317144;5609.354924183771;5502.80740174092;5538.584606154635;5579.3304803422225;5586.078297080936;5590.413006634408;5390.757415916371;5472;5489.368722596792;5528.391876893458;5550.639208451437;5586.078297081099;5595.272614560081;5614.214010038516;5619.297587801525;5637.577181711306;5486.231927530229;5487.259220005249;5499.1476321170285;5507.0637991542335;5567 04:23:42 INFO - PROCESS | 13747 | |1;ext.html;484.5493690867494;522.9294045303888;547.2967237100326;559.5383808358105;569.2969183058924;27768.166954991357;35040.29919401614;35143.297134057306;35430.468542971874;35538;38654.61345386545;39312.41031384524;39383;39489.21021579567;39563.20873582527;8386.287165590917;8513.318934485258;8558.572071396437;8560.272376847975;8568;8230.382721295897;8330.791730206733;8337.708180213695;8358.247757701805;8362.038365587943;8368.790780230513;8424.410291279613;8439.57802109892;8458.661653533882;8487.830243395128;8416;8431.40980131391;8497.787555311135;8522.446041007315;8621.094785047542;8404.453710508797;8602.956985215034;8606.139386061344;8606.354523410706;8618.181272779077;39293.60706392928;39424.21151576981;39765.602343976476;39771.403428948586;39942.20115597672;2881.812682175652;2961.689022652612;3001.4897467430587;3144.5912031435996;3229.3056992746438;28991.710082899113;29607.85196074006;29926.102216933527;29966.101016969526;30124.69875301241;3897.7271590988644;3938.5667576566557;3942.329803933338;3985.6612187964056;4045.898852528681;190683;193338;193616;194178;194497;48836.75581622069;54423;54503.72748136313;54889.451105489235;55002;44497.55502444999;57761;57818.71090644604;58145;58191.709041454524;15417.537473875802;15605;15693.450729224422;15713.135777532118;15746.68506629861;11065.114790816715;11131.610393636345;11173.441327933571;11205.991460768408;11239.494222759995;18044.819551804576;18172.182251798702;18297.26810927548;18350.908245458686;18951.052447377577;7516.586587737727;7677;7687.2697093776005;7817.57003364809;7870.9606451967375;852.1946760311446;868.2446271743623;890.0921060518235;893.5041052215953;899.7210864631854;24492.14277500279;24911.750882490942;27872;28451.857740711162;28665.856670716512;959.1367769007949;985.1576901749045;1001.7595777013464;1011.585250047477;1110.4669758515797;13682.452701891812;13921.850950796841;14130.64673383153;14157;14284.714305713827;325135;325638;326512;328728;330429;48426;48707;48768.26847597289;48812.755936220805;48912;1315.0597322914161;1359.3475131936527;1362.257569624557;1362.6457121148374;1362.9795553066713;26476.8676156618;27157;27225.31936701598;27253.182404527895;27581.448371032868;44601;44681;44723;44932.550674492835;44962;262577;266301;266777;266869;267012;30060;31252;31366.529502057943;31437.214069648442;31716;37103.62896371002;37490.81254593709;37575.624243757215;37878.43182352322;38443.42334864923;34101.82949085338;34108.488372674925;34782.47826282557;34849;35044.123896901765;33988.83005584956;34322.14194645154;34933.82533087318;35232;35265.11837203988;33883;33985.3202935935;34067.318653626295;34147.65852341445;34232.657673422946;29249.122526324245;29908.252293692833;31467.52798708067;32108.839455803507;32376.676233238308;22845.771542284365;23738.525229494968;24182;24425.633615495426;24745.87627061925 04:23:42 INFO - PROCESS | 13747 | |2;jquery.html;352.5416957954659;355.96084430712625;373.74772028880517;376.4353469795309;378.1567105355056;11296.717582060453;11722;15483.767743483842;16711.16444177791;17665.646687066266;16894.324227030935;17001.48995530133;17619.647607047853;18046.18792154353;18091.81908180921;6076.118962750387;6275.090111933767;6316.589421687599;6324.146240257553;6327.651979141146;5989.191459153024;6116.388361163892;6190.814275571717;6198.34917333678;6216.222972128484;6179.134921111048;6225.47083497901;6227.532935029891;6246.187995560594;6511.869762604745;6394;6406.327335629761;6461.06314584385;6643.236027856762;6985.930140698579;6501.414872661436;6613.636250006248;6620.536562440631;6685.699143538553;6687.264400915896;21272.78727212739;21629.891850540804;22203.777962220494;22295;22338.66492002621;2188.1466228171025;2216.1357070742424;2234.2515257388795;2275.3628983884537;2460.4463995601027;13604.455821767118;14031.929840350835;14098.788518172236;14367.281635918267;14375.928120359436;1875.1749230338608;1929.9674674049315;1963.901804909763;1976.090998140857;2009.8392128629675;61300.38699612991;63208.367916320705;63349;64067.679661601396;64694.35305646931;14438.783418248735;15142.091474511344;15147.697046059016;15228.086314821147;15244.923775381052;23029;23139.76860231376;23152.88423557905;23382.53234935326;23399.41501462477;9049.321300902327;9158.95420522893;9175.174234318943;9250.306227033;9298.95350523243;7739.148693643695;7770.922290777133;7801.297883190427;7818.257265559762;7829.099653539915;7479.252074792477;7586.165521792598;7588.051493563305;7601.543907365576;7634.50375725576;1799.1454059321718;1859.7582314299054;2949.439606474763;3059.5563643272044;3123.141136187521;832;857.3355649371787;887.3921363865772;968.1867231525553;996.1035068438464;14331.85668143326;16005.67988640244;16320;16549.338026479047;16555.917220414063;854.372036553133;921.9216366608913;923.0538697834639;928.7817362919709;980.7401038724744;8652.3510736695;9044.819103618023;9145.634174633073;9276.397034192756;9335.206507446806;386810;393197;397252;403981;472422;70103.64948175328;70309;71191.64404177947;73667.63166184135;74490.62754686191;1143.0626885953438;1165.7726743284977;1169.5321871251567;1172.2146162071433;1173.5188572685158;14972.401103956156;15028.849711502746;15146.924265379044;15178.24108794578;15458.768118478007;31332.843335783175;31354;31790.52314215335;32263.193420164684;32611.673883261814;41631.7918410406;41858.58141418547;42004.78997604993;42102.789486052374;45034.09931801411;7062.435005199469;7161.355478007004;7235.782926512213;7363.77908662741;7400.296971787671;9076.500792456478;10507.31702439339;11047.889521105008;11089.22375433712;11285.040771534512;9435;9609.792655508369;9972.700818975442;10168.898311016796;10194.898051019394;9736.41581505112;10048.447335396624;10057.145142662663;10223.539940702538;10487;9611.567479463582;10078.143357814668;10217.182625389802;10331.483425828828;10358.792824143626;7403.296686814744;7573.2048134947245;7583.9620801895635;7598.316151546387;7600.543967361976;8711.25954293892;9898.703038908845;9917.801643966935;10034.899651003396;10050.949745251228 04:23:42 INFO - PROCESS | 13747 | |3;mootools.html;1425.6863490032192;1437.7578560346417;1589.7059044076839;1715.8198389169129;1761.524388415128;7742.922570774291;7793.298603125718;7918.524888506679;7952.522848629086;8009.4793838400465;8162.755117346489;8191.467554608947;8212.876806847888;8329.666813327474;8342.416030877841;2154.267549033332;2172.435166856613;2186.147402513021;2186.5080356919725;2192.112194561197;2172.543765809174;2205.52581195043;2207.569523942832;2208.094681180716;2232.2968264996557;2143.732033495813;2168.2627906511784;2198.120751699317;2199.5490924360547;2205.184081889695;2162.664786958024;2174.499865031044;2208.2381578355444;2209.668549717539;2210.6794514795347;2200.207925146946;2212.856164349312;2218.0684112672716;2222.3221917315213;2224.5217278285245;7838.333741631968;7893.13175550689;7916.643751031217;7949.523028618243;7987.400944929153;4853.927191092136;5042.672226305279;5043.42000669924;5061.493850614946;5061.670991385548;3046.9695303046906;3155.842207889619;3254.1213872254593;3255.869765209389;3267.39553182662;1053.1890444357803;1064.7178497698117;1086.4187659602076;1102.7188067042932;1992.6911328744068;10890.183236257313;10922;10983.505742241538;11037.448127593589;11051;4298.312270036841;4345.782710864444;4390.495093064274;4390.648748100144;4398.692091553625;8899.466032038099;8911.643534258557;8940.50827204497;8956.68651597191;8984.371094023487;4862.6839255448285;4864.708117512961;4897.902041959141;4907.043126590281;4923.433805112386;4454.665900057508;4487.618552423015;4493.483249426358;4512.34570987205;4531.093781243699;3286.4084464796088;3369.22507823202;3409.079548521885;3418.2308980479193;3427.588689357293;1049.9527521261562;1052.147760314148;1059.7562560611102;1066.6106870992032;1076.6716151573846;920.052346083535;920.0753242990752;1081.0486771640906;1133.8582677165355;1321.85459599444;7198;7257.237990011078;7321.414286857039;7333.083364579427;7364.594947277951;587.7795826565039;589.4164776870867;590.4272855330323;597.2593983460478;712.4015826705593;5717.2281741965135;5782.306123265235;5801.767929282866;5982.282126144803;6166.969165154145;9527.857082143773;9589.328746987783;9607.615695372107;9663.226941844636;9756.90243097574;9405.20055795265;9409.38838975478;9441.24470042395;9574.856377154209;9614.855777163348;7398.186199518049;7529.096508419025;7534.886976695354;7550.622468876534;7568.281013303837;7299.124105107421;7390.29792169743;7520.135184453639;7580.696772129053;7604.353629941517;8365.330773538224;8622.094680058504;8639.611217495101;8672.262857656917;8678.218960293352;8704.869426958727;8851.46891186531;8923.643054278016;8932.598033088396;9077.364584479023;7063.117110361205;7092.219855815959;7146.428285737233;7190.856182876209;7208.06295181623;7476.663550140148;7578.12851522082;7588.317051465395;7601.619919004138;7604.695812167452;6914.9308506914285;7137.500374973702;7198.2801719829695;7317.670704818403;7349.118105827335;6839.942551663711;6933.479989000744;7079.256678048937;7119.82200444993;7164.856702866018;7111.040009598845;7178.353948144692;7183.425325974014;7184.46116541251;7187.6765545551625;6483;6546.378094081055;6577.309382514767;6592.077109204619;6622.635755033327;6373.681315934277;6480.060391243149;6486.481081513562;6500.382463665944;6501.9674901625185 04:23:42 INFO - PROCESS | 13747 | |4;prototype.html;342.5273123090135;355.69054922217657;359.15598343891855;361.2215675219902;364.5516015301181;6156.7537298508005;6281.528885333595;6305.054241863722;6327.683615819214;6365.840853978647;6022.638641681502;6229.283632382278;6234.781782637609;6269.404406581379;6269.843253918654;4763.047390521892;4774.665773395864;4795.664303498756;4804.087223427555;4810.302506136608;4814.253790662436;4816.988432429194;4822.228443449048;4824.927626085594;4826.806927722887;4676.976615116937;4723.409573803275;4748.881277968044;4770.379850619414;4772.188727916246;4745.122152401782;4752.453467851206;4754.120487709767;4771.713697178146;4773.236282194867;4158.293090174678;4159.750414975111;4197.958020419787;4201.97899010503;4209.431726716884;5880.911786323209;5904.114382842565;5904.61619994699;5924.526037916957;5927.37762534932;5392.083345831218;5535.612507124503;5541.0580201365865;5552.750126244288;5552.86117847053;6506.056621789814;6528.249251336062;6544.247411547638;6545.509086818508;6580.407763301326;4648.163330600491;4654.720716757005;4660.72035677857;4664.39362882823;4670.836520721792;6632;6923.342282483156;6934.583924964468;6942.861142777167;6963.547369420971;4728.338032675429;4735.2423612222565;4737.194676904935;4740.976295118571;4751.59611433032;4782.33047373368;4791.089692958327;4791.712497250106;4794.424669039668;4811.446683631427;5505.339359276913;5524.972375138099;5527.170924361378;5532.806351777749;5539.612227144061;6565;6638.4689224861895;6669.599824010575;6674.432673222734;6675.666216689243;1645.983540164583;1686.7048266553304;1687.392538686072;1691.4671878358279;1712.5119340987758;1064.9254552181274;1074.7420619051527;1077.3751224289892;1078.7033565769477;1084.8318510630866;6248.31268560458;6249.687515624291;6258.15514905491;6259.155014073133;6273.905891411632;6694.129763130762;6703.698333575001;6704.363085506869;6734.932650673529;6739.59562426256;6130.877382452326;6203.627782333075;6260.843478912972;6268.717907694165;6269.028300613412;3645.052286405554;3648.872289469856;3655.3420384330543;3674.0998455378603;3675.1363429594026;7018.40343570792;7041.1902631197045;7042.894356584656;7043.190033146151;7052.753153639701;6769.356911093537;6917.619530925746;6924;6943;6958.165020197609;7028.683709233097;7028.824279392954;7038.260982596856;7039.648017599099;7041.964790176119;6720.966395167993;6744.932550674431;6750.25747167821;6755.392014718699;6765.763198288037;6577.3422657733845;6672.766453174116;6704.229013663296;6705.027770973084;6711.530192886451;7019.929800701928;7058;7058.576485410892;7069.9646501767165;7070.292970702889;4670.486246512949;4701.059788042474;4708.317293992283;4710.929336059893;4716.8113275468595;6717.891547894543;6801.7279308829075;6822;6857.108575885103;6919.273476284918;6625.50308726857;6636.634985075674;6678.365555272241;6704.329567043256;6712.127423434922;6655.933440665532;6730.899036514358;6741.22475915276;6752.662366881538;6763.93236067633;6489.772857949949;6552.049952756728;6605.339466053356;6607.867842643024;6626.204855417188;6736.955771855371;6756.527043106936;6759.425448836707;6770.5599136056;6793.966030169818;6534.444572211415;6553.868922621617;6580.934190658032;6588.868222635616;6589.934100659124 04:23:42 INFO - PROCESS | 13747 | |5;yui.html;746.0078096132145;748.9288517590828;765.0322342237067;798.9773090444231;805.8267472493412;12653.240805551663;12906.677333066666;12937.676558086052;12969.935150324236;12982.610521684353;12065.638030859067;12336.383180840945;12380.876191238085;12460.252384856893;12480.188787728792;814.0313027497274;829.1542626520945;831.4387788242942;832.9625166867476;834.6077343648476;819.7417813388794;822.3996482567729;822.8560001999656;825.2531459029558;825.6738588257634;855.6534603485599;857.7512521368827;858.8110615664575;859.4628357276702;863.6674880171148;851.8126012277289;853.7609469348562;857.7855536115972;858.2919091749332;860.5095095795399;626.987460250797;628.3057221769969;628.45324567626;630.3538872655519;631.1447987976318;12423.4409451574;12495.687607809787;12509.06182036351;12522.436490357955;12559.811602825965;10852.511636976355;11087.944560277228;11298.661040168809;11315.094792416587;11443.713907152387;9361;9588.280878934107;9594;9987.250956178243;10056.497175141214;3510.701590364822;3547.290541891606;3564.198055437532;3584.982075089608;3592.5329707138167;42586.78706606478;42587.78706106481;45997.54002459999;46871;47157.76421117873;10056.50111955004;10090.394576325298;10114.898851011396;10212.948935255276;10507.684769456928;17343.566410839576;17360.95834249949;17365.652686946443;17377.131143442777;17400.564985875455;7664.271894170045;7673.501222420525;7695.6152192390155;7699.576523291273;7944.404169687296;4416.271315233015;4463.776811159429;4465.754383508938;4581.404417425713;4601.4248218972625;3256.3812875553567;3259.6414394416597;3278.47544392896;3280.507923811447;3284.2774589590254;612.1643956000116;615.7167702856736;618.8762247550418;628.4815027602247;628.5129025005657;505.90387826312883;558.4331903118339;639.7025383196743;643.2731013954202;653.8071268975664;8276.255137037695;8334.458260213189;8364.45631033993;8438.66245350179;8647;559.9356074051454;628.5945565110478;642.7236288395941;646.7219095788856;648.8799572079181;4138.255114079434;4196.286631272691;4227.070044590185;4235.830566777356;4272.380504826782;53123;54127;54901;55653;55921;42462;47173.5282647176;48678.26982595264;48865;49507.75246123746;43483.13033739307;43991.56008439939;43996.780016100354;44987.775061124485;45459.31811022837;8806.383553151474;8813.779655508664;8969.14793094655;9076.954615227145;9113.498757568397;32585.18537036593;33161.83419082889;33577.49633755447;33610.327793444485;34178.31643367169;41191;42978.78510607552;43029;43977;44188.55811441845;10268.281220314506;10286.2799604027;10424.895751042695;10469.842952355568;10616.787664246825;11428.657140285804;11582.71043223926;11612.825807612724;11781.941090294837;11936.343501107522;11387;11399.316041037564;11452.255603385753;11474.713132171762;11584.826227606423;10356.792864142524;10400.375977441377;10629.840552391566;10660.147188224768;10763.892361076601;11049.779004420026;11071.5571377144;11133.443327833415;11179.88820111821;11191;8866.689665861664;8982.236509896471;9011.864822027545;9068.682596109105;9326.580303886478;8704.26013788835;8789.472631642122;8878.86681699788;8970.820583588422;9538.761530961781 04:23:42 INFO - PROCESS | 13747 | __end_tp_report 04:23:42 INFO - PROCESS | 13747 | __start_cc_report 04:23:42 INFO - PROCESS | 13747 | _x_x_mozilla_cycle_collect,311 04:23:42 INFO - PROCESS | 13747 | __end_cc_report 04:23:42 INFO - PROCESS | 13747 | __startTimestamp1453638222069__endTimestamp 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | ------- Summary: start ------- 04:23:42 INFO - PROCESS | 13747 | Number of tests: 6 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#0] dojo.html Cycles:165 Average:5308.96 Median:5507.06 stddev:586.49 (10.6%) stddev-sans-first:564.31 04:23:42 INFO - PROCESS | 13747 | Values: 3192.8 3196.0 3228.9 3243.5 3247.8 5226.1 5270.4 5270.7 5278.9 5280.7 5248.9 5264.8 5270.1 5293.1 5311.9 4566.4 4846.5 4965.1 4969.4 4973.4 4790.3 4891.0 4930.9 4950.3 4950.6 4812.1 4857.9 4869.1 4886.3 4931.0 4813.3 4829.8 4848.4 4870.0 4899.3 4769.0 4827.6 4833.2 4835.0 4850.1 5111.1 5116.6 5162.0 5172.2 5198.9 5571.4 5688.2 5695.9 5703.2 5749.2 5610.6 5733.3 5737.3 5739.1 5777.9 5330.8 5341.0 5341.1 5348.5 5376.8 5824.4 5828.2 5839.3 5844.2 5856.3 5532.8 5614.9 5616.4 5630.0 5716.1 5737.3 5752.8 5755.5 5767.5 5770.3 5697.4 5709.7 5714.1 5716.1 5724.0 5544.6 5642.4 5651.8 5664.9 5743.9 4428.6 4436.1 4443.3 4446.2 4471.5 3900.2 3941.7 3958.5 3979.1 4010.0 5347.3 5436.5 5444.9 5464.3 5512.8 5748.4 5759.8 5767.1 5768.8 5769.1 5262.4 5289.0 5419.4 5428.8 5437.5 4862.6 4865.4 4885.5 4916.8 4933.9 5917.0 5984.6 5990.7 6008.8 6015.5 5590.4 5670.4 5703.1 5784.5 5835.4 5928.6 5935.1 5951.9 6004.0 6062.1 5650.0 5684.4 5686.2 5687.8 5719.0 5694.1 5699.1 5717.5 5782.6 5805.3 5182.2 5564.0 5572.0 5588.7 5609.4 5502.8 5538.6 5579.3 5586.1 5590.4 5390.8 5472.0 5489.4 5528.4 5550.6 5586.1 5595.3 5614.2 5619.3 5637.6 5486.2 5487.3 5499.1 5507.1 5567.0 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#1] ext.html Cycles:180 Average:42570.20 Median:34987.06 stddev:70063.23 (200.3%) stddev-sans-first:70188.52 04:23:42 INFO - PROCESS | 13747 | Values: 484.5 522.9 547.3 559.5 569.3 27768.2 35040.3 35143.3 35430.5 35538.0 38654.6 39312.4 39383.0 39489.2 39563.2 8386.3 8513.3 8558.6 8560.3 8568.0 8230.4 8330.8 8337.7 8358.2 8362.0 8368.8 8424.4 8439.6 8458.7 8487.8 8416.0 8431.4 8497.8 8522.4 8621.1 8404.5 8603.0 8606.1 8606.4 8618.2 39293.6 39424.2 39765.6 39771.4 39942.2 2881.8 2961.7 3001.5 3144.6 3229.3 28991.7 29607.9 29926.1 29966.1 30124.7 3897.7 3938.6 3942.3 3985.7 4045.9 190683.0 193338.0 193616.0 194178.0 194497.0 48836.8 54423.0 54503.7 54889.5 55002.0 44497.6 57761.0 57818.7 58145.0 58191.7 15417.5 15605.0 15693.5 15713.1 15746.7 11065.1 11131.6 11173.4 11206.0 11239.5 18044.8 18172.2 18297.3 18350.9 18951.1 7516.6 7677.0 7687.3 7817.6 7871.0 852.2 868.2 890.1 893.5 899.7 24492.1 24911.8 27872.0 28451.9 28665.9 959.1 985.2 1001.8 1011.6 1110.5 13682.5 13921.9 14130.6 14157.0 14284.7 325135.0 325638.0 326512.0 328728.0 330429.0 48426.0 48707.0 48768.3 48812.8 48912.0 1315.1 1359.3 1362.3 1362.6 1363.0 26476.9 27157.0 27225.3 27253.2 27581.4 44601.0 44681.0 44723.0 44932.6 44962.0 262577.0 266301.0 266777.0 266869.0 267012.0 30060.0 31252.0 31366.5 31437.2 31716.0 37103.6 37490.8 37575.6 37878.4 38443.4 34101.8 34108.5 34782.5 34849.0 35044.1 33988.8 34322.1 34933.8 35232.0 35265.1 33883.0 33985.3 34067.3 34147.7 34232.7 29249.1 29908.3 31467.5 32108.8 32376.7 22845.8 23738.5 24182.0 24425.6 24745.9 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#2] jquery.html Cycles:180 Average:24967.52 Median:41745.19 stddev:67444.44 (161.6%) stddev-sans-first:67608.31 04:23:42 INFO - PROCESS | 13747 | Values: 352.5 356.0 373.7 376.4 378.2 11296.7 11722.0 15483.8 16711.2 17665.6 16894.3 17001.5 17619.6 18046.2 18091.8 6076.1 6275.1 6316.6 6324.1 6327.7 5989.2 6116.4 6190.8 6198.3 6216.2 6179.1 6225.5 6227.5 6246.2 6511.9 6394.0 6406.3 6461.1 6643.2 6985.9 6501.4 6613.6 6620.5 6685.7 6687.3 21272.8 21629.9 22203.8 22295.0 22338.7 2188.1 2216.1 2234.3 2275.4 2460.4 13604.5 14031.9 14098.8 14367.3 14375.9 1875.2 1930.0 1963.9 1976.1 2009.8 61300.4 63208.4 63349.0 64067.7 64694.4 14438.8 15142.1 15147.7 15228.1 15244.9 23029.0 23139.8 23152.9 23382.5 23399.4 9049.3 9159.0 9175.2 9250.3 9299.0 7739.1 7770.9 7801.3 7818.3 7829.1 7479.3 7586.2 7588.1 7601.5 7634.5 1799.1 1859.8 2949.4 3059.6 3123.1 832.0 857.3 887.4 968.2 996.1 14331.9 16005.7 16320.0 16549.3 16555.9 854.4 921.9 923.1 928.8 980.7 8652.4 9044.8 9145.6 9276.4 9335.2 386810.0 393197.0 397252.0 403981.0 472422.0 70103.6 70309.0 71191.6 73667.6 74490.6 1143.1 1165.8 1169.5 1172.2 1173.5 14972.4 15028.8 15146.9 15178.2 15458.8 31332.8 31354.0 31790.5 32263.2 32611.7 41631.8 41858.6 42004.8 42102.8 45034.1 7062.4 7161.4 7235.8 7363.8 7400.3 9076.5 10507.3 11047.9 11089.2 11285.0 9435.0 9609.8 9972.7 10168.9 10194.9 9736.4 10048.4 10057.1 10223.5 10487.0 9611.6 10078.1 10217.2 10331.5 10358.8 7403.3 7573.2 7584.0 7598.3 7600.5 8711.3 9898.7 9917.8 10034.9 10050.9 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#3] mootools.html Cycles:180 Average:5549.83 Median:6493.43 stddev:2930.09 (45.1%) stddev-sans-first:2921.91 04:23:42 INFO - PROCESS | 13747 | Values: 1425.7 1437.8 1589.7 1715.8 1761.5 7742.9 7793.3 7918.5 7952.5 8009.5 8162.8 8191.5 8212.9 8329.7 8342.4 2154.3 2172.4 2186.1 2186.5 2192.1 2172.5 2205.5 2207.6 2208.1 2232.3 2143.7 2168.3 2198.1 2199.5 2205.2 2162.7 2174.5 2208.2 2209.7 2210.7 2200.2 2212.9 2218.1 2222.3 2224.5 7838.3 7893.1 7916.6 7949.5 7987.4 4853.9 5042.7 5043.4 5061.5 5061.7 3047.0 3155.8 3254.1 3255.9 3267.4 1053.2 1064.7 1086.4 1102.7 1992.7 10890.2 10922.0 10983.5 11037.4 11051.0 4298.3 4345.8 4390.5 4390.6 4398.7 8899.5 8911.6 8940.5 8956.7 8984.4 4862.7 4864.7 4897.9 4907.0 4923.4 4454.7 4487.6 4493.5 4512.3 4531.1 3286.4 3369.2 3409.1 3418.2 3427.6 1050.0 1052.1 1059.8 1066.6 1076.7 920.1 920.1 1081.0 1133.9 1321.9 7198.0 7257.2 7321.4 7333.1 7364.6 587.8 589.4 590.4 597.3 712.4 5717.2 5782.3 5801.8 5982.3 6167.0 9527.9 9589.3 9607.6 9663.2 9756.9 9405.2 9409.4 9441.2 9574.9 9614.9 7398.2 7529.1 7534.9 7550.6 7568.3 7299.1 7390.3 7520.1 7580.7 7604.4 8365.3 8622.1 8639.6 8672.3 8678.2 8704.9 8851.5 8923.6 8932.6 9077.4 7063.1 7092.2 7146.4 7190.9 7208.1 7476.7 7578.1 7588.3 7601.6 7604.7 6914.9 7137.5 7198.3 7317.7 7349.1 6839.9 6933.5 7079.3 7119.8 7164.9 7111.0 7178.4 7183.4 7184.5 7187.7 6483.0 6546.4 6577.3 6592.1 6622.6 6373.7 6480.1 6486.5 6500.4 6502.0 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#4] prototype.html Cycles:180 Average:5534.98 Median:6264.78 stddev:1662.69 (26.5%) stddev-sans-first:1621.03 04:23:42 INFO - PROCESS | 13747 | Values: 342.5 355.7 359.2 361.2 364.6 6156.8 6281.5 6305.1 6327.7 6365.8 6022.6 6229.3 6234.8 6269.4 6269.8 4763.0 4774.7 4795.7 4804.1 4810.3 4814.3 4817.0 4822.2 4824.9 4826.8 4677.0 4723.4 4748.9 4770.4 4772.2 4745.1 4752.5 4754.1 4771.7 4773.2 4158.3 4159.8 4198.0 4202.0 4209.4 5880.9 5904.1 5904.6 5924.5 5927.4 5392.1 5535.6 5541.1 5552.8 5552.9 6506.1 6528.2 6544.2 6545.5 6580.4 4648.2 4654.7 4660.7 4664.4 4670.8 6632.0 6923.3 6934.6 6942.9 6963.5 4728.3 4735.2 4737.2 4741.0 4751.6 4782.3 4791.1 4791.7 4794.4 4811.4 5505.3 5525.0 5527.2 5532.8 5539.6 6565.0 6638.5 6669.6 6674.4 6675.7 1646.0 1686.7 1687.4 1691.5 1712.5 1064.9 1074.7 1077.4 1078.7 1084.8 6248.3 6249.7 6258.2 6259.2 6273.9 6694.1 6703.7 6704.4 6734.9 6739.6 6130.9 6203.6 6260.8 6268.7 6269.0 3645.1 3648.9 3655.3 3674.1 3675.1 7018.4 7041.2 7042.9 7043.2 7052.8 6769.4 6917.6 6924.0 6943.0 6958.2 7028.7 7028.8 7038.3 7039.6 7042.0 6721.0 6744.9 6750.3 6755.4 6765.8 6577.3 6672.8 6704.2 6705.0 6711.5 7019.9 7058.0 7058.6 7070.0 7070.3 4670.5 4701.1 4708.3 4710.9 4716.8 6717.9 6801.7 6822.0 6857.1 6919.3 6625.5 6636.6 6678.4 6704.3 6712.1 6655.9 6730.9 6741.2 6752.7 6763.9 6489.8 6552.0 6605.3 6607.9 6626.2 6737.0 6756.5 6759.4 6770.6 6794.0 6534.4 6553.9 6580.9 6588.9 6589.9 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - PROCESS | 13747 | [#5] yui.html Cycles:180 Average:13187.46 Median:45223.55 stddev:15054.29 (33.3%) stddev-sans-first:15067.52 04:23:42 INFO - PROCESS | 13747 | Values: 746.0 748.9 765.0 799.0 805.8 12653.2 12906.7 12937.7 12969.9 12982.6 12065.6 12336.4 12380.9 12460.3 12480.2 814.0 829.2 831.4 833.0 834.6 819.7 822.4 822.9 825.3 825.7 855.7 857.8 858.8 859.5 863.7 851.8 853.8 857.8 858.3 860.5 627.0 628.3 628.5 630.4 631.1 12423.4 12495.7 12509.1 12522.4 12559.8 10852.5 11087.9 11298.7 11315.1 11443.7 9361.0 9588.3 9594.0 9987.3 10056.5 3510.7 3547.3 3564.2 3585.0 3592.5 42586.8 42587.8 45997.5 46871.0 47157.8 10056.5 10090.4 10114.9 10212.9 10507.7 17343.6 17361.0 17365.7 17377.1 17400.6 7664.3 7673.5 7695.6 7699.6 7944.4 4416.3 4463.8 4465.8 4581.4 4601.4 3256.4 3259.6 3278.5 3280.5 3284.3 612.2 615.7 618.9 628.5 628.5 505.9 558.4 639.7 643.3 653.8 8276.3 8334.5 8364.5 8438.7 8647.0 559.9 628.6 642.7 646.7 648.9 4138.3 4196.3 4227.1 4235.8 4272.4 53123.0 54127.0 54901.0 55653.0 55921.0 42462.0 47173.5 48678.3 48865.0 49507.8 43483.1 43991.6 43996.8 44987.8 45459.3 8806.4 8813.8 8969.1 9077.0 9113.5 32585.2 33161.8 33577.5 33610.3 34178.3 41191.0 42978.8 43029.0 43977.0 44188.6 10268.3 10286.3 10424.9 10469.8 10616.8 11428.7 11582.7 11612.8 11781.9 11936.3 11387.0 11399.3 11452.3 11474.7 11584.8 10356.8 10400.4 10629.8 10660.1 10763.9 11049.8 11071.6 11133.4 11179.9 11191.0 8866.7 8982.2 9011.9 9068.7 9326.6 8704.3 8789.5 8878.9 8970.8 9538.8 04:23:42 INFO - PROCESS | 13747 | -------- Summary: end -------- 04:23:42 INFO - PROCESS | 13747 | 04:23:42 INFO - TEST-INFO | 13747: exit 0 04:23:42 INFO - TEST-OK | dromaeo_css | took 1110025ms 04:23:42 INFO - TEST-START | kraken 04:23:42 INFO - operating with platform_type : linux_ 04:23:42 INFO - Initialising browser for kraken test... 04:23:42 INFO - TEST-INFO | started process 13989 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVR5Cvk/profile http://localhost:36455/getInfo.html) 04:23:46 INFO - PROCESS | 13989 | 04:23:46 INFO - PROCESS | 13989 | (process:14059): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:46 INFO - PROCESS | 13989 | __metrics Screen width/height:1600/1200 04:23:46 INFO - PROCESS | 13989 | colorDepth:24 04:23:46 INFO - PROCESS | 13989 | Browser inner width/height: 1024/697 04:23:46 INFO - PROCESS | 13989 | __metrics 04:23:46 INFO - PROCESS | 13989 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:23:47 INFO - TEST-INFO | 13989: exit 0 04:23:47 INFO - Browser initialized. 04:23:47 INFO - Running cycle 1/1 for kraken test... 04:23:47 INFO - TEST-INFO | started process 14108 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVR5Cvk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:49 INFO - PROCESS | 14108 | 04:23:49 INFO - PROCESS | 14108 | (process:14166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:23:59 INFO - PROCESS | 14108 | RSS: Main: 152387584 04:23:59 INFO - PROCESS | 14108 | 04:24:02 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36455/tests/kraken/driver.html?testName=audio-beat-detection) 04:24:02 INFO - PROCESS | 14108 | RSS: Main: 155127808 04:24:02 INFO - PROCESS | 14108 | 04:24:05 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36455/tests/kraken/driver.html?testName=audio-dft) 04:24:05 INFO - PROCESS | 14108 | RSS: Main: 158965760 04:24:05 INFO - PROCESS | 14108 | 04:24:08 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36455/tests/kraken/driver.html?testName=audio-fft) 04:24:09 INFO - PROCESS | 14108 | RSS: Main: 153190400 04:24:09 INFO - PROCESS | 14108 | 04:24:11 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36455/tests/kraken/driver.html?testName=audio-oscillator) 04:24:12 INFO - PROCESS | 14108 | RSS: Main: 152870912 04:24:12 INFO - PROCESS | 14108 | 04:24:14 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:24:15 INFO - PROCESS | 14108 | RSS: Main: 153083904 04:24:15 INFO - PROCESS | 14108 | 04:24:18 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36455/tests/kraken/driver.html?testName=imaging-darkroom) 04:24:18 INFO - PROCESS | 14108 | RSS: Main: 153325568 04:24:18 INFO - PROCESS | 14108 | 04:24:22 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36455/tests/kraken/driver.html?testName=imaging-desaturate) 04:24:22 INFO - PROCESS | 14108 | RSS: Main: 153448448 04:24:22 INFO - PROCESS | 14108 | 04:24:25 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36455/tests/kraken/driver.html?testName=json-parse-financial) 04:24:26 INFO - PROCESS | 14108 | RSS: Main: 153419776 04:24:26 INFO - PROCESS | 14108 | 04:24:27 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:24:28 INFO - PROCESS | 14108 | RSS: Main: 154255360 04:24:28 INFO - PROCESS | 14108 | 04:24:30 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:24:30 INFO - PROCESS | 14108 | RSS: Main: 153665536 04:24:30 INFO - PROCESS | 14108 | 04:24:32 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:33 INFO - PROCESS | 14108 | RSS: Main: 152915968 04:24:33 INFO - PROCESS | 14108 | 04:24:35 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:36 INFO - PROCESS | 14108 | RSS: Main: 154456064 04:24:36 INFO - PROCESS | 14108 | 04:24:38 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:39 INFO - PROCESS | 14108 | RSS: Main: 154198016 04:24:39 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | Cycle 1(1): loaded http://localhost:36455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36455/tests/kraken/driver.html?testName=ai-astar) 04:24:41 INFO - PROCESS | 14108 | RSS: Main: 155365376 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | __start_tp_report 04:24:41 INFO - PROCESS | 14108 | _x_x_mozilla_page_load 04:24:41 INFO - PROCESS | 14108 | _x_x_mozilla_page_load_details 04:24:41 INFO - PROCESS | 14108 | |i|pagename|runs| 04:24:41 INFO - PROCESS | 14108 | |0;ai-astar;111;106;110;111;110;121;111;111;110;112 04:24:41 INFO - PROCESS | 14108 | |1;audio-beat-detection;148;128;153;170;129;157;155;131;179;130 04:24:41 INFO - PROCESS | 14108 | |2;audio-dft;161;162;165;163;161;163;161;165;168;164 04:24:41 INFO - PROCESS | 14108 | |3;audio-fft;73;73;75;73;72;143;72;75;73;74 04:24:41 INFO - PROCESS | 14108 | |4;audio-oscillator;97;96;146;96;96;96;144;97;96;142 04:24:41 INFO - PROCESS | 14108 | |5;imaging-gaussian-blur;110;109;111;110;110;109;110;110;109;110 04:24:41 INFO - PROCESS | 14108 | |6;imaging-darkroom;146;148;146;147;146;147;147;146;147;146 04:24:41 INFO - PROCESS | 14108 | |7;imaging-desaturate;97;97;97;98;96;96;97;96;96;96 04:24:41 INFO - PROCESS | 14108 | |8;json-parse-financial;60;61;59;59;61;60;60;60;69;63 04:24:41 INFO - PROCESS | 14108 | |9;json-stringify-tinderbox;67;68;69;70;71;67;68;68;68;68 04:24:41 INFO - PROCESS | 14108 | |10;stanford-crypto-aes;83;83;86;84;84;83;87;82;83;83 04:24:41 INFO - PROCESS | 14108 | |11;stanford-crypto-ccm;118;117;120;124;118;131;120;119;120;119 04:24:41 INFO - PROCESS | 14108 | |12;stanford-crypto-pbkdf2;135;148;148;156;147;149;151;145;139;133 04:24:41 INFO - PROCESS | 14108 | |13;stanford-crypto-sha256-iterative;67;70;68;68;67;67;67;69;68;67 04:24:41 INFO - PROCESS | 14108 | __end_tp_report 04:24:41 INFO - PROCESS | 14108 | __start_cc_report 04:24:41 INFO - PROCESS | 14108 | _x_x_mozilla_cycle_collect,752 04:24:41 INFO - PROCESS | 14108 | __end_cc_report 04:24:41 INFO - PROCESS | 14108 | __startTimestamp1453638281482__endTimestamp 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | ------- Summary: start ------- 04:24:41 INFO - PROCESS | 14108 | Number of tests: 14 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:3.77 (3.4%) stddev-sans-first:4.00 04:24:41 INFO - PROCESS | 14108 | Values: 111.0 106.0 110.0 111.0 110.0 121.0 111.0 111.0 110.0 112.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:154.00 stddev:18.18 (11.8%) stddev-sans-first:19.28 04:24:41 INFO - PROCESS | 14108 | Values: 148.0 128.0 153.0 170.0 129.0 157.0 155.0 131.0 179.0 130.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.24 04:24:41 INFO - PROCESS | 14108 | Values: 161.0 162.0 165.0 163.0 161.0 163.0 161.0 165.0 168.0 164.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#3] audio-fft Cycles:10 Average:80.30 Median:73.00 stddev:22.06 (30.2%) stddev-sans-first:23.23 04:24:41 INFO - PROCESS | 14108 | Values: 73.0 73.0 75.0 73.0 72.0 143.0 72.0 75.0 73.0 74.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:23.07 (24.0%) stddev-sans-first:23.94 04:24:41 INFO - PROCESS | 14108 | Values: 97.0 96.0 146.0 96.0 96.0 96.0 144.0 97.0 96.0 142.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:24:41 INFO - PROCESS | 14108 | Values: 110.0 109.0 111.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:24:41 INFO - PROCESS | 14108 | Values: 146.0 148.0 146.0 147.0 146.0 147.0 147.0 146.0 147.0 146.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 04:24:41 INFO - PROCESS | 14108 | Values: 97.0 97.0 97.0 98.0 96.0 96.0 97.0 96.0 96.0 96.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:60.50 stddev:2.97 (4.9%) stddev-sans-first:3.12 04:24:41 INFO - PROCESS | 14108 | Values: 60.0 61.0 59.0 59.0 61.0 60.0 60.0 60.0 69.0 63.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 04:24:41 INFO - PROCESS | 14108 | Values: 67.0 68.0 69.0 70.0 71.0 67.0 68.0 68.0 68.0 68.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.55 (1.9%) stddev-sans-first:1.62 04:24:41 INFO - PROCESS | 14108 | Values: 83.0 83.0 86.0 84.0 84.0 83.0 87.0 82.0 83.0 83.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.00 stddev:4.12 (3.4%) stddev-sans-first:4.26 04:24:41 INFO - PROCESS | 14108 | Values: 118.0 117.0 120.0 124.0 118.0 131.0 120.0 119.0 120.0 119.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:148.00 stddev:7.26 (4.9%) stddev-sans-first:6.72 04:24:41 INFO - PROCESS | 14108 | Values: 135.0 148.0 148.0 156.0 147.0 149.0 151.0 145.0 139.0 133.0 04:24:41 INFO - PROCESS | 14108 | 04:24:41 INFO - PROCESS | 14108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 04:24:41 INFO - PROCESS | 14108 | Values: 67.0 70.0 68.0 68.0 67.0 67.0 67.0 69.0 68.0 67.0 04:24:41 INFO - PROCESS | 14108 | -------- Summary: end -------- 04:24:41 INFO - PROCESS | 14108 | 04:24:42 INFO - TEST-INFO | 14108: exit 0 04:24:42 INFO - TEST-OK | kraken | took 59677ms 04:24:42 INFO - TEST-START | v8_7 04:24:42 INFO - operating with platform_type : linux_ 04:24:42 INFO - Initialising browser for v8_7 test... 04:24:42 INFO - TEST-INFO | started process 14395 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7z3tx6/profile http://localhost:36455/getInfo.html) 04:24:45 INFO - PROCESS | 14395 | 04:24:45 INFO - PROCESS | 14395 | (process:14466): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:24:46 INFO - PROCESS | 14395 | __metrics Screen width/height:1600/1200 04:24:46 INFO - PROCESS | 14395 | colorDepth:24 04:24:46 INFO - PROCESS | 14395 | Browser inner width/height: 1024/697 04:24:46 INFO - PROCESS | 14395 | __metrics 04:24:46 INFO - PROCESS | 14395 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:24:47 INFO - TEST-INFO | 14395: exit 0 04:24:47 INFO - Browser initialized. 04:24:47 INFO - Running cycle 1/1 for v8_7 test... 04:24:47 INFO - TEST-INFO | started process 14515 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7z3tx6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:48 INFO - PROCESS | 14515 | 04:24:48 INFO - PROCESS | 14515 | (process:14573): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:24:59 INFO - PROCESS | 14515 | RSS: Main: 150667264 04:24:59 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:36455/tests/v8_7/run.html (next: http://localhost:36455/tests/v8_7/run.html) 04:25:21 INFO - PROCESS | 14515 | RSS: Main: 152031232 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | __start_tp_report 04:25:21 INFO - PROCESS | 14515 | _x_x_mozilla_page_load 04:25:21 INFO - PROCESS | 14515 | _x_x_mozilla_page_load_details 04:25:21 INFO - PROCESS | 14515 | |i|pagename|runs| 04:25:21 INFO - PROCESS | 14515 | |0;Richards;166.41704110500916 04:25:21 INFO - PROCESS | 14515 | |1;DeltaBlue;189.75332068311195 04:25:21 INFO - PROCESS | 14515 | |2;Encrypt;278.473962684489 04:25:21 INFO - PROCESS | 14515 | |3;Decrypt;5186.5284974093265 04:25:21 INFO - PROCESS | 14515 | |4;RayTrace;1052.6315789473683 04:25:21 INFO - PROCESS | 14515 | |5;Earley;694.9270326615705 04:25:21 INFO - PROCESS | 14515 | |6;Boyer;12231.707317073171 04:25:21 INFO - PROCESS | 14515 | |7;RegExp;41959.183673469386 04:25:21 INFO - PROCESS | 14515 | |8;Splay;577.7007510109763 04:25:21 INFO - PROCESS | 14515 | |9;NavierStokes;4864.077669902913 04:25:21 INFO - PROCESS | 14515 | __end_tp_report 04:25:21 INFO - PROCESS | 14515 | __startTimestamp1453638321987__endTimestamp 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | ------- Summary: start ------- 04:25:21 INFO - PROCESS | 14515 | Number of tests: 10 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 04:25:21 INFO - PROCESS | 14515 | Values: 166.4 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#1] DeltaBlue Cycles:1 Average:189.75 Median:189.75 stddev:0.00 (0.0%) 04:25:21 INFO - PROCESS | 14515 | Values: 189.8 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 04:25:21 INFO - PROCESS | 14515 | Values: 278.5 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 04:25:21 INFO - PROCESS | 14515 | Values: 5186.5 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 04:25:21 INFO - PROCESS | 14515 | Values: 1052.6 04:25:21 INFO - PROCESS | 14515 | 04:25:21 INFO - PROCESS | 14515 | [#5] Earley Cycles:1 Average:694.93 Median:694.93 stddev:0.00 (0.0%) 04:25:22 INFO - PROCESS | 14515 | Values: 694.9 04:25:22 INFO - PROCESS | 14515 | 04:25:22 INFO - PROCESS | 14515 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 04:25:22 INFO - PROCESS | 14515 | Values: 12231.7 04:25:22 INFO - PROCESS | 14515 | 04:25:22 INFO - PROCESS | 14515 | [#7] RegExp Cycles:1 Average:41959.18 Median:41959.18 stddev:0.00 (0.0%) 04:25:22 INFO - PROCESS | 14515 | Values: 41959.2 04:25:22 INFO - PROCESS | 14515 | 04:25:22 INFO - PROCESS | 14515 | [#8] Splay Cycles:1 Average:577.70 Median:577.70 stddev:0.00 (0.0%) 04:25:22 INFO - PROCESS | 14515 | Values: 577.7 04:25:22 INFO - PROCESS | 14515 | 04:25:22 INFO - PROCESS | 14515 | [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 04:25:22 INFO - PROCESS | 14515 | Values: 4864.1 04:25:22 INFO - PROCESS | 14515 | -------- Summary: end -------- 04:25:22 INFO - PROCESS | 14515 | 04:25:22 INFO - TEST-INFO | 14515: exit 0 04:25:22 INFO - TEST-OK | v8_7 | took 40531ms 04:25:22 INFO - SUITE-END | took 1210s 04:25:23 INFO - Completed test suite (00:20:10) 04:25:23 INFO - Working with test: dromaeo_css 04:25:23 INFO - Generating results file: dromaeo_css 04:25:23 INFO - Working with test: kraken 04:25:23 INFO - Generating results file: kraken 04:25:23 INFO - javascript benchmark 04:25:23 INFO - Working with test: v8_7 04:25:23 INFO - Generating results file: v8_7 04:25:23 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 04:25:23 INFO - process_Request line: dromaeo_css 6962.12 graph.html#tests=[[72,63,43]] 04:25:23 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:23 INFO - process_Request line: kraken 1513.40 graph.html#tests=[[232,63,43]] 04:25:23 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:25:23 INFO - process_Request line: v8_7 20507.05 graph.html#tests=[[230,63,43]] 04:25:23 INFO - RETURN: dromaeo_css: 6962.12 04:25:23 INFO - RETURN: kraken: 1513.40 04:25:23 INFO - RETURN: v8_7: 20507.05 04:25:23 INFO - javascript benchmark 04:25:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3192.776505644604, 3196.0411876437065, 3228.903132906011, 3243.5459035734984, 3247.772655914086, 5226.08543504887, 5270.393904700961, 5270.683758974459, 5278.947210527894, 5280.735963201843, 5248.921266181011, 5264.8157314494, 5270.077736396134, 5293.073712100387, 5311.9468805311935, 4566.3607095006555, 4846.539578740014, 4965.0566392385335, 4969.428515720684, 4973.353464049668, 4790.329353890458, 4890.951090489103, 4930.876728081808, 4950.282209079682, 4950.6287028472825, 4812.061647978646, 4857.878553036167, 4869.099216644932, 4886.315915771795, 4930.975345123269, 4813.326134341195, 4829.830955916526, 4848.369711937461, 4869.951300486985, 4899.265110233458, 4769.0, 4827.565519103263, 4833.2266837306215, 4835.032993401333, 4850.078485087822, 5111.131107711661, 5116.641835071547, 5162.0, 5172.172452407597, 5198.870028249324, 5571.387147413781, 5688.232088668018, 5695.886082278331, 5703.173039909231, 5749.195112684228, 5610.635308704921, 5733.254676892019, 5737.282839645044, 5739.053056245714, 5777.884442311172, 5330.840074797762, 5341.0, 5341.1187154119525, 5348.545373643206, 5376.784928602851, 5824.388439213906, 5828.184054232411, 5839.299284085937, 5844.1818145459665, 5856.326522449973, 5532.834014979557, 5614.9157762633595, 5616.410276920946, 5630.0, 5716.056850619684, 5737.340205876294, 5752.798652047159, 5755.539556835443, 5767.452092051249, 5770.307563092456, 5697.4302569742695, 5709.65742055478, 5714.114312281603, 5716.056850619601, 5723.971380143156, 5544.611877168641, 5642.435756424325, 5651.802186923438, 5664.85837854057, 5743.9425605744245, 4428.623566996841, 4436.0906014267, 4443.333499974965, 4446.221911165533, 4471.530489298577, 3900.2199560088097, 3941.6649584785614, 3958.5447673517338, 3979.10470144221, 4009.979950100231, 5347.331583552056, 5436.456354364532, 5444.863878402993, 5464.3442786865835, 5512.80705175325, 5748.396418376094, 5759.819237056394, 5767.134929760569, 5768.798092066758, 5769.105788602773, 5262.394824595221, 5289.047971365191, 5419.403865574784, 5428.782848686087, 5437.45625437461, 4862.586680132157, 4865.416150062015, 4885.462599114095, 4916.754162291871, 4933.9013219736125, 5917.0, 5984.640921544634, 5990.670513121733, 6008.759649614054, 6015.4586087252355, 5590.357108932362, 5670.4329567044615, 5703.08750599902, 5784.509060766233, 5835.387284335254, 5928.584999050197, 5935.109733540004, 5951.880962380642, 6003.969980150071, 6062.120992455981, 5650.0, 5684.403137670485, 5686.203931449518, 5687.800926967537, 5718.971405142947, 5694.117411801178, 5699.059655156852, 5717.5425965921795, 5782.5663075268685, 5805.3033635962265, 5182.196759502283, 5563.972180139073, 5571.9721401392735, 5588.748506317144, 5609.354924183771, 5502.80740174092, 5538.584606154635, 5579.3304803422225, 5586.078297080936, 5590.413006634408, 5390.757415916371, 5472.0, 5489.368722596792, 5528.391876893458, 5550.639208451437, 5586.078297081099, 5595.272614560081, 5614.214010038516, 5619.297587801525, 5637.577181711306, 5486.231927530229, 5487.259220005249, 5499.1476321170285, 5507.0637991542335, 5567.0], "unit": "score", "name": "dojo.html", "value": 5271.453223288602}, {"lowerIsBetter": false, "replicates": [484.5493690867494, 522.9294045303888, 547.2967237100326, 559.5383808358105, 569.2969183058924, 27768.166954991357, 35040.29919401614, 35143.297134057306, 35430.468542971874, 35538.0, 38654.61345386545, 39312.41031384524, 39383.0, 39489.21021579567, 39563.20873582527, 8386.287165590917, 8513.318934485258, 8558.572071396437, 8560.272376847975, 8568.0, 8230.382721295897, 8330.791730206733, 8337.708180213695, 8358.247757701805, 8362.038365587943, 8368.790780230513, 8424.410291279613, 8439.57802109892, 8458.661653533882, 8487.830243395128, 8416.0, 8431.40980131391, 8497.787555311135, 8522.446041007315, 8621.094785047542, 8404.453710508797, 8602.956985215034, 8606.139386061344, 8606.354523410706, 8618.181272779077, 39293.60706392928, 39424.21151576981, 39765.602343976476, 39771.403428948586, 39942.20115597672, 2881.812682175652, 2961.689022652612, 3001.4897467430587, 3144.5912031435996, 3229.3056992746438, 28991.710082899113, 29607.85196074006, 29926.102216933527, 29966.101016969526, 30124.69875301241, 3897.7271590988644, 3938.5667576566557, 3942.329803933338, 3985.6612187964056, 4045.898852528681, 190683.0, 193338.0, 193616.0, 194178.0, 194497.0, 48836.75581622069, 54423.0, 54503.72748136313, 54889.451105489235, 55002.0, 44497.55502444999, 57761.0, 57818.71090644604, 58145.0, 58191.709041454524, 15417.537473875802, 15605.0, 15693.450729224422, 15713.135777532118, 15746.68506629861, 11065.114790816715, 11131.610393636345, 11173.441327933571, 11205.991460768408, 11239.494222759995, 18044.819551804576, 18172.182251798702, 18297.26810927548, 18350.908245458686, 18951.052447377577, 7516.586587737727, 7677.0, 7687.2697093776005, 7817.57003364809, 7870.9606451967375, 852.1946760311446, 868.2446271743623, 890.0921060518235, 893.5041052215953, 899.7210864631854, 24492.14277500279, 24911.750882490942, 27872.0, 28451.857740711162, 28665.856670716512, 959.1367769007949, 985.1576901749045, 1001.7595777013464, 1011.585250047477, 1110.4669758515797, 13682.452701891812, 13921.850950796841, 14130.64673383153, 14157.0, 14284.714305713827, 325135.0, 325638.0, 326512.0, 328728.0, 330429.0, 48426.0, 48707.0, 48768.26847597289, 48812.755936220805, 48912.0, 1315.0597322914161, 1359.3475131936527, 1362.257569624557, 1362.6457121148374, 1362.9795553066713, 26476.8676156618, 27157.0, 27225.31936701598, 27253.182404527895, 27581.448371032868, 44601.0, 44681.0, 44723.0, 44932.550674492835, 44962.0, 262577.0, 266301.0, 266777.0, 266869.0, 267012.0, 30060.0, 31252.0, 31366.529502057943, 31437.214069648442, 31716.0, 37103.62896371002, 37490.81254593709, 37575.624243757215, 37878.43182352322, 38443.42334864923, 34101.82949085338, 34108.488372674925, 34782.47826282557, 34849.0, 35044.123896901765, 33988.83005584956, 34322.14194645154, 34933.82533087318, 35232.0, 35265.11837203988, 33883.0, 33985.3202935935, 34067.318653626295, 34147.65852341445, 34232.657673422946, 29249.122526324245, 29908.252293692833, 31467.52798708067, 32108.839455803507, 32376.676233238308, 22845.771542284365, 23738.525229494968, 24182.0, 24425.633615495426, 24745.87627061925], "unit": "score", "name": "ext.html", "value": 17468.12902489108}, {"lowerIsBetter": false, "replicates": [352.5416957954659, 355.96084430712625, 373.74772028880517, 376.4353469795309, 378.1567105355056, 11296.717582060453, 11722.0, 15483.767743483842, 16711.16444177791, 17665.646687066266, 16894.324227030935, 17001.48995530133, 17619.647607047853, 18046.18792154353, 18091.81908180921, 6076.118962750387, 6275.090111933767, 6316.589421687599, 6324.146240257553, 6327.651979141146, 5989.191459153024, 6116.388361163892, 6190.814275571717, 6198.34917333678, 6216.222972128484, 6179.134921111048, 6225.47083497901, 6227.532935029891, 6246.187995560594, 6511.869762604745, 6394.0, 6406.327335629761, 6461.06314584385, 6643.236027856762, 6985.930140698579, 6501.414872661436, 6613.636250006248, 6620.536562440631, 6685.699143538553, 6687.264400915896, 21272.78727212739, 21629.891850540804, 22203.777962220494, 22295.0, 22338.66492002621, 2188.1466228171025, 2216.1357070742424, 2234.2515257388795, 2275.3628983884537, 2460.4463995601027, 13604.455821767118, 14031.929840350835, 14098.788518172236, 14367.281635918267, 14375.928120359436, 1875.1749230338608, 1929.9674674049315, 1963.901804909763, 1976.090998140857, 2009.8392128629675, 61300.38699612991, 63208.367916320705, 63349.0, 64067.679661601396, 64694.35305646931, 14438.783418248735, 15142.091474511344, 15147.697046059016, 15228.086314821147, 15244.923775381052, 23029.0, 23139.76860231376, 23152.88423557905, 23382.53234935326, 23399.41501462477, 9049.321300902327, 9158.95420522893, 9175.174234318943, 9250.306227033, 9298.95350523243, 7739.148693643695, 7770.922290777133, 7801.297883190427, 7818.257265559762, 7829.099653539915, 7479.252074792477, 7586.165521792598, 7588.051493563305, 7601.543907365576, 7634.50375725576, 1799.1454059321718, 1859.7582314299054, 2949.439606474763, 3059.5563643272044, 3123.141136187521, 832.0, 857.3355649371787, 887.3921363865772, 968.1867231525553, 996.1035068438464, 14331.85668143326, 16005.67988640244, 16320.0, 16549.338026479047, 16555.917220414063, 854.372036553133, 921.9216366608913, 923.0538697834639, 928.7817362919709, 980.7401038724744, 8652.3510736695, 9044.819103618023, 9145.634174633073, 9276.397034192756, 9335.206507446806, 386810.0, 393197.0, 397252.0, 403981.0, 472422.0, 70103.64948175328, 70309.0, 71191.64404177947, 73667.63166184135, 74490.62754686191, 1143.0626885953438, 1165.7726743284977, 1169.5321871251567, 1172.2146162071433, 1173.5188572685158, 14972.401103956156, 15028.849711502746, 15146.924265379044, 15178.24108794578, 15458.768118478007, 31332.843335783175, 31354.0, 31790.52314215335, 32263.193420164684, 32611.673883261814, 41631.7918410406, 41858.58141418547, 42004.78997604993, 42102.789486052374, 45034.09931801411, 7062.435005199469, 7161.355478007004, 7235.782926512213, 7363.77908662741, 7400.296971787671, 9076.500792456478, 10507.31702439339, 11047.889521105008, 11089.22375433712, 11285.040771534512, 9435.0, 9609.792655508369, 9972.700818975442, 10168.898311016796, 10194.898051019394, 9736.41581505112, 10048.447335396624, 10057.145142662663, 10223.539940702538, 10487.0, 9611.567479463582, 10078.143357814668, 10217.182625389802, 10331.483425828828, 10358.792824143626, 7403.296686814744, 7573.2048134947245, 7583.9620801895635, 7598.316151546387, 7600.543967361976, 8711.25954293892, 9898.703038908845, 9917.801643966935, 10034.899651003396, 10050.949745251228], "unit": "score", "name": "jquery.html", "value": 8976.152452218568}, {"lowerIsBetter": false, "replicates": [1425.6863490032192, 1437.7578560346417, 1589.7059044076839, 1715.8198389169129, 1761.524388415128, 7742.922570774291, 7793.298603125718, 7918.524888506679, 7952.522848629086, 8009.4793838400465, 8162.755117346489, 8191.467554608947, 8212.876806847888, 8329.666813327474, 8342.416030877841, 2154.267549033332, 2172.435166856613, 2186.147402513021, 2186.5080356919725, 2192.112194561197, 2172.543765809174, 2205.52581195043, 2207.569523942832, 2208.094681180716, 2232.2968264996557, 2143.732033495813, 2168.2627906511784, 2198.120751699317, 2199.5490924360547, 2205.184081889695, 2162.664786958024, 2174.499865031044, 2208.2381578355444, 2209.668549717539, 2210.6794514795347, 2200.207925146946, 2212.856164349312, 2218.0684112672716, 2222.3221917315213, 2224.5217278285245, 7838.333741631968, 7893.13175550689, 7916.643751031217, 7949.523028618243, 7987.400944929153, 4853.927191092136, 5042.672226305279, 5043.42000669924, 5061.493850614946, 5061.670991385548, 3046.9695303046906, 3155.842207889619, 3254.1213872254593, 3255.869765209389, 3267.39553182662, 1053.1890444357803, 1064.7178497698117, 1086.4187659602076, 1102.7188067042932, 1992.6911328744068, 10890.183236257313, 10922.0, 10983.505742241538, 11037.448127593589, 11051.0, 4298.312270036841, 4345.782710864444, 4390.495093064274, 4390.648748100144, 4398.692091553625, 8899.466032038099, 8911.643534258557, 8940.50827204497, 8956.68651597191, 8984.371094023487, 4862.6839255448285, 4864.708117512961, 4897.902041959141, 4907.043126590281, 4923.433805112386, 4454.665900057508, 4487.618552423015, 4493.483249426358, 4512.34570987205, 4531.093781243699, 3286.4084464796088, 3369.22507823202, 3409.079548521885, 3418.2308980479193, 3427.588689357293, 1049.9527521261562, 1052.147760314148, 1059.7562560611102, 1066.6106870992032, 1076.6716151573846, 920.052346083535, 920.0753242990752, 1081.0486771640906, 1133.8582677165355, 1321.85459599444, 7198.0, 7257.237990011078, 7321.414286857039, 7333.083364579427, 7364.594947277951, 587.7795826565039, 589.4164776870867, 590.4272855330323, 597.2593983460478, 712.4015826705593, 5717.2281741965135, 5782.306123265235, 5801.767929282866, 5982.282126144803, 6166.969165154145, 9527.857082143773, 9589.328746987783, 9607.615695372107, 9663.226941844636, 9756.90243097574, 9405.20055795265, 9409.38838975478, 9441.24470042395, 9574.856377154209, 9614.855777163348, 7398.186199518049, 7529.096508419025, 7534.886976695354, 7550.622468876534, 7568.281013303837, 7299.124105107421, 7390.29792169743, 7520.135184453639, 7580.696772129053, 7604.353629941517, 8365.330773538224, 8622.094680058504, 8639.611217495101, 8672.262857656917, 8678.218960293352, 8704.869426958727, 8851.46891186531, 8923.643054278016, 8932.598033088396, 9077.364584479023, 7063.117110361205, 7092.219855815959, 7146.428285737233, 7190.856182876209, 7208.06295181623, 7476.663550140148, 7578.12851522082, 7588.317051465395, 7601.619919004138, 7604.695812167452, 6914.9308506914285, 7137.500374973702, 7198.2801719829695, 7317.670704818403, 7349.118105827335, 6839.942551663711, 6933.479989000744, 7079.256678048937, 7119.82200444993, 7164.856702866018, 7111.040009598845, 7178.353948144692, 7183.425325974014, 7184.46116541251, 7187.6765545551625, 6483.0, 6546.378094081055, 6577.309382514767, 6592.077109204619, 6622.635755033327, 6373.681315934277, 6480.060391243149, 6486.481081513562, 6500.382463665944, 6501.9674901625185], "unit": "score", "name": "mootools.html", "value": 4473.087330630659}, {"lowerIsBetter": false, "replicates": [342.5273123090135, 355.69054922217657, 359.15598343891855, 361.2215675219902, 364.5516015301181, 6156.7537298508005, 6281.528885333595, 6305.054241863722, 6327.683615819214, 6365.840853978647, 6022.638641681502, 6229.283632382278, 6234.781782637609, 6269.404406581379, 6269.843253918654, 4763.047390521892, 4774.665773395864, 4795.664303498756, 4804.087223427555, 4810.302506136608, 4814.253790662436, 4816.988432429194, 4822.228443449048, 4824.927626085594, 4826.806927722887, 4676.976615116937, 4723.409573803275, 4748.881277968044, 4770.379850619414, 4772.188727916246, 4745.122152401782, 4752.453467851206, 4754.120487709767, 4771.713697178146, 4773.236282194867, 4158.293090174678, 4159.750414975111, 4197.958020419787, 4201.97899010503, 4209.431726716884, 5880.911786323209, 5904.114382842565, 5904.61619994699, 5924.526037916957, 5927.37762534932, 5392.083345831218, 5535.612507124503, 5541.0580201365865, 5552.750126244288, 5552.86117847053, 6506.056621789814, 6528.249251336062, 6544.247411547638, 6545.509086818508, 6580.407763301326, 4648.163330600491, 4654.720716757005, 4660.72035677857, 4664.39362882823, 4670.836520721792, 6632.0, 6923.342282483156, 6934.583924964468, 6942.861142777167, 6963.547369420971, 4728.338032675429, 4735.2423612222565, 4737.194676904935, 4740.976295118571, 4751.59611433032, 4782.33047373368, 4791.089692958327, 4791.712497250106, 4794.424669039668, 4811.446683631427, 5505.339359276913, 5524.972375138099, 5527.170924361378, 5532.806351777749, 5539.612227144061, 6565.0, 6638.4689224861895, 6669.599824010575, 6674.432673222734, 6675.666216689243, 1645.983540164583, 1686.7048266553304, 1687.392538686072, 1691.4671878358279, 1712.5119340987758, 1064.9254552181274, 1074.7420619051527, 1077.3751224289892, 1078.7033565769477, 1084.8318510630866, 6248.31268560458, 6249.687515624291, 6258.15514905491, 6259.155014073133, 6273.905891411632, 6694.129763130762, 6703.698333575001, 6704.363085506869, 6734.932650673529, 6739.59562426256, 6130.877382452326, 6203.627782333075, 6260.843478912972, 6268.717907694165, 6269.028300613412, 3645.052286405554, 3648.872289469856, 3655.3420384330543, 3674.0998455378603, 3675.1363429594026, 7018.40343570792, 7041.1902631197045, 7042.894356584656, 7043.190033146151, 7052.753153639701, 6769.356911093537, 6917.619530925746, 6924.0, 6943.0, 6958.165020197609, 7028.683709233097, 7028.824279392954, 7038.260982596856, 7039.648017599099, 7041.964790176119, 6720.966395167993, 6744.932550674431, 6750.25747167821, 6755.392014718699, 6765.763198288037, 6577.3422657733845, 6672.766453174116, 6704.229013663296, 6705.027770973084, 6711.530192886451, 7019.929800701928, 7058.0, 7058.576485410892, 7069.9646501767165, 7070.292970702889, 4670.486246512949, 4701.059788042474, 4708.317293992283, 4710.929336059893, 4716.8113275468595, 6717.891547894543, 6801.7279308829075, 6822.0, 6857.108575885103, 6919.273476284918, 6625.50308726857, 6636.634985075674, 6678.365555272241, 6704.329567043256, 6712.127423434922, 6655.933440665532, 6730.899036514358, 6741.22475915276, 6752.662366881538, 6763.93236067633, 6489.772857949949, 6552.049952756728, 6605.339466053356, 6607.867842643024, 6626.204855417188, 6736.955771855371, 6756.527043106936, 6759.425448836707, 6770.5599136056, 6793.966030169818, 6534.444572211415, 6553.868922621617, 6580.934190658032, 6588.868222635616, 6589.934100659124], "unit": "score", "name": "prototype.html", "value": 4992.176365153208}, {"lowerIsBetter": false, "replicates": [746.0078096132145, 748.9288517590828, 765.0322342237067, 798.9773090444231, 805.8267472493412, 12653.240805551663, 12906.677333066666, 12937.676558086052, 12969.935150324236, 12982.610521684353, 12065.638030859067, 12336.383180840945, 12380.876191238085, 12460.252384856893, 12480.188787728792, 814.0313027497274, 829.1542626520945, 831.4387788242942, 832.9625166867476, 834.6077343648476, 819.7417813388794, 822.3996482567729, 822.8560001999656, 825.2531459029558, 825.6738588257634, 855.6534603485599, 857.7512521368827, 858.8110615664575, 859.4628357276702, 863.6674880171148, 851.8126012277289, 853.7609469348562, 857.7855536115972, 858.2919091749332, 860.5095095795399, 626.987460250797, 628.3057221769969, 628.45324567626, 630.3538872655519, 631.1447987976318, 12423.4409451574, 12495.687607809787, 12509.06182036351, 12522.436490357955, 12559.811602825965, 10852.511636976355, 11087.944560277228, 11298.661040168809, 11315.094792416587, 11443.713907152387, 9361.0, 9588.280878934107, 9594.0, 9987.250956178243, 10056.497175141214, 3510.701590364822, 3547.290541891606, 3564.198055437532, 3584.982075089608, 3592.5329707138167, 42586.78706606478, 42587.78706106481, 45997.54002459999, 46871.0, 47157.76421117873, 10056.50111955004, 10090.394576325298, 10114.898851011396, 10212.948935255276, 10507.684769456928, 17343.566410839576, 17360.95834249949, 17365.652686946443, 17377.131143442777, 17400.564985875455, 7664.271894170045, 7673.501222420525, 7695.6152192390155, 7699.576523291273, 7944.404169687296, 4416.271315233015, 4463.776811159429, 4465.754383508938, 4581.404417425713, 4601.4248218972625, 3256.3812875553567, 3259.6414394416597, 3278.47544392896, 3280.507923811447, 3284.2774589590254, 612.1643956000116, 615.7167702856736, 618.8762247550418, 628.4815027602247, 628.5129025005657, 505.90387826312883, 558.4331903118339, 639.7025383196743, 643.2731013954202, 653.8071268975664, 8276.255137037695, 8334.458260213189, 8364.45631033993, 8438.66245350179, 8647.0, 559.9356074051454, 628.5945565110478, 642.7236288395941, 646.7219095788856, 648.8799572079181, 4138.255114079434, 4196.286631272691, 4227.070044590185, 4235.830566777356, 4272.380504826782, 53123.0, 54127.0, 54901.0, 55653.0, 55921.0, 42462.0, 47173.5282647176, 48678.26982595264, 48865.0, 49507.75246123746, 43483.13033739307, 43991.56008439939, 43996.780016100354, 44987.775061124485, 45459.31811022837, 8806.383553151474, 8813.779655508664, 8969.14793094655, 9076.954615227145, 9113.498757568397, 32585.18537036593, 33161.83419082889, 33577.49633755447, 33610.327793444485, 34178.31643367169, 41191.0, 42978.78510607552, 43029.0, 43977.0, 44188.55811441845, 10268.281220314506, 10286.2799604027, 10424.895751042695, 10469.842952355568, 10616.787664246825, 11428.657140285804, 11582.71043223926, 11612.825807612724, 11781.941090294837, 11936.343501107522, 11387.0, 11399.316041037564, 11452.255603385753, 11474.713132171762, 11584.826227606423, 10356.792864142524, 10400.375977441377, 10629.840552391566, 10660.147188224768, 10763.892361076601, 11049.779004420026, 11071.5571377144, 11133.443327833415, 11179.88820111821, 11191.0, 8866.689665861664, 8982.236509896471, 9011.864822027545, 9068.682596109105, 9326.580303886478, 8704.26013788835, 8789.472631642122, 8878.86681699788, 8970.820583588422, 9538.761530961781], "unit": "score", "name": "yui.html", "value": 6169.4863071090085}], "name": "dromaeo_css", "value": 6962.120176611519}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 111.0, 110.0, 121.0, 111.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [148.0, 128.0, 153.0, 170.0, 129.0, 157.0, 155.0, 131.0, 179.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 165.0, 163.0, 161.0, 163.0, 161.0, 165.0, 168.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 75.0, 73.0, 72.0, 143.0, 72.0, 75.0, 73.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 146.0, 96.0, 96.0, 96.0, 144.0, 97.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 59.0, 59.0, 61.0, 60.0, 60.0, 60.0, 69.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 70.0, 71.0, 67.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 84.0, 84.0, 83.0, 87.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 120.0, 124.0, 118.0, 131.0, 120.0, 119.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 148.0, 156.0, 147.0, 149.0, 151.0, 145.0, 139.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1513.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [189.75332068311195], "unit": "score", "name": "DeltaBlue", "value": 348.44186000000013}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1052.6315789473683], "unit": "score", "name": "RayTrace", "value": 702.9895499999999}, {"lowerIsBetter": false, "replicates": [694.9270326615705], "unit": "score", "name": "Earley", "value": 959.0402569999998}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [41959.183673469386], "unit": "score", "name": "RegExp", "value": 21.711218385214018}, {"lowerIsBetter": false, "replicates": [577.7007510109763], "unit": "score", "name": "Splay", "value": 141.06092100000006}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 20507.054844464827}]} 04:25:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20507.05"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6962.12"}}} 04:25:23 INFO - Return code: 0 04:25:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:25:23 INFO - # TBPL SUCCESS # 04:25:23 INFO - Running post-action listener: _resource_record_post_action 04:25:23 INFO - Running post-run listener: _resource_record_post_run 04:25:24 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550174720; Read time: 48; Write time: 457816 04:25:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236351488; Read time: 0; Write time: 285304 04:25:24 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313823232; Read time: 48; Write time: 172512 04:25:24 INFO - Running post-run listener: _upload_blobber_files 04:25:24 INFO - Blob upload gear active. 04:25:24 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:25:24 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 04:25:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:25:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:25:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:25:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:26 INFO - (blobuploader) - INFO - Done attempting. 04:25:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:25:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:25:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:26 INFO - (blobuploader) - INFO - Done attempting. 04:25:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:26 INFO - Return code: 0 04:25:26 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:25:26 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e72447505285e823111884a69b2dd0dbec21653780bd57276b89f15d80bf676448c32601608c1ada5c5d4b83999f4c1903ef0a370f57d9b44518e35aaff505ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae7b74731085fdcc517398cdc683f6fbd7807a1dc736a49b4d3c62329c63aa1b7ae82dd8d2d7640f849fc2575a5642885f637b6a169b183670f84185c22fb2e"} 04:25:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:25:26 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:25:26 INFO - Contents: 04:25:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e72447505285e823111884a69b2dd0dbec21653780bd57276b89f15d80bf676448c32601608c1ada5c5d4b83999f4c1903ef0a370f57d9b44518e35aaff505ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae7b74731085fdcc517398cdc683f6fbd7807a1dc736a49b4d3c62329c63aa1b7ae82dd8d2d7640f849fc2575a5642885f637b6a169b183670f84185c22fb2e"} 04:25:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:26 INFO - Copying logs to upload dir... 04:25:26 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:25:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.835801 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-24 04:25:26.032612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 04:25:26.036718) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 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-Inbound/sha512/e72447505285e823111884a69b2dd0dbec21653780bd57276b89f15d80bf676448c32601608c1ada5c5d4b83999f4c1903ef0a370f57d9b44518e35aaff505ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae7b74731085fdcc517398cdc683f6fbd7807a1dc736a49b4d3c62329c63aa1b7ae82dd8d2d7640f849fc2575a5642885f637b6a169b183670f84185c22fb2e"} build_url:https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/DVw-UalNTNm1D942TbBRsQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e72447505285e823111884a69b2dd0dbec21653780bd57276b89f15d80bf676448c32601608c1ada5c5d4b83999f4c1903ef0a370f57d9b44518e35aaff505ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0ae7b74731085fdcc517398cdc683f6fbd7807a1dc736a49b4d3c62329c63aa1b7ae82dd8d2d7640f849fc2575a5642885f637b6a169b183670f84185c22fb2e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-24 04:25:26.061793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:25:26.062129) ========= 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=82e07478c745e68b1fe4678a000001bc-1453636167.616307-190497591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-24 04:25:26.148286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 04:25:26.148802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-24 04:25:26.149122) ========= ========= Total master_lag: 0.50 =========