builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1450904115.41 results: success (0) buildid: 20151223103050 builduid: 7de1a80ff04445679793402889c8c0cf revision: 24a27da1a369c93df5b446483c8efdeecab96aaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.409568) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.410073) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.410356) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006205 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.432970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.433272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.446629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.447003) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.496314) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.496630) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.496987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.497253) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 12:55:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-23 12:55:16 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.693178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.693499) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014412 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.743392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:15.743769) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 24a27da1a369c93df5b446483c8efdeecab96aaf --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 24a27da1a369c93df5b446483c8efdeecab96aaf --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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 12:55:16,559 truncating revision to first 12 chars 2015-12-23 12:55:16,559 Setting DEBUG logging. 2015-12-23 12:55:16,559 attempt 1/10 2015-12-23 12:55:16,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/24a27da1a369?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 12:55:16,790 unpacking tar archive at: mozilla-inbound-24a27da1a369/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:16.278338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:16.278667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:16.288329) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:16.288593) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 12:55:16.288969) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-23 12:55:16.289247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:55:17 INFO - MultiFileLogger online at 20151223 12:55:17 in /builds/slave/test-pgo 12:55:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:55:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:55:17 INFO - {'append_to_log': False, 12:55:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:55:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:55:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:55:17 INFO - 'branch': 'Mozilla-Inbound', 12:55:17 INFO - 'buildbot_json_path': 'buildprops.json', 12:55:17 INFO - 'config_files': ('talos/linux_config.py',), 12:55:17 INFO - 'default_actions': ('clobber', 12:55:17 INFO - 'read-buildbot-config', 12:55:17 INFO - 'download-and-extract', 12:55:17 INFO - 'populate-webroot', 12:55:17 INFO - 'create-virtualenv', 12:55:17 INFO - 'install', 12:55:17 INFO - 'run-tests'), 12:55:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:55:17 INFO - 'download_minidump_stackwalk': True, 12:55:17 INFO - 'download_symbols': 'ondemand', 12:55:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:55:17 INFO - 'tooltool.py': '/tools/tooltool.py', 12:55:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:55:17 INFO - '/tools/misc-python/virtualenv.py')}, 12:55:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:55:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:55:17 INFO - 'installer_path': 'installer.exe', 12:55:17 INFO - 'log_level': 'info', 12:55:17 INFO - 'log_name': 'talos', 12:55:17 INFO - 'log_to_console': True, 12:55:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:55:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:55:17 INFO - 'opt_config_files': (), 12:55:17 INFO - 'pip_index': False, 12:55:17 INFO - 'sps_profile': False, 12:55:17 INFO - 'sps_profile_interval': 0, 12:55:17 INFO - 'suite': 'dromaeojs', 12:55:17 INFO - 'system_bits': '64', 12:55:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:55:17 INFO - 'title': 'talos-linux64-ix-011', 12:55:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:55:17 INFO - 'use_talos_json': True, 12:55:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:55:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:55:17 INFO - 'work_dir': 'build'} 12:55:17 INFO - ##### 12:55:17 INFO - ##### Running clobber step. 12:55:17 INFO - ##### 12:55:17 INFO - Running pre-action listener: _resource_record_pre_action 12:55:17 INFO - Running main action method: clobber 12:55:17 INFO - rmtree: /builds/slave/test-pgo/build 12:55:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:55:17 INFO - Running post-action listener: _resource_record_post_action 12:55:17 INFO - ##### 12:55:17 INFO - ##### Running read-buildbot-config step. 12:55:17 INFO - ##### 12:55:17 INFO - Running pre-action listener: _resource_record_pre_action 12:55:17 INFO - Running main action method: read_buildbot_config 12:55:17 INFO - Using buildbot properties: 12:55:17 INFO - { 12:55:17 INFO - "project": "", 12:55:17 INFO - "product": "firefox", 12:55:17 INFO - "script_repo_revision": "production", 12:55:17 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:55:17 INFO - "repository": "", 12:55:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:55:17 INFO - "buildid": "20151223103050", 12:55:17 INFO - "pgo_build": "True", 12:55:17 INFO - "basedir": "/builds/slave/test-pgo", 12:55:17 INFO - "buildnumber": 594, 12:55:17 INFO - "slavename": "talos-linux64-ix-011", 12:55:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:55:17 INFO - "platform": "ubuntu64_hw", 12:55:17 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:55:17 INFO - "branch": "mozilla-inbound", 12:55:17 INFO - "repo_path": "integration/mozilla-inbound", 12:55:17 INFO - "revision": "24a27da1a369c93df5b446483c8efdeecab96aaf", 12:55:17 INFO - "stage_platform": "linux64-pgo", 12:55:17 INFO - "builduid": "7de1a80ff04445679793402889c8c0cf", 12:55:17 INFO - "slavebuilddir": "test" 12:55:17 INFO - } 12:55:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:55:17 INFO - Running post-action listener: _resource_record_post_action 12:55:17 INFO - ##### 12:55:17 INFO - ##### Running download-and-extract step. 12:55:17 INFO - ##### 12:55:17 INFO - Running pre-action listener: _resource_record_pre_action 12:55:17 INFO - Running main action method: download_and_extract 12:55:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:55:17 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')]} 12:55:17 INFO - https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:55:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/test_packages.json 12:55:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/test_packages.json 12:55:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:55:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:55:18 INFO - Downloaded 1302 bytes. 12:55:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:55:18 INFO - Using the following test package requirements: 12:55:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:55:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'jsshell-linux-x86_64.zip'], 12:55:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:55:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:55:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:55:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:55:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:55:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:55:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:55:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:18 INFO - https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:55:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:19 INFO - Downloaded 23183098 bytes. 12:55:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:55:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:55:20 INFO - Return code: 0 12:55:20 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 12:55:20 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')]} 12:55:20 INFO - https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:55:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:21 INFO - Downloaded 23183098 bytes. 12:55:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:55:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:55:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:55:22 INFO - Return code: 0 12:55: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')]} 12:55:22 INFO - https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:55:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:23 INFO - Downloaded 11132277 bytes. 12:55:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:55:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:55:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:55:23 INFO - Return code: 0 12:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:23 INFO - https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/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 12:55:25 INFO - Downloaded 54867937 bytes. 12:55:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:55:25 INFO - mkdir: /builds/slave/test-pgo/properties 12:55:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:55:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:55:25 INFO - Contents: 12:55:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:55:25 INFO - Running post-action listener: _resource_record_post_action 12:55:25 INFO - Running post-action listener: set_extra_try_arguments 12:55:25 INFO - ##### 12:55:25 INFO - ##### Running populate-webroot step. 12:55:25 INFO - ##### 12:55:25 INFO - Running pre-action listener: _resource_record_pre_action 12:55:25 INFO - Running main action method: populate_webroot 12:55:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:55:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:55:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:55:25 INFO - '--tppagecycles', 12:55:25 INFO - '7'], 12:55:25 INFO - 'tests': ['tsvgm']}}, 12:55:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:55:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:55:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:55:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:55:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:55:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'tests': ['damp', 'tps']}, 12:55:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['damp', 'tps']}, 12:55:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:55:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:55:25 INFO - 'other': {'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'other_l64': {'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'other_nol64': {'tests': ['a11yr', 12:55:25 INFO - 'ts_paint', 12:55:25 INFO - 'tpaint', 12:55:25 INFO - 'sessionrestore', 12:55:25 INFO - 'sessionrestore_no_auto_restore']}, 12:55:25 INFO - 'svgr': {'tests': ['tsvgx', 12:55:25 INFO - 'tsvgr_opacity', 12:55:25 INFO - 'tart', 12:55:25 INFO - 'tscrollx', 12:55:25 INFO - 'cart']}, 12:55:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['tsvgx', 12:55:25 INFO - 'tsvgr_opacity', 12:55:25 INFO - 'tart', 12:55:25 INFO - 'tscrollx', 12:55:25 INFO - 'cart']}, 12:55:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'tests': ['tp5o']}, 12:55:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'talos_options': ['--e10s'], 12:55:25 INFO - 'tests': ['tp5o']}, 12:55:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'talos_options': ['--xperf_path', 12:55:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:25 INFO - 'tests': ['tp5n']}, 12:55:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:55:25 INFO - 'talos_options': ['--e10s', 12:55:25 INFO - '--xperf_path', 12:55:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:55:25 INFO - 'tests': ['tp5n']}}, 12:55:25 INFO - 'talos.zip': {'path': '', 12:55:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:55:25 INFO - Running post-action listener: _resource_record_post_action 12:55:25 INFO - ##### 12:55:25 INFO - ##### Running create-virtualenv step. 12:55:25 INFO - ##### 12:55:25 INFO - Running pre-action listener: _resource_record_pre_action 12:55:25 INFO - Running main action method: create_virtualenv 12:55:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:55:25 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 12:55:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:55:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:55:26 INFO - Using real prefix '/usr' 12:55:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:55:26 INFO - Installing distribute.............................................................................................................................................................................................done. 12:55:28 INFO - Installing pip.................done. 12:55:28 INFO - Return code: 0 12:55:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:28 INFO - Using env: {'DISPLAY': ':0', 12:55:28 INFO - 'HOME': '/home/cltbld', 12:55:28 INFO - 'LANG': 'en_US.UTF-8', 12:55:28 INFO - 'LANGUAGE': 'en_US:en', 12:55:28 INFO - 'LOGNAME': 'cltbld', 12:55:28 INFO - 'MAIL': '/var/mail/cltbld', 12:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:28 INFO - 'MOZ_NO_REMOTE': '1', 12:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:28 INFO - 'NO_EM_RESTART': '1', 12:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:28 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:28 INFO - 'SHELL': '/bin/bash', 12:55:28 INFO - 'SHLVL': '1', 12:55:28 INFO - 'TERM': 'linux', 12:55:28 INFO - 'TMOUT': '86400', 12:55:28 INFO - 'USER': 'cltbld', 12:55:28 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:28 INFO - '_': '/tools/buildbot/bin/python'} 12:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:28 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 12:55:28 INFO - Cleaning up... 12:55:28 INFO - Return code: 0 12:55:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:28 INFO - Using env: {'DISPLAY': ':0', 12:55:28 INFO - 'HOME': '/home/cltbld', 12:55:28 INFO - 'LANG': 'en_US.UTF-8', 12:55:28 INFO - 'LANGUAGE': 'en_US:en', 12:55:28 INFO - 'LOGNAME': 'cltbld', 12:55:28 INFO - 'MAIL': '/var/mail/cltbld', 12:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:28 INFO - 'MOZ_NO_REMOTE': '1', 12:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:28 INFO - 'NO_EM_RESTART': '1', 12:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:28 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:28 INFO - 'SHELL': '/bin/bash', 12:55:28 INFO - 'SHLVL': '1', 12:55:28 INFO - 'TERM': 'linux', 12:55:28 INFO - 'TMOUT': '86400', 12:55:28 INFO - 'USER': 'cltbld', 12:55:28 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:28 INFO - '_': '/tools/buildbot/bin/python'} 12:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:28 INFO - Downloading/unpacking psutil>=0.7.1 12:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:30 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:55:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:55:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:55:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:30 INFO - Installing collected packages: psutil 12:55:30 INFO - Running setup.py install for psutil 12:55:30 INFO - building 'psutil._psutil_linux' extension 12:55:30 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 12:55:31 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 12:55:31 INFO - building 'psutil._psutil_posix' extension 12:55:31 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 12:55:31 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 12:55:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:55:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:55:31 INFO - Successfully installed psutil 12:55:31 INFO - Cleaning up... 12:55:31 INFO - Return code: 0 12:55:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:31 INFO - Using env: {'DISPLAY': ':0', 12:55:31 INFO - 'HOME': '/home/cltbld', 12:55:31 INFO - 'LANG': 'en_US.UTF-8', 12:55:31 INFO - 'LANGUAGE': 'en_US:en', 12:55:31 INFO - 'LOGNAME': 'cltbld', 12:55:31 INFO - 'MAIL': '/var/mail/cltbld', 12:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:31 INFO - 'MOZ_NO_REMOTE': '1', 12:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:31 INFO - 'NO_EM_RESTART': '1', 12:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:31 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:31 INFO - 'SHELL': '/bin/bash', 12:55:31 INFO - 'SHLVL': '1', 12:55:31 INFO - 'TERM': 'linux', 12:55:31 INFO - 'TMOUT': '86400', 12:55:31 INFO - 'USER': 'cltbld', 12:55:31 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:31 INFO - '_': '/tools/buildbot/bin/python'} 12:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:55:31 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 12:55:31 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 12:55:31 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 12:55:31 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 12:55:31 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 12:55:31 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 12:55:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:55:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:55:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:55:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:55:33 INFO - Installing collected packages: mozsystemmonitor 12:55:33 INFO - Running setup.py install for mozsystemmonitor 12:55:33 INFO - Successfully installed mozsystemmonitor 12:55:33 INFO - Cleaning up... 12:55:33 INFO - Return code: 0 12:55:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:55:33 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')]} 12:55:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:33 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')]} 12:55:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:33 INFO - Using env: {'DISPLAY': ':0', 12:55:33 INFO - 'HOME': '/home/cltbld', 12:55:33 INFO - 'LANG': 'en_US.UTF-8', 12:55:33 INFO - 'LANGUAGE': 'en_US:en', 12:55:33 INFO - 'LOGNAME': 'cltbld', 12:55:33 INFO - 'MAIL': '/var/mail/cltbld', 12:55:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:33 INFO - 'MOZ_NO_REMOTE': '1', 12:55:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:33 INFO - 'NO_EM_RESTART': '1', 12:55:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:33 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:33 INFO - 'SHELL': '/bin/bash', 12:55:33 INFO - 'SHLVL': '1', 12:55:33 INFO - 'TERM': 'linux', 12:55:33 INFO - 'TMOUT': '86400', 12:55:33 INFO - 'USER': 'cltbld', 12:55:33 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:33 INFO - '_': '/tools/buildbot/bin/python'} 12:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:55:33 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 12:55:33 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 12:55:33 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 12:55:33 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 12:55:33 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 12:55:33 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 12:55:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:55:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:55:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:55:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:55:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:55:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:36 INFO - Downloading docopt-0.6.1.tar.gz 12:55:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:55:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:55:36 INFO - Installing collected packages: blobuploader, requests, docopt 12:55:36 INFO - Running setup.py install for blobuploader 12:55:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:55:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:55:36 INFO - Running setup.py install for requests 12:55:36 INFO - Running setup.py install for docopt 12:55:36 INFO - Successfully installed blobuploader requests docopt 12:55:36 INFO - Cleaning up... 12:55:36 INFO - Return code: 0 12:55:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:36 INFO - Using env: {'DISPLAY': ':0', 12:55:36 INFO - 'HOME': '/home/cltbld', 12:55:36 INFO - 'LANG': 'en_US.UTF-8', 12:55:36 INFO - 'LANGUAGE': 'en_US:en', 12:55:36 INFO - 'LOGNAME': 'cltbld', 12:55:36 INFO - 'MAIL': '/var/mail/cltbld', 12:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:36 INFO - 'MOZ_NO_REMOTE': '1', 12:55:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:36 INFO - 'NO_EM_RESTART': '1', 12:55:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:36 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:36 INFO - 'SHELL': '/bin/bash', 12:55:36 INFO - 'SHLVL': '1', 12:55:36 INFO - 'TERM': 'linux', 12:55:36 INFO - 'TMOUT': '86400', 12:55:36 INFO - 'USER': 'cltbld', 12:55:36 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:36 INFO - '_': '/tools/buildbot/bin/python'} 12:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:55:36 INFO - Running setup.py (path:/tmp/pip-ivoMDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:55:37 INFO - Running setup.py (path:/tmp/pip-xKldX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:55:37 INFO - Running setup.py (path:/tmp/pip-xGhEhN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:55:37 INFO - Running setup.py (path:/tmp/pip-n36md4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:55:37 INFO - Running setup.py (path:/tmp/pip-A54XuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:55:37 INFO - Running setup.py (path:/tmp/pip-om_MEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:55:37 INFO - Running setup.py (path:/tmp/pip-aTiD3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:55:37 INFO - Running setup.py (path:/tmp/pip-KhTMJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:55:37 INFO - Running setup.py (path:/tmp/pip-9m4ShP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:55:37 INFO - Running setup.py (path:/tmp/pip-ohSpug-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:55:37 INFO - Running setup.py (path:/tmp/pip-QQPlzt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:55:37 INFO - Running setup.py (path:/tmp/pip-gXfo8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:55:37 INFO - Running setup.py (path:/tmp/pip-2lGd0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:55:37 INFO - Running setup.py (path:/tmp/pip-wjAStH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:55:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:55:37 INFO - Running setup.py (path:/tmp/pip-k3iX23-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:55:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:55:38 INFO - Running setup.py (path:/tmp/pip-F1Z3Kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:55:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:55:38 INFO - Running setup.py (path:/tmp/pip-l1DeW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:55:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:55:38 INFO - Running setup.py install for manifestparser 12:55:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Running setup.py install for mozcrash 12:55:38 INFO - Running setup.py install for mozdebug 12:55:38 INFO - Running setup.py install for mozdevice 12:55:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Running setup.py install for mozfile 12:55:38 INFO - Running setup.py install for mozhttpd 12:55:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Running setup.py install for mozinfo 12:55:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Running setup.py install for mozInstall 12:55:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:55:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Running setup.py install for mozleak 12:55:39 INFO - Running setup.py install for mozlog 12:55:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Running setup.py install for moznetwork 12:55:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Running setup.py install for mozprocess 12:55:39 INFO - Running setup.py install for mozprofile 12:55:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Running setup.py install for mozrunner 12:55:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Running setup.py install for mozscreenshot 12:55:39 INFO - Running setup.py install for moztest 12:55:39 INFO - Running setup.py install for mozversion 12:55:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:55:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:55:39 INFO - Cleaning up... 12:55:39 INFO - Return code: 0 12:55:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:55: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')]} 12:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55: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')]} 12:55:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:39 INFO - Using env: {'DISPLAY': ':0', 12:55:39 INFO - 'HOME': '/home/cltbld', 12:55:39 INFO - 'LANG': 'en_US.UTF-8', 12:55:39 INFO - 'LANGUAGE': 'en_US:en', 12:55:39 INFO - 'LOGNAME': 'cltbld', 12:55:39 INFO - 'MAIL': '/var/mail/cltbld', 12:55:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:39 INFO - 'MOZ_NO_REMOTE': '1', 12:55:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:39 INFO - 'NO_EM_RESTART': '1', 12:55:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:39 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:39 INFO - 'SHELL': '/bin/bash', 12:55:39 INFO - 'SHLVL': '1', 12:55:39 INFO - 'TERM': 'linux', 12:55:39 INFO - 'TMOUT': '86400', 12:55:39 INFO - 'USER': 'cltbld', 12:55:39 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:39 INFO - '_': '/tools/buildbot/bin/python'} 12:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:55:40 INFO - Running setup.py (path:/tmp/pip-Y58Pxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:55:40 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)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:55:40 INFO - Running setup.py (path:/tmp/pip-vIHPCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:55:40 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)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:55:40 INFO - Running setup.py (path:/tmp/pip-7ei7j4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:55:40 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)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:55:40 INFO - Running setup.py (path:/tmp/pip-EPfri7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:55:40 INFO - Running setup.py (path:/tmp/pip-lSKHin-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:55:40 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)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:55:40 INFO - Running setup.py (path:/tmp/pip-z998EP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:55:40 INFO - Running setup.py (path:/tmp/pip-i6EnlH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:55:40 INFO - Running setup.py (path:/tmp/pip-mdW8Hz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:55:40 INFO - Running setup.py (path:/tmp/pip-QtVQsW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:55:40 INFO - Running setup.py (path:/tmp/pip-ZAtg1p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:55:40 INFO - Running setup.py (path:/tmp/pip-7lRPZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 12:55:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:55:41 INFO - Running setup.py (path:/tmp/pip-rXYKBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:55:41 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)) 12:55:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:55:41 INFO - Running setup.py (path:/tmp/pip-gQLTwa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:55:41 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)) 12:55:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:55:41 INFO - Running setup.py (path:/tmp/pip-oUuY0C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:55:41 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)) 12:55:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:55:41 INFO - Running setup.py (path:/tmp/pip-Jf0xt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:55:41 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)) 12:55:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:55:41 INFO - Running setup.py (path:/tmp/pip-5V5lya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:55:41 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)) 12:55:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:55:41 INFO - Running setup.py (path:/tmp/pip-WAV_Kw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:55:41 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)) 12:55:41 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)) 12:55:41 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)) 12:55:41 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)) 12:55:41 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:55:41 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:55:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55: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 12:55:43 INFO - Downloading blessings-1.5.1.tar.gz 12:55:43 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:55:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:55:43 INFO - Installing collected packages: blessings 12:55:43 INFO - Running setup.py install for blessings 12:55:43 INFO - Successfully installed blessings 12:55:43 INFO - Cleaning up... 12:55:43 INFO - Return code: 0 12:55:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:55:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:55:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:55:43 INFO - Reading from file tmpfile_stdout 12:55:43 INFO - Current package versions: 12:55:43 INFO - argparse == 1.2.1 12:55:43 INFO - blessings == 1.5.1 12:55:43 INFO - blobuploader == 1.2.4 12:55:43 INFO - docopt == 0.6.1 12:55:43 INFO - manifestparser == 1.1 12:55:43 INFO - mozInstall == 1.12 12:55:43 INFO - mozcrash == 0.16 12:55:43 INFO - mozdebug == 0.1 12:55:43 INFO - mozdevice == 0.47 12:55:43 INFO - mozfile == 1.2 12:55:43 INFO - mozhttpd == 0.7 12:55:43 INFO - mozinfo == 0.9 12:55:43 INFO - mozleak == 0.1 12:55:43 INFO - mozlog == 3.1 12:55:43 INFO - moznetwork == 0.27 12:55:43 INFO - mozprocess == 0.22 12:55:43 INFO - mozprofile == 0.28 12:55:43 INFO - mozrunner == 6.11 12:55:43 INFO - mozscreenshot == 0.1 12:55:43 INFO - mozsystemmonitor == 0.0 12:55:43 INFO - moztest == 0.7 12:55:43 INFO - mozversion == 1.4 12:55:43 INFO - psutil == 3.1.1 12:55:43 INFO - requests == 1.2.3 12:55:43 INFO - wsgiref == 0.1.2 12:55:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:43 INFO - Using env: {'DISPLAY': ':0', 12:55:43 INFO - 'HOME': '/home/cltbld', 12:55:43 INFO - 'LANG': 'en_US.UTF-8', 12:55:43 INFO - 'LANGUAGE': 'en_US:en', 12:55:43 INFO - 'LOGNAME': 'cltbld', 12:55:43 INFO - 'MAIL': '/var/mail/cltbld', 12:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:43 INFO - 'MOZ_NO_REMOTE': '1', 12:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:43 INFO - 'NO_EM_RESTART': '1', 12:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:43 INFO - 'SHELL': '/bin/bash', 12:55:43 INFO - 'SHLVL': '1', 12:55:43 INFO - 'TERM': 'linux', 12:55:43 INFO - 'TMOUT': '86400', 12:55:43 INFO - 'USER': 'cltbld', 12:55:43 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:43 INFO - '_': '/tools/buildbot/bin/python'} 12:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:55:43 INFO - Cleaning up... 12:55:43 INFO - Return code: 0 12:55:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:43 INFO - Using env: {'DISPLAY': ':0', 12:55:43 INFO - 'HOME': '/home/cltbld', 12:55:43 INFO - 'LANG': 'en_US.UTF-8', 12:55:43 INFO - 'LANGUAGE': 'en_US:en', 12:55:43 INFO - 'LOGNAME': 'cltbld', 12:55:43 INFO - 'MAIL': '/var/mail/cltbld', 12:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:43 INFO - 'MOZ_NO_REMOTE': '1', 12:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:43 INFO - 'NO_EM_RESTART': '1', 12:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:43 INFO - 'SHELL': '/bin/bash', 12:55:43 INFO - 'SHLVL': '1', 12:55:43 INFO - 'TERM': 'linux', 12:55:43 INFO - 'TMOUT': '86400', 12:55:43 INFO - 'USER': 'cltbld', 12:55:43 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:43 INFO - '_': '/tools/buildbot/bin/python'} 12:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:43 INFO - Downloading/unpacking jsonschema 12:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:55:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 12:55:45 INFO - Downloading/unpacking functools32 (from jsonschema) 12:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:45 INFO - Downloading functools32-3.2.3-2.tar.gz 12:55:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:55:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:55:45 INFO - warning: no files found matching '*.txt' 12:55:45 INFO - no previously-included directories found matching 'build' 12:55:45 INFO - no previously-included directories found matching 'dist' 12:55:45 INFO - no previously-included directories found matching '.git*' 12:55:45 INFO - Installing collected packages: jsonschema, functools32 12:55:45 INFO - Running setup.py install for functools32 12:55:46 INFO - warning: no files found matching '*.txt' 12:55:46 INFO - no previously-included directories found matching 'build' 12:55:46 INFO - no previously-included directories found matching 'dist' 12:55:46 INFO - no previously-included directories found matching '.git*' 12:55:46 INFO - Successfully installed jsonschema functools32 12:55:46 INFO - Cleaning up... 12:55:46 INFO - Return code: 0 12:55:46 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:55:46 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')]} 12:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:46 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')]} 12:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fef5ead6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, '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': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', '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 12:55:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 12:55:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 12:55:46 INFO - Using env: {'DISPLAY': ':0', 12:55:46 INFO - 'HOME': '/home/cltbld', 12:55:46 INFO - 'LANG': 'en_US.UTF-8', 12:55:46 INFO - 'LANGUAGE': 'en_US:en', 12:55:46 INFO - 'LOGNAME': 'cltbld', 12:55:46 INFO - 'MAIL': '/var/mail/cltbld', 12:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:46 INFO - 'MOZ_NO_REMOTE': '1', 12:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:46 INFO - 'NO_EM_RESTART': '1', 12:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:55:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:55:46 INFO - 'SHELL': '/bin/bash', 12:55:46 INFO - 'SHLVL': '1', 12:55:46 INFO - 'TERM': 'linux', 12:55:46 INFO - 'TMOUT': '86400', 12:55:46 INFO - 'USER': 'cltbld', 12:55:46 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:46 INFO - '_': '/tools/buildbot/bin/python'} 12:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:55:46 INFO - Downloading/unpacking flake8 12:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:55:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 12:55:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 12:55:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:55:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:55:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:48 INFO - no previously-included directories found matching 'docs/_build' 12:55:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:55:48 INFO - Running setup.py install for pep8 12:55:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:55:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:55:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:55:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:55:48 INFO - no previously-included directories found matching 'docs/_build' 12:55:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:55:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:55:48 INFO - Cleaning up... 12:55:49 INFO - Return code: 0 12:55:49 INFO - Running post-action listener: _resource_record_post_action 12:55:49 INFO - Running post-action listener: _start_resource_monitoring 12:55:49 INFO - Starting resource monitoring. 12:55:49 INFO - ##### 12:55:49 INFO - ##### Running install step. 12:55:49 INFO - ##### 12:55:49 INFO - Running pre-action listener: _resource_record_pre_action 12:55:49 INFO - Running main action method: install 12:55:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:55:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:55:49 INFO - Reading from file tmpfile_stdout 12:55:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:55:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:55:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:55:49 INFO - Reading from file tmpfile_stdout 12:55:49 INFO - Output received: 12:55:49 INFO - Usage: mozinstall [options] installer 12:55:49 INFO - Options: 12:55:49 INFO - -h, --help show this help message and exit 12:55:49 INFO - -d DEST, --destination=DEST 12:55:49 INFO - Directory to install application into. [default: 12:55:49 INFO - "/builds/slave/test-pgo"] 12:55:49 INFO - --app=APP Application being installed. [default: firefox] 12:55:49 INFO - mkdir: /builds/slave/test-pgo/build/application 12:55:49 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'] 12:55:49 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 12:56:05 INFO - Reading from file tmpfile_stdout 12:56:05 INFO - Output received: 12:56:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:56:05 INFO - Running post-action listener: _resource_record_post_action 12:56:05 INFO - ##### 12:56:05 INFO - ##### Running run-tests step. 12:56:05 INFO - ##### 12:56:05 INFO - Running pre-action listener: _resource_record_pre_action 12:56:05 INFO - Running main action method: run_tests 12:56:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:56:05 INFO - Python 2.7.3 12:56:05 INFO - Return code: 0 12:56:05 INFO - grabbing minidump binary from tooltool 12:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf307f0>, '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 0xe9c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe9c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:56:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 12:56:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:56:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:56:05 INFO - Return code: 0 12:56:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:56:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:56:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:56:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:56:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:56:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:56:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:56:06 INFO - Return code: 0 12:56:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 12:56:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 12:56:06 INFO - Using env: {'DISPLAY': ':0', 12:56:06 INFO - 'HOME': '/home/cltbld', 12:56:06 INFO - 'LANG': 'en_US.UTF-8', 12:56:06 INFO - 'LANGUAGE': 'en_US:en', 12:56:06 INFO - 'LOGNAME': 'cltbld', 12:56:06 INFO - 'MAIL': '/var/mail/cltbld', 12:56:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:56:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:06 INFO - 'MOZ_NO_REMOTE': '1', 12:56:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:06 INFO - 'NO_EM_RESTART': '1', 12:56:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:06 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:56:06 INFO - 'SHELL': '/bin/bash', 12:56:06 INFO - 'SHLVL': '1', 12:56:06 INFO - 'TERM': 'linux', 12:56:06 INFO - 'TMOUT': '86400', 12:56:06 INFO - 'USER': 'cltbld', 12:56:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261', 12:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:06 INFO - '_': '/tools/buildbot/bin/python'} 12:56:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:56:06 INFO - mozversion application_buildid: 20151223103050 12:56:06 INFO - mozversion application_changeset: 24a27da1a369c93df5b446483c8efdeecab96aaf 12:56:06 INFO - mozversion application_display_name: Nightly 12:56:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:56:06 INFO - mozversion application_name: Firefox 12:56:06 INFO - mozversion application_remotingname: firefox 12:56:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:56:06 INFO - mozversion application_vendor: Mozilla 12:56:06 INFO - mozversion application_version: 46.0a1 12:56:06 INFO - mozversion platform_buildid: 20151223103050 12:56:06 INFO - mozversion platform_changeset: 24a27da1a369c93df5b446483c8efdeecab96aaf 12:56:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:56:06 INFO - mozversion platform_version: 46.0a1 12:56:06 INFO - using testdate: 1450904166 12:56:06 INFO - actual date: 1450904166 12:56:06 INFO - starting webserver on 'localhost:42217' 12:56:06 INFO - SUITE-START | Running 3 tests 12:56:06 INFO - TEST-START | dromaeo_css 12:56:06 INFO - operating with platform_type : linux_ 12:56:06 INFO - Initialising browser for dromaeo_css test... 12:56:06 INFO - TEST-INFO | started process 18362 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwJCXP/profile http://localhost:42217/getInfo.html) 12:56:11 INFO - PROCESS | 18362 | __metrics Screen width/height:1600/1200 12:56:11 INFO - PROCESS | 18362 | colorDepth:24 12:56:11 INFO - PROCESS | 18362 | Browser inner width/height: 1024/697 12:56:11 INFO - PROCESS | 18362 | __metrics 12:56:11 INFO - PROCESS | 18362 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:56:11 INFO - PROCESS | 18362 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:56:11 ERROR - PROCESS | 18362 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 12:56:12 INFO - TEST-INFO | 18362: exit 0 12:56:12 INFO - Browser initialized. 12:56:12 INFO - Running cycle 1/1 for dromaeo_css test... 12:56:12 INFO - TEST-INFO | started process 18458 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmwJCXP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:56:23 INFO - PROCESS | 18458 | RSS: Main: 149921792 12:56:23 INFO - PROCESS | 18458 | 12:57:15 INFO - PROCESS | 18458 | 1450904235454 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] 12:59:23 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42217/tests/dromaeo/cssquery-ext.html) 12:59:25 INFO - PROCESS | 18458 | RSS: Main: 238755840 12:59:25 INFO - PROCESS | 18458 | 13:02:27 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-ext.html (next: http://localhost:42217/tests/dromaeo/cssquery-jquery.html) 13:02:27 INFO - PROCESS | 18458 | RSS: Main: 225038336 13:02:27 INFO - PROCESS | 18458 | 13:05:29 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42217/tests/dromaeo/cssquery-mootools.html) 13:05:30 INFO - PROCESS | 18458 | RSS: Main: 223301632 13:05:30 INFO - PROCESS | 18458 | 13:08:32 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42217/tests/dromaeo/cssquery-prototype.html) 13:08:32 INFO - PROCESS | 18458 | RSS: Main: 210264064 13:08:32 INFO - PROCESS | 18458 | 13:11:35 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42217/tests/dromaeo/cssquery-yui.html) 13:11:35 INFO - PROCESS | 18458 | RSS: Main: 215797760 13:11:35 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | Cycle 1(1): loaded http://localhost:42217/tests/dromaeo/cssquery-yui.html (next: http://localhost:42217/tests/dromaeo/cssquery-dojo.html) 13:14:38 INFO - PROCESS | 18458 | RSS: Main: 271581184 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | __start_tp_report 13:14:38 INFO - PROCESS | 18458 | _x_x_mozilla_page_load 13:14:38 INFO - PROCESS | 18458 | _x_x_mozilla_page_load_details 13:14:38 INFO - PROCESS | 18458 | |i|pagename|runs| 13:14:38 INFO - PROCESS | 18458 | |0;dojo.html;3128.3743251349733;3179.395914776194;3185.7451403887676;3190.2821865080373;3213.6143662760464;5208.427073021964;5230.686158830473;5267.894642107156;5277.419483856782;5328.786848526059;5277.261183434322;5306.602004849632;5349.732513374325;5353.705546194958;5358.490943360374;4793.640476964224;4800.711957282574;4823.855284341475;4882.462929077798;4882.536159064884;4737.620990320784;4890.14422476067;4912.582430493412;4926.45808961014;4988.376452943382;4751.121042607128;4815.975920120412;4833.927491087637;4835.347228124228;4851.029794041206;4803.879903002453;4818.68678535894;4829.782659780319;4837.274408838667;4863.902721945541;4680.906381872377;4775.80896764129;4779.784909679072;4785.617150627942;4822.469528351879;5023.924641130386;5052.873678158038;5181.663191892552;5190.143626301656;5224.268602395668;5698.601097923147;5701.344345400249;5701.372848986608;5725.6278341908055;5737.483626473596;5536.4186760390385;5722.656640601577;5735.455131762517;5750.913736293959;5759.222504961818;5296.232046353296;5324.148136298212;5341.946580534145;5346.331708536433;5384.1923711443205;5801.970990145022;5823.621464604787;5824.446677565709;5833.416658334218;5834.504067154255;5477.178423236467;5543.1685247213245;5582.190582365534;5618;5627.212190293362;5592.133219351007;5706.172604972338;5712.514436272881;5713.257276554022;5738.110592858114;5663.263775709132;5677.801276955287;5683.204351390808;5686.175504551899;5688.089905615165;5453.318335208099;5559.193916882029;5569.192467092249;5604.271444712162;5678.943210567842;4342.913141737147;4382.780860956939;4391.429114215131;4393.0774537347515;4393.736375817397;3869.9357676638588;3886.7473614214987;3899.064224586079;3925.156091440297;3929.0766669832565;5214.739263036833;5252.317198764136;5277.683338999673;5318.25544423781;5327.413984461784;5732.398098199712;5754.251947246831;5755.223044888887;5756.251687280626;5769.711514424262;5342.813001544927;5360.249565060894;5362.544183744348;5365.785368585213;5366.490183432567;4830.3479030331155;4915.21356582945;4916.852494425173;4972.2790195422185;5010.248462730619;5891.764329426861;5916.1421593868645;5925.466707996301;5926.940730592725;5946.613470124515;5732.484076433141;5753.309602847685;5753.626014309057;5754.165645981393;5757.798477053283;5746.942530574641;5811.215485909517;5855.238818953509;5872.383399743137;5998;5556.111022236423;5559.972200138974;5576.302962129734;5610.270664813548;5615.522680572197;5617.859553511195;5649.378568357395;5668.829935101953;5671.376148623731;5674.347450043133;5411.729413529229;5481.862953426037;5519.69641669712;5552.472515111058;5585.078462053716;5543.611947163821;5545.112781954868;5549.972250138723;5553.611247212818;5556.166575013619;5387;5477.698726570077;5482.122860342326;5482.479164479368;5526.91709624364;5544;5566.387697353207;5583.8883222336135;5602.467765562265;5660.7169641518585;5459;5461.644993075437;5462.153366228241;5462.3445186577865;5512.641678290898 13:14:38 INFO - PROCESS | 18458 | |1;ext.html;569.0780934885486;596.7493652665883;597.3041406761123;603.8822429626223;611.4863514647695;34872.30255394894;35477.645223547755;35478.82260588697;35503.64496355036;35568.11079723008;41517.16965660685;42102.15795684084;42147.15705685884;42200;42204.36693449593;7357.632118394085;7478.850422991537;8727.083656216086;8860.24687901529;8886.777830554223;10066;10227.079562839343;10269;10303.53634086464;10317.535710893027;10089.899101009007;10169.847452288222;10181.847272290921;10206.285560010801;10224.539895704675;7556.924430755677;7700.075990881102;7720.961395193044;9950.850737238947;10094.29339946204;9811.313208075437;9942.751431214205;9984.750381240454;9996.050375214343;9999.50002499872;35283.4707479388;35778.28443431143;35787.284254315025;35815;35882.30882683783;3314.386838434897;3331.1006028372203;3366.259422926952;3376.3922493951077;3423.2126610879636;27420.314492137655;27633.447331053267;29935.70064299351;30097.247568810737;30927.84536077305;3960.1683646434285;3982.960170398288;4035.8183881725395;4102.097538541516;4117.794110294473;203921;204155;205279;206138.9999999985;206267;51036.48963510317;52156.47843521592;55869;57216.71391643015;57641.42358576361;56844;56929;57171.71414142986;57201;57288.42711572831;14584;14627;14751.557453276419;14756.778648320069;14845.331960061823;10774.838377424345;10780.083692886192;10780.245382823126;10790.838137427945;10816.405097719544;18987.33544325942;19048.80951190498;19095.90452047731;19201.61596768057;19229.326973555857;7248.96375518119;7501.924980750232;7521.05986751656;7672.5012874163;7688.769336919901;918.2929144558786;953.8473844185036;976.4824642939111;1075.0002497677235;1078.1536493852288;28009.859950700116;28317.15048548547;28575.57136642952;28767.712322876923;28805.85597072001;1048.8793788714395;1062.2617280989793;1069.2996087562658;1112.554978008803;1207.3480320626763;14478.131312121306;14539.709205816036;14641.34113964874;14818.629534261514;14959.810874704492;302898;309193;310263;310400;311185;43558;44256.11487770227;51080.74459627678;51100;51297.743511282206;1213.836132122152;1251.9186252893533;1345.7981302804462;1349.8110264562772;1362.7683293839873;25643.230703078938;25855.353616159748;26420.867895660398;27907.720922791323;28743.85628071846;41994.37008444815;42370.15259694727;43631.78184109059;44276.33585496285;47469.762651186524;201467;202577;204723;205275;205355;31986;32363.51454728134;32404;32411.51382729308;32442;42285.788571056946;42974.140517190106;43169.13661726685;43258;43728.56271437245;35685.82157089198;36161.81919090388;36360.90917272486;36596.81701591475;37623.623763762014;36194;36732;36904.63095369012;36935;37009.25981480409;34955;35079;35353.46969795404;35643.46534801928;35715.82142089273;26843;27436.314092147855;28994.42011159723;29909.70090299156;31853.681463185072;24027.759722402552;24150.864347774266;24386.51226975486;24641.876790615934;24735.134270300452 13:14:38 INFO - PROCESS | 18458 | |2;jquery.html;361.7359327690784;366.6150541930972;367.59013699724807;369.329666655021;371.63208423660586;13726.519571814988;13962.860371396284;16235.51293461195;17176.39882604109;18171.364002259925;14912.62718432037;16431.17844107796;16756.497305080866;17714.822851771478;17719.822801771978;4498.887527811815;5300.840974770763;5422.864428389283;5423.810166644168;5425.159100339453;3948.802559872009;4059.4113853491226;5766.106253530688;5896.675682837442;5938.524918006549;5818;5864.325602555718;5901.881962360751;5914.645121292736;5915.1718759373725;5705.2012718219485;5824.417558244184;5830.125481177814;5840.912386314209;5849.6197747146725;5128.230765385222;5146.485351464861;5152.355955505562;5174.896502069938;5176.197689358156;19109.1400886959;19893.602127957503;20250.17748402651;20845.68731469029;21000.789992100035;2148.8603240789457;2259.20927675314;2333.0551126793675;2433.9878300608384;2655.3361659585103;12865.67835804103;12973.766757906977;13002.154859934075;13251.13867598603;13265.535706250235;1784.8661350398772;1787.8748487605874;1820.4447643468736;1822.4441545328668;1874.4189301316635;51761.482385176045;55718.72140639312;55870.720646396505;56185.15722264169;56697.149542756895;9555.18780903631;9792.51037448139;9900.108990190918;9900.455474948947;9948.154406875497;12948;12961.351932403342;12970.481180752664;12971.740565188644;13024.720673882033;7346.963265183746;7369.078865141857;7416.369608583331;7419.109706835215;7422.888656670154;7316.890246646304;7340.4861659684375;7344.96327518359;7370.96314518424;7373.820188769771;4296.871093867189;4357.607815296638;4392.912141757147;4395.230834603932;4398.560143985575;1702.1999660159704;1709.4529750479728;1746.9650606987789;1754.2719771295026;1782.5632719983428;846.4202021615213;926.1201858234704;975.1662328708993;987.9901200987898;1000.8548760429696;12425.19236249641;16177.67644647124;16830.41093561744;16974.15129243533;17160.914195428944;874.0822136756381;875.5753459572103;914.835329640671;990.8018396320621;1004.8444289067485;9458.716238512856;9476.573554190078;9698.903010969942;9722.222222222204;9771.267154963407;438699;439836;443455;444693;474087;78942.6052869732;81005;81584;81827.18172818195;82106.17893821104;1148.1733152130453;1149.8160294352863;1155.7284038251005;1156.7455159864817;1158.4497363752319;15338.233088345762;15590.610234744223;15734.527964161094;15908.602284942506;15978.60053498672;31199.84400077985;31685.841570792;31741.04776856698;32059.679403205668;32653.510197346583;38128;41300;48872.75563622302;49486.257706133714;50989.235161471865;9560.378575392577;9744.512774361396;9943.950280248553;9947.303688741718;9963.800723985625;16414.753778693568;17222.483325500256;17461.825381746527;17924.283028678707;17984;13840.23878686682;14162.716745665235;14193.361298741787;14225.359858806585;14325.355359009078;12891.548795792101;14221.573352799433;14552.49066282675;14776.261186940395;15341.386344546094;14850.40598376053;14914.477993270184;15265.084094954338;15276.388944442542;15295.235238238267;9442.622295108393;9692.854607180758;9885.258605604464;9984.650537231162;9998.150157236716;10260.486975651038;10343.224258180517;13606.863931360956;13847.307634618028;14304.785428218793 13:14:38 INFO - PROCESS | 18458 | |3;mootools.html;1222.4193508083656;1474.0934325389887;1493.7161939231546;1626.5770899566116;1828.8171182881722;6722.79831605052;7340.743073992411;7445.664945077471;7447.664855081521;7461.104667439908;7363.374113200384;7385.778426647195;7459.067616547932;7459.179490256068;7477.214892436297;1954.667706489893;1983.4049785064494;2266.3087758233733;2303.101790301775;2308.145985985188;2325.6744055832196;2348.518553696488;2352.6000579901374;2352.6000579901374;2355.5877721398774;2267.1611503743557;2284.0407029047838;2303.2053941390195;2308.4921317310163;2311.56080344734;2283.4633861042644;2285.371522831218;2287.062304455182;2306.7001289832297;2326.360250930999;2294.7016887804643;2301.2405906050963;2325.5930212212793;2328.499372634875;2336.0538981712434;7589.392848572101;7654.502457340255;7695.384369250447;7703.499272547267;7731.304182623591;4731.716097034155;4772.73749943753;4773.665843390964;4799.592034677056;4810.855674329776;3051.755859531232;3096.736777373926;3142.025971948703;3151.2437015116207;3162.9683703162905;1002.5187909803335;1028.70167651381;1028.9485525723685;1068.3483075324045;1081.2863510083307;10075.748106297327;10238.078572928398;10283.07452329294;10292.794144117152;10298.845517317246;4066.268071747114;4092;4162.313218318944;4310.827566897289;4313.051128751669;8325.750227493185;8494.362922780816;8496.745097647081;8509.829803403898;8511.446755960842;4760.119377915097;4761.4524329701835;4786.7845946932475;4804.855854324376;4810.39870016248;4347.152305300436;4356.19410409069;4396.450443694538;4428.645708343325;4428.977855110704;3253.6908993645566;3288.046466524681;3423.4522476403654;3447.620761716209;3473.409520381491;1055.767731099157;1060.2260349944584;1067.4662668665667;1070.7911957168278;1089.2865173311493;1074.001178903627;1080.0225795654944;1127.3855748617023;1262.4571434283346;1376.0436496634743;6691.397774200345;6705.161854768154;6793.830154246183;6802.115724955724;7131.393831524379;624.1168746224133;638.6072565372356;641.233725697796;644.7421031587403;776.9961150194213;5580.525655319262;5613.354464236583;5739.770409183586;5767.942320576824;5783.132530120515;8791.692290769792;9095;9096;9116.726498205064;9147.451152930846;8500.362472814564;8714.782130446663;8717;8755.56222188888;8860.246879015227;7097.609631470319;7128.215896251409;7154.7495837646475;7221.819454513679;7230.56616602995;6869.210040845167;6951.9652401739695;6979.022936788752;6998.510104292651;7000.61496617691;7888.921110789048;8030.478018928985;8064.314533264738;8118.715844945398;8141.8371632568205;8232.958835205785;8305.543195124326;8385.58072096405;8421.157884211774;8505.36209784281;6468.191476065492;6490.318516555693;6538.705758240795;6549.24683661385;6555.344465553407;7412.258774122544;7474.402047836269;7482.625868706652;7486.625668716433;7503.699852005859;6999.09011828459;7073.328033836778;7085.539439936388;7219.422446204396;7269.454790890599;6622.569532980341;6973;7026.859462810818;7092.929070709433;7160.283971602798;6730.427913627396;6739.123913891162;6748.69630866622;6749.898751518829;6753.054572359972;5790.9420905792085;5801.245838041028;5802.47777700009;5811.360750317546;6167.475764560063;6389.361063893573;6402.03969404593;6426.453751430994;6430.067640192239;6434 13:14:38 INFO - PROCESS | 18458 | |4;prototype.html;338.71040260577206;342.0593368237347;344.5555233748465;346.923676791106;347.77394693449264;5830.3586605473365;5888.293404791426;5902.468777809996;5930.377310382407;5982.491488223506;5709.143628455734;5889.263842019747;5902.527797776178;5909.409059094089;5971.910421343683;4582.1064892346;4585.403897493321;4588.380568623244;4591.035882464686;4591.747453890035;4326.502452218004;4398.164348773723;4500.932486012713;4567.794449249775;4588.885277868063;4474.865754027384;4505.684602077856;4519.4124763780665;4523.841665541707;4527.479339875924;4512.9097418051615;4530.66020048496;4565.338025986247;4572.657050721176;4586.701864378805;4055.188962207541;4056.1684854604737;4061.0862555924978;4067.796610169509;4068.084680946793;5489.752961116759;5620.185073164409;5622.8313150605545;5629.437056294379;5645.745941432604;5240.34495688039;5257.237700533401;5265.499332690165;5266.894662106736;5277.47225277473;5998.190244317005;6291.276503202144;6295.213098362705;6299.9370006299805;6300.991841305415;4287.785610719483;4289.678274129422;4371.191329604034;4388.144311859189;4402.163588918127;6422.26143993442;6510.93489065108;6519.282878883319;6519.837004074889;6524.543281970216;4492.865214043584;4498.077894031716;4498.640108791289;4500.752458614742;4501.7974191161475;4417.712848664826;4542.750148741785;4547.272436410159;4549.45406551216;4580.4045474088825;5234.110201265794;5234.7906083756225;5242.633015688942;5243.292155559027;5260.579153667697;6255.937440625627;6262.843428914222;6263.467605253604;6267.091271765568;6281.555242294298;1575.220265968353;1603.871690264776;1604.5587463447646;1606.983930160707;1609.8470645288678;1063.5905176507101;1069.1286601419818;1071.132382769959;1083.1118482843992;1097.2703152403562;6027.939720602825;6029.276486821609;6035.245594300713;6035.547333949971;6039.78860739872;6422.967885160544;6434.613923164625;6436.292007879223;6440.935590644033;6481.28705842357;5801.7099145042575;5979.372165922602;6004.6097003695495;6019.69901504923;6028.758849646053;3455.9136021599156;3514.262004978932;3515.964840351615;3516.2088530081037;3518.1028837646236;6647.700853461606;6685.331466853373;6695.531312808057;6709.027191057269;6715.328467153246;6573.704183311763;6577.309382514863;6586.8353291168105;6593.044008618724;6602.9009564855605;6541.901871471931;6696.531242812956;6710.664466776641;6720.025596288511;6723.294054124344;6343.270523889627;6458.063580780855;6462.644554549545;6464.030395440722;6468.126802881551;6280.685965701605;6437.517186210959;6454.419102280817;6472.967635161794;6479.870402592016;6685.130932978682;6697.129373181455;6697.497687673346;6698.531102822755;6699.966500167663;4361.149575832682;4534.183846907456;4545.272756358967;4546.522615125365;4549.909001820011;6366.204224471941;6389.9680501597195;6404.071409645669;6420.454261387835;6423.132877061536;6253.5622506424115;6254.093156492374;6262.123302737529;6286.685665716787;6326.019466982625;6206.906896396467;6239.844003899939;6247.812565623039;6252.843678907881;6254.312025677263;6197.101420294122;6234.127222188988;6242.906356404748;6245.281792593728;6257.624542527463;6366.363363663597;6396.968015159894;6410.391012853772;6411.51913606472;6413.262474815269;6138.969305153446;6219.844503887439;6230.6884655767935;6253.6560489173535;6253.937460625518 13:14:38 INFO - PROCESS | 18458 | |5;yui.html;755.9697612095516;770.8381239939614;807.7778610882007;815.3762371785581;884.4825776920501;13578.321083945813;13819.861801381983;13828.17030978142;13829.861701382983;13871.861281387182;13125.606231813037;13203;13220.40508177132;13240.602781916534;13262.270575118364;679.9694013769392;680.9387155156035;819.5533434278303;828.2256090555335;830.8421399934024;833.4540875726409;837.1461109668165;838.0195171649154;840.2857571064608;840.8024114333127;709.3899246647878;877.9209871111599;879.5909901895617;879.9868001979976;880.7357792662208;709.1242315740056;860.9354298427612;873.4366333714751;875.8773771671971;878.3851304087165;640.2317219336815;646.8253571535658;647.1974751308344;647.4917190005823;648.0473703655618;12859.485620575166;12988.935055324662;13011.089223754341;13014;13061.412236449383;11548.480318385693;11610.6516804496;11641;12487.188332758342;12543.56097536582;9743;10069.09378155962;10090.9495452523;10161.745956351077;10251.53868075931;3524.8766293179874;3560.3235385276716;3571.928561428757;3581.3732596795717;3711.183539621279;43435.131297374195;43764.12471750579;43783.562164378585;43970.90072748175;44061.33907991383;8829.823403532022;9041.141091596288;9125.726228213165;9158.358914876027;9216.493092879957;16922.830771692126;16928.57678558021;16956.321747130223;16961.745573816403;17618.2071806769;7489.588072656056;7603.771886843404;7729.227077292338;7766.417518686121;7783.066032076187;4383.320585309282;4446.510883802779;4485.170243504962;4517.88705282364;4555.088982203572;3063.0963865659237;3080.122165182957;3101.5347697845505;3135.247540590242;3136.1532386255585;568.6019786149711;570.3156212544963;576.1674380520192;577.4687287695331;584.9824505264849;535.8472835241937;565.9292588426447;573.2719446303255;599.7301214453513;619.3404024713666;7893.802654933673;8108.5540295283145;8117.472364296302;8202.794930126794;8221.753347399588;445.84618306684143;457.04477641728283;461.0387342391085;562.8086450606813;591.8254115036075;3681.8711345102793;3709.5919448860604;3794.867179648699;3874.9806250968563;4233.470816147981;44959.19742457099;46577.53422465732;49651.77959873379;52143.478565214624;53526.46473535215;45832;46702.29946550805;46908;47060;47276;42509.57490425056;43478.130437391075;44038.77980610076;44214.99999999936;44351.11297774027;8058.194180581895;8071.112177660335;8233.094359620318;8257.876131858147;8337.166283371615;33518;33573.15347655804;34181.82909085538;34381.656183437844;34490.13774655654;38611.6138838608;41411.37882931698;42460;43133.137337252454;43247;10392.324498907547;10597.523111460157;10648.201384896009;10754;11175.888241117485;11069.225154239126;11200.943995279971;11239.494222759831;11433.828492572451;11458.19792614509;10685.145188384755;10706.143508519144;10891.618793342195;10932.836007460053;11286.66140015801;10379.377237365783;10483.266171367932;10587.788244235226;10613.150947923994;10942.343459392461;7961.562114083549;9398.2951278653;10504.527296271533;10517.263791534519;10621.362718236931;8976;9411.764705882133;9693.9030609693;9702.846574863339;9756.902430975599;8707.303415726854;8724.65101395937;8728.127187281476;8953.865692014495;9279.62881484733 13:14:38 INFO - PROCESS | 18458 | __end_tp_report 13:14:38 INFO - PROCESS | 18458 | __start_cc_report 13:14:38 INFO - PROCESS | 18458 | _x_x_mozilla_cycle_collect,937 13:14:38 INFO - PROCESS | 18458 | __end_cc_report 13:14:38 INFO - PROCESS | 18458 | __startTimestamp1450905278749__endTimestamp 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | ------- Summary: start ------- 13:14:38 INFO - PROCESS | 18458 | Number of tests: 6 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#0] dojo.html Cycles:165 Average:5275.97 Median:5477.18 stddev:585.49 (10.7%) stddev-sans-first:562.52 13:14:38 INFO - PROCESS | 18458 | Values: 3128.4 3179.4 3185.7 3190.3 3213.6 5208.4 5230.7 5267.9 5277.4 5328.8 5277.3 5306.6 5349.7 5353.7 5358.5 4793.6 4800.7 4823.9 4882.5 4882.5 4737.6 4890.1 4912.6 4926.5 4988.4 4751.1 4816.0 4833.9 4835.3 4851.0 4803.9 4818.7 4829.8 4837.3 4863.9 4680.9 4775.8 4779.8 4785.6 4822.5 5023.9 5052.9 5181.7 5190.1 5224.3 5698.6 5701.3 5701.4 5725.6 5737.5 5536.4 5722.7 5735.5 5750.9 5759.2 5296.2 5324.1 5341.9 5346.3 5384.2 5802.0 5823.6 5824.4 5833.4 5834.5 5477.2 5543.2 5582.2 5618.0 5627.2 5592.1 5706.2 5712.5 5713.3 5738.1 5663.3 5677.8 5683.2 5686.2 5688.1 5453.3 5559.2 5569.2 5604.3 5678.9 4342.9 4382.8 4391.4 4393.1 4393.7 3869.9 3886.7 3899.1 3925.2 3929.1 5214.7 5252.3 5277.7 5318.3 5327.4 5732.4 5754.3 5755.2 5756.3 5769.7 5342.8 5360.2 5362.5 5365.8 5366.5 4830.3 4915.2 4916.9 4972.3 5010.2 5891.8 5916.1 5925.5 5926.9 5946.6 5732.5 5753.3 5753.6 5754.2 5757.8 5746.9 5811.2 5855.2 5872.4 5998.0 5556.1 5560.0 5576.3 5610.3 5615.5 5617.9 5649.4 5668.8 5671.4 5674.3 5411.7 5481.9 5519.7 5552.5 5585.1 5543.6 5545.1 5550.0 5553.6 5556.2 5387.0 5477.7 5482.1 5482.5 5526.9 5544.0 5566.4 5583.9 5602.5 5660.7 5459.0 5461.6 5462.2 5462.3 5512.6 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#1] ext.html Cycles:180 Average:41179.99 Median:3371.33 stddev:63625.54 (1887.3%) stddev-sans-first:63730.96 13:14:38 INFO - PROCESS | 18458 | Values: 569.1 596.7 597.3 603.9 611.5 34872.3 35477.6 35478.8 35503.6 35568.1 41517.2 42102.2 42147.2 42200.0 42204.4 7357.6 7478.9 8727.1 8860.2 8886.8 10066.0 10227.1 10269.0 10303.5 10317.5 10089.9 10169.8 10181.8 10206.3 10224.5 7556.9 7700.1 7721.0 9950.9 10094.3 9811.3 9942.8 9984.8 9996.1 9999.5 35283.5 35778.3 35787.3 35815.0 35882.3 3314.4 3331.1 3366.3 3376.4 3423.2 27420.3 27633.4 29935.7 30097.2 30927.8 3960.2 3983.0 4035.8 4102.1 4117.8 203921.0 204155.0 205279.0 206139.0 206267.0 51036.5 52156.5 55869.0 57216.7 57641.4 56844.0 56929.0 57171.7 57201.0 57288.4 14584.0 14627.0 14751.6 14756.8 14845.3 10774.8 10780.1 10780.2 10790.8 10816.4 18987.3 19048.8 19095.9 19201.6 19229.3 7249.0 7501.9 7521.1 7672.5 7688.8 918.3 953.8 976.5 1075.0 1078.2 28009.9 28317.2 28575.6 28767.7 28805.9 1048.9 1062.3 1069.3 1112.6 1207.3 14478.1 14539.7 14641.3 14818.6 14959.8 302898.0 309193.0 310263.0 310400.0 311185.0 43558.0 44256.1 51080.7 51100.0 51297.7 1213.8 1251.9 1345.8 1349.8 1362.8 25643.2 25855.4 26420.9 27907.7 28743.9 41994.4 42370.2 43631.8 44276.3 47469.8 201467.0 202577.0 204723.0 205275.0 205355.0 31986.0 32363.5 32404.0 32411.5 32442.0 42285.8 42974.1 43169.1 43258.0 43728.6 35685.8 36161.8 36360.9 36596.8 37623.6 36194.0 36732.0 36904.6 36935.0 37009.3 34955.0 35079.0 35353.5 35643.5 35715.8 26843.0 27436.3 28994.4 29909.7 31853.7 24027.8 24150.9 24386.5 24641.9 24735.1 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#2] jquery.html Cycles:180 Average:26132.44 Median:370.48 stddev:73377.53 (19806.0%) stddev-sans-first:73557.86 13:14:38 INFO - PROCESS | 18458 | Values: 361.7 366.6 367.6 369.3 371.6 13726.5 13962.9 16235.5 17176.4 18171.4 14912.6 16431.2 16756.5 17714.8 17719.8 4498.9 5300.8 5422.9 5423.8 5425.2 3948.8 4059.4 5766.1 5896.7 5938.5 5818.0 5864.3 5901.9 5914.6 5915.2 5705.2 5824.4 5830.1 5840.9 5849.6 5128.2 5146.5 5152.4 5174.9 5176.2 19109.1 19893.6 20250.2 20845.7 21000.8 2148.9 2259.2 2333.1 2434.0 2655.3 12865.7 12973.8 13002.2 13251.1 13265.5 1784.9 1787.9 1820.4 1822.4 1874.4 51761.5 55718.7 55870.7 56185.2 56697.1 9555.2 9792.5 9900.1 9900.5 9948.2 12948.0 12961.4 12970.5 12971.7 13024.7 7347.0 7369.1 7416.4 7419.1 7422.9 7316.9 7340.5 7345.0 7371.0 7373.8 4296.9 4357.6 4392.9 4395.2 4398.6 1702.2 1709.5 1747.0 1754.3 1782.6 846.4 926.1 975.2 988.0 1000.9 12425.2 16177.7 16830.4 16974.2 17160.9 874.1 875.6 914.8 990.8 1004.8 9458.7 9476.6 9698.9 9722.2 9771.3 438699.0 439836.0 443455.0 444693.0 474087.0 78942.6 81005.0 81584.0 81827.2 82106.2 1148.2 1149.8 1155.7 1156.7 1158.4 15338.2 15590.6 15734.5 15908.6 15978.6 31199.8 31685.8 31741.0 32059.7 32653.5 38128.0 41300.0 48872.8 49486.3 50989.2 9560.4 9744.5 9944.0 9947.3 9963.8 16414.8 17222.5 17461.8 17924.3 17984.0 13840.2 14162.7 14193.4 14225.4 14325.4 12891.5 14221.6 14552.5 14776.3 15341.4 14850.4 14914.5 15265.1 15276.4 15295.2 9442.6 9692.9 9885.3 9984.7 9998.2 10260.5 10343.2 13606.9 13847.3 14304.8 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#3] mootools.html Cycles:180 Average:5294.47 Median:631.36 stddev:2702.73 (428.1%) stddev-sans-first:2692.97 13:14:38 INFO - PROCESS | 18458 | Values: 1222.4 1474.1 1493.7 1626.6 1828.8 6722.8 7340.7 7445.7 7447.7 7461.1 7363.4 7385.8 7459.1 7459.2 7477.2 1954.7 1983.4 2266.3 2303.1 2308.1 2325.7 2348.5 2352.6 2352.6 2355.6 2267.2 2284.0 2303.2 2308.5 2311.6 2283.5 2285.4 2287.1 2306.7 2326.4 2294.7 2301.2 2325.6 2328.5 2336.1 7589.4 7654.5 7695.4 7703.5 7731.3 4731.7 4772.7 4773.7 4799.6 4810.9 3051.8 3096.7 3142.0 3151.2 3163.0 1002.5 1028.7 1028.9 1068.3 1081.3 10075.7 10238.1 10283.1 10292.8 10298.8 4066.3 4092.0 4162.3 4310.8 4313.1 8325.8 8494.4 8496.7 8509.8 8511.4 4760.1 4761.5 4786.8 4804.9 4810.4 4347.2 4356.2 4396.5 4428.6 4429.0 3253.7 3288.0 3423.5 3447.6 3473.4 1055.8 1060.2 1067.5 1070.8 1089.3 1074.0 1080.0 1127.4 1262.5 1376.0 6691.4 6705.2 6793.8 6802.1 7131.4 624.1 638.6 641.2 644.7 777.0 5580.5 5613.4 5739.8 5767.9 5783.1 8791.7 9095.0 9096.0 9116.7 9147.5 8500.4 8714.8 8717.0 8755.6 8860.2 7097.6 7128.2 7154.7 7221.8 7230.6 6869.2 6952.0 6979.0 6998.5 7000.6 7888.9 8030.5 8064.3 8118.7 8141.8 8233.0 8305.5 8385.6 8421.2 8505.4 6468.2 6490.3 6538.7 6549.2 6555.3 7412.3 7474.4 7482.6 7486.6 7503.7 6999.1 7073.3 7085.5 7219.4 7269.5 6622.6 6973.0 7026.9 7092.9 7160.3 6730.4 6739.1 6748.7 6749.9 6753.1 5790.9 5801.2 5802.5 5811.4 6167.5 6389.4 6402.0 6426.5 6430.1 6434.0 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#4] prototype.html Cycles:180 Average:5256.10 Median:5980.93 stddev:1570.59 (26.3%) stddev-sans-first:1531.02 13:14:38 INFO - PROCESS | 18458 | Values: 338.7 342.1 344.6 346.9 347.8 5830.4 5888.3 5902.5 5930.4 5982.5 5709.1 5889.3 5902.5 5909.4 5971.9 4582.1 4585.4 4588.4 4591.0 4591.7 4326.5 4398.2 4500.9 4567.8 4588.9 4474.9 4505.7 4519.4 4523.8 4527.5 4512.9 4530.7 4565.3 4572.7 4586.7 4055.2 4056.2 4061.1 4067.8 4068.1 5489.8 5620.2 5622.8 5629.4 5645.7 5240.3 5257.2 5265.5 5266.9 5277.5 5998.2 6291.3 6295.2 6299.9 6301.0 4287.8 4289.7 4371.2 4388.1 4402.2 6422.3 6510.9 6519.3 6519.8 6524.5 4492.9 4498.1 4498.6 4500.8 4501.8 4417.7 4542.8 4547.3 4549.5 4580.4 5234.1 5234.8 5242.6 5243.3 5260.6 6255.9 6262.8 6263.5 6267.1 6281.6 1575.2 1603.9 1604.6 1607.0 1609.8 1063.6 1069.1 1071.1 1083.1 1097.3 6027.9 6029.3 6035.2 6035.5 6039.8 6423.0 6434.6 6436.3 6440.9 6481.3 5801.7 5979.4 6004.6 6019.7 6028.8 3455.9 3514.3 3516.0 3516.2 3518.1 6647.7 6685.3 6695.5 6709.0 6715.3 6573.7 6577.3 6586.8 6593.0 6602.9 6541.9 6696.5 6710.7 6720.0 6723.3 6343.3 6458.1 6462.6 6464.0 6468.1 6280.7 6437.5 6454.4 6473.0 6479.9 6685.1 6697.1 6697.5 6698.5 6700.0 4361.1 4534.2 4545.3 4546.5 4549.9 6366.2 6390.0 6404.1 6420.5 6423.1 6253.6 6254.1 6262.1 6286.7 6326.0 6206.9 6239.8 6247.8 6252.8 6254.3 6197.1 6234.1 6242.9 6245.3 6257.6 6366.4 6397.0 6410.4 6411.5 6413.3 6139.0 6219.8 6230.7 6253.7 6253.9 13:14:38 INFO - PROCESS | 18458 | 13:14:38 INFO - PROCESS | 18458 | [#5] yui.html Cycles:180 Average:12908.45 Median:24722.18 stddev:14491.54 (58.6%) stddev-sans-first:14503.46 13:14:38 INFO - PROCESS | 18458 | Values: 756.0 770.8 807.8 815.4 884.5 13578.3 13819.9 13828.2 13829.9 13871.9 13125.6 13203.0 13220.4 13240.6 13262.3 680.0 680.9 819.6 828.2 830.8 833.5 837.1 838.0 840.3 840.8 709.4 877.9 879.6 880.0 880.7 709.1 860.9 873.4 875.9 878.4 640.2 646.8 647.2 647.5 648.0 12859.5 12988.9 13011.1 13014.0 13061.4 11548.5 11610.7 11641.0 12487.2 12543.6 9743.0 10069.1 10090.9 10161.7 10251.5 3524.9 3560.3 3571.9 3581.4 3711.2 43435.1 43764.1 43783.6 43970.9 44061.3 8829.8 9041.1 9125.7 9158.4 9216.5 16922.8 16928.6 16956.3 16961.7 17618.2 7489.6 7603.8 7729.2 7766.4 7783.1 4383.3 4446.5 4485.2 4517.9 4555.1 3063.1 3080.1 3101.5 3135.2 3136.2 568.6 570.3 576.2 577.5 585.0 535.8 565.9 573.3 599.7 619.3 7893.8 8108.6 8117.5 8202.8 8221.8 445.8 457.0 461.0 562.8 591.8 3681.9 3709.6 3794.9 3875.0 4233.5 44959.2 46577.5 49651.8 52143.5 53526.5 45832.0 46702.3 46908.0 47060.0 47276.0 42509.6 43478.1 44038.8 44215.0 44351.1 8058.2 8071.1 8233.1 8257.9 8337.2 33518.0 33573.2 34181.8 34381.7 34490.1 38611.6 41411.4 42460.0 43133.1 43247.0 10392.3 10597.5 10648.2 10754.0 11175.9 11069.2 11200.9 11239.5 11433.8 11458.2 10685.1 10706.1 10891.6 10932.8 11286.7 10379.4 10483.3 10587.8 10613.2 10942.3 7961.6 9398.3 10504.5 10517.3 10621.4 8976.0 9411.8 9693.9 9702.8 9756.9 8707.3 8724.7 8728.1 8953.9 9279.6 13:14:38 INFO - PROCESS | 18458 | -------- Summary: end -------- 13:14:38 INFO - PROCESS | 18458 | 13:14:39 INFO - TEST-INFO | 18458: exit 0 13:14:39 INFO - TEST-OK | dromaeo_css | took 1113112ms 13:14:39 INFO - TEST-START | kraken 13:14:39 INFO - operating with platform_type : linux_ 13:14:39 INFO - Initialising browser for kraken test... 13:14:39 INFO - TEST-INFO | started process 18661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYKcJDb/profile http://localhost:42217/getInfo.html) 13:14:43 INFO - PROCESS | 18661 | __metrics Screen width/height:1600/1200 13:14:43 INFO - PROCESS | 18661 | colorDepth:24 13:14:43 INFO - PROCESS | 18661 | Browser inner width/height: 1024/697 13:14:43 INFO - PROCESS | 18661 | __metrics 13:14:43 INFO - PROCESS | 18661 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:14:44 INFO - PROCESS | 18661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:14:44 INFO - TEST-INFO | 18661: exit 0 13:14:44 INFO - Browser initialized. 13:14:44 INFO - Running cycle 1/1 for kraken test... 13:14:44 INFO - TEST-INFO | started process 18746 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYKcJDb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:56 INFO - PROCESS | 18746 | RSS: Main: 149549056 13:14:56 INFO - PROCESS | 18746 | 13:14:59 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42217/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:59 INFO - PROCESS | 18746 | RSS: Main: 186945536 13:14:59 INFO - PROCESS | 18746 | 13:15:02 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42217/tests/kraken/driver.html?testName=audio-dft) 13:15:02 INFO - PROCESS | 18746 | RSS: Main: 176959488 13:15:02 INFO - PROCESS | 18746 | 13:15:05 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42217/tests/kraken/driver.html?testName=audio-fft) 13:15:06 INFO - PROCESS | 18746 | RSS: Main: 160047104 13:15:06 INFO - PROCESS | 18746 | 13:15:08 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42217/tests/kraken/driver.html?testName=audio-oscillator) 13:15:08 INFO - PROCESS | 18746 | RSS: Main: 162623488 13:15:08 INFO - PROCESS | 18746 | 13:15:11 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:15:11 INFO - PROCESS | 18746 | RSS: Main: 164339712 13:15:11 INFO - PROCESS | 18746 | 13:15:14 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42217/tests/kraken/driver.html?testName=imaging-darkroom) 13:15:15 INFO - PROCESS | 18746 | RSS: Main: 165638144 13:15:15 INFO - PROCESS | 18746 | 13:15:18 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42217/tests/kraken/driver.html?testName=imaging-desaturate) 13:15:19 INFO - PROCESS | 18746 | RSS: Main: 165408768 13:15:19 INFO - PROCESS | 18746 | 13:15:21 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42217/tests/kraken/driver.html?testName=json-parse-financial) 13:15:22 INFO - PROCESS | 18746 | RSS: Main: 163909632 13:15:22 INFO - PROCESS | 18746 | 13:15:23 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:15:24 INFO - PROCESS | 18746 | RSS: Main: 177799168 13:15:24 INFO - PROCESS | 18746 | 13:15:26 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:15:26 INFO - PROCESS | 18746 | RSS: Main: 175992832 13:15:26 INFO - PROCESS | 18746 | 13:15:28 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:15:29 INFO - PROCESS | 18746 | RSS: Main: 187240448 13:15:29 INFO - PROCESS | 18746 | 13:15:31 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:15:32 INFO - PROCESS | 18746 | RSS: Main: 193339392 13:15:32 INFO - PROCESS | 18746 | 13:15:35 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:15:35 INFO - PROCESS | 18746 | RSS: Main: 193789952 13:15:35 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:42217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42217/tests/kraken/driver.html?testName=ai-astar) 13:15:37 INFO - PROCESS | 18746 | RSS: Main: 251224064 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | __start_tp_report 13:15:37 INFO - PROCESS | 18746 | _x_x_mozilla_page_load 13:15:37 INFO - PROCESS | 18746 | _x_x_mozilla_page_load_details 13:15:37 INFO - PROCESS | 18746 | |i|pagename|runs| 13:15:37 INFO - PROCESS | 18746 | |0;ai-astar;111;110;105;110;110;110;97;109;110;116 13:15:37 INFO - PROCESS | 18746 | |1;audio-beat-detection;161;127;154;163;133;147;149;127;175;135 13:15:37 INFO - PROCESS | 18746 | |2;audio-dft;161;162;160;161;160;159;161;161;160;162 13:15:37 INFO - PROCESS | 18746 | |3;audio-fft;71;72;88;92;71;73;70;99;90;71 13:15:37 INFO - PROCESS | 18746 | |4;audio-oscillator;95;96;141;96;96;96;146;95;96;140 13:15:37 INFO - PROCESS | 18746 | |5;imaging-gaussian-blur;109;108;109;109;109;109;109;109;108;108 13:15:37 INFO - PROCESS | 18746 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;145;146 13:15:37 INFO - PROCESS | 18746 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;95 13:15:37 INFO - PROCESS | 18746 | |8;json-parse-financial;60;58;59;59;57;58;61;67;56;57 13:15:37 INFO - PROCESS | 18746 | |9;json-stringify-tinderbox;66;66;66;67;68;67;68;67;67;67 13:15:37 INFO - PROCESS | 18746 | |10;stanford-crypto-aes;83;83;82;84;84;85;83;85;83;85 13:15:37 INFO - PROCESS | 18746 | |11;stanford-crypto-ccm;124;121;116;114;127;122;119;129;116;119 13:15:37 INFO - PROCESS | 18746 | |12;stanford-crypto-pbkdf2;140;141;152;155;152;143;154;152;158;140 13:15:37 INFO - PROCESS | 18746 | |13;stanford-crypto-sha256-iterative;67;66;69;69;66;67;69;68;67;68 13:15:37 INFO - PROCESS | 18746 | __end_tp_report 13:15:37 INFO - PROCESS | 18746 | __start_cc_report 13:15:37 INFO - PROCESS | 18746 | _x_x_mozilla_cycle_collect,919 13:15:37 INFO - PROCESS | 18746 | __end_cc_report 13:15:37 INFO - PROCESS | 18746 | __startTimestamp1450905337574__endTimestamp 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | ------- Summary: start ------- 13:15:37 INFO - PROCESS | 18746 | Number of tests: 14 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:4.92 (4.5%) stddev-sans-first:5.15 13:15:37 INFO - PROCESS | 18746 | Values: 111.0 110.0 105.0 110.0 110.0 110.0 97.0 109.0 110.0 116.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.50 stddev:16.43 (10.8%) stddev-sans-first:16.64 13:15:37 INFO - PROCESS | 18746 | Values: 161.0 127.0 154.0 163.0 133.0 147.0 149.0 127.0 175.0 135.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:15:37 INFO - PROCESS | 18746 | Values: 161.0 162.0 160.0 161.0 160.0 159.0 161.0 161.0 160.0 162.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#3] audio-fft Cycles:10 Average:79.70 Median:80.50 stddev:11.18 (13.9%) stddev-sans-first:11.40 13:15:37 INFO - PROCESS | 18746 | Values: 71.0 72.0 88.0 92.0 71.0 73.0 70.0 99.0 90.0 71.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.00 stddev:22.57 (23.5%) stddev-sans-first:23.31 13:15:37 INFO - PROCESS | 18746 | Values: 95.0 96.0 141.0 96.0 96.0 96.0 146.0 95.0 96.0 140.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#5] imaging-gaussian-blur Cycles:10 Average:108.70 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:15:37 INFO - PROCESS | 18746 | Values: 109.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 108.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:15:37 INFO - PROCESS | 18746 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:15:37 INFO - PROCESS | 18746 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:3.12 (5.3%) stddev-sans-first:3.30 13:15:37 INFO - PROCESS | 18746 | Values: 60.0 58.0 59.0 59.0 57.0 58.0 61.0 67.0 56.0 57.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 13:15:37 INFO - PROCESS | 18746 | Values: 66.0 66.0 66.0 67.0 68.0 67.0 68.0 67.0 67.0 67.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:1.09 13:15:37 INFO - PROCESS | 18746 | Values: 83.0 83.0 82.0 84.0 84.0 85.0 83.0 85.0 83.0 85.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:4.90 (4.0%) stddev-sans-first:5.05 13:15:37 INFO - PROCESS | 18746 | Values: 124.0 121.0 116.0 114.0 127.0 122.0 119.0 129.0 116.0 119.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:152.00 stddev:6.91 (4.5%) stddev-sans-first:6.58 13:15:37 INFO - PROCESS | 18746 | Values: 140.0 141.0 152.0 155.0 152.0 143.0 154.0 152.0 158.0 140.0 13:15:37 INFO - PROCESS | 18746 | 13:15:37 INFO - PROCESS | 18746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 13:15:37 INFO - PROCESS | 18746 | Values: 67.0 66.0 69.0 69.0 66.0 67.0 69.0 68.0 67.0 68.0 13:15:37 INFO - PROCESS | 18746 | -------- Summary: end -------- 13:15:37 INFO - PROCESS | 18746 | 13:15:38 INFO - TEST-INFO | 18746: exit 0 13:15:38 INFO - TEST-OK | kraken | took 59011ms 13:15:38 INFO - TEST-START | v8_7 13:15:38 INFO - operating with platform_type : linux_ 13:15:38 INFO - Initialising browser for v8_7 test... 13:15:38 INFO - TEST-INFO | started process 18996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyFP2xQ/profile http://localhost:42217/getInfo.html) 13:15:42 INFO - PROCESS | 18996 | __metrics Screen width/height:1600/1200 13:15:42 INFO - PROCESS | 18996 | colorDepth:24 13:15:42 INFO - PROCESS | 18996 | Browser inner width/height: 1024/697 13:15:42 INFO - PROCESS | 18996 | __metrics 13:15:42 INFO - PROCESS | 18996 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:15:42 INFO - PROCESS | 18996 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:15:42 ERROR - PROCESS | 18996 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 13:15:43 INFO - TEST-INFO | 18996: exit 0 13:15:43 INFO - Browser initialized. 13:15:43 INFO - Running cycle 1/1 for v8_7 test... 13:15:43 INFO - TEST-INFO | started process 19083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyFP2xQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:55 INFO - PROCESS | 19083 | RSS: Main: 149762048 13:15:55 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | Cycle 1(1): loaded http://localhost:42217/tests/v8_7/run.html (next: http://localhost:42217/tests/v8_7/run.html) 13:16:16 INFO - PROCESS | 19083 | RSS: Main: 590856192 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | __start_tp_report 13:16:16 INFO - PROCESS | 19083 | _x_x_mozilla_page_load 13:16:16 INFO - PROCESS | 19083 | _x_x_mozilla_page_load_details 13:16:16 INFO - PROCESS | 19083 | |i|pagename|runs| 13:16:16 INFO - PROCESS | 19083 | |0;Richards;166.05778811026238 13:16:16 INFO - PROCESS | 19083 | |1;DeltaBlue;189.3580761219466 13:16:16 INFO - PROCESS | 19083 | |2;Encrypt;281.0567734682406 13:16:16 INFO - PROCESS | 19083 | |3;Decrypt;5186.5284974093265 13:16:16 INFO - PROCESS | 19083 | |4;RayTrace;1108.6474501108648 13:16:16 INFO - PROCESS | 19083 | |5;Earley;791.1392405063291 13:16:16 INFO - PROCESS | 19083 | |6;Boyer;12256.09756097561 13:16:16 INFO - PROCESS | 19083 | |7;RegExp;26500 13:16:16 INFO - PROCESS | 19083 | |8;Splay;638.9776357827476 13:16:16 INFO - PROCESS | 19083 | |9;NavierStokes;4822.115384615385 13:16:16 INFO - PROCESS | 19083 | __end_tp_report 13:16:16 INFO - PROCESS | 19083 | __startTimestamp1450905376907__endTimestamp 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | ------- Summary: start ------- 13:16:16 INFO - PROCESS | 19083 | Number of tests: 10 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 166.1 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#1] DeltaBlue Cycles:1 Average:189.36 Median:189.36 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 189.4 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#2] Encrypt Cycles:1 Average:281.06 Median:281.06 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 281.1 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 5186.5 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 1108.6 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 791.1 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 12256.1 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#7] RegExp Cycles:1 Average:26500.00 Median:26500.00 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 26500.0 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#8] Splay Cycles:1 Average:638.98 Median:638.98 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 639.0 13:16:16 INFO - PROCESS | 19083 | 13:16:16 INFO - PROCESS | 19083 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:16:16 INFO - PROCESS | 19083 | Values: 4822.1 13:16:16 INFO - PROCESS | 19083 | -------- Summary: end -------- 13:16:16 INFO - PROCESS | 19083 | 13:16:17 INFO - TEST-INFO | 19083: exit 0 13:16:17 INFO - TEST-OK | v8_7 | took 39225ms 13:16:17 INFO - SUITE-END | took 1211s 13:16:17 INFO - Completed test suite (00:20:11) 13:16:17 INFO - Working with test: dromaeo_css 13:16:17 INFO - Generating results file: dromaeo_css 13:16:17 INFO - Working with test: kraken 13:16:17 INFO - Generating results file: kraken 13:16:17 INFO - javascript benchmark 13:16:17 INFO - Working with test: v8_7 13:16:17 INFO - Generating results file: v8_7 13:16:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:16:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 13:16:18 INFO - process_Request line: dromaeo_css 6850.86 graph.html#tests=[[72,63,35]] 13:16:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:16:18 INFO - process_Request line: kraken 1503.00 graph.html#tests=[[232,63,35]] 13:16:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:16:18 INFO - process_Request line: v8_7 20846.80 graph.html#tests=[[230,63,35]] 13:16:18 INFO - RETURN: dromaeo_css: 6850.86 13:16:18 INFO - RETURN: kraken: 1503.00 13:16:18 INFO - RETURN: v8_7: 20846.80 13:16:18 INFO - javascript benchmark 13:16:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.3743251349733, 3179.395914776194, 3185.7451403887676, 3190.2821865080373, 3213.6143662760464, 5208.427073021964, 5230.686158830473, 5267.894642107156, 5277.419483856782, 5328.786848526059, 5277.261183434322, 5306.602004849632, 5349.732513374325, 5353.705546194958, 5358.490943360374, 4793.640476964224, 4800.711957282574, 4823.855284341475, 4882.462929077798, 4882.536159064884, 4737.620990320784, 4890.14422476067, 4912.582430493412, 4926.45808961014, 4988.376452943382, 4751.121042607128, 4815.975920120412, 4833.927491087637, 4835.347228124228, 4851.029794041206, 4803.879903002453, 4818.68678535894, 4829.782659780319, 4837.274408838667, 4863.902721945541, 4680.906381872377, 4775.80896764129, 4779.784909679072, 4785.617150627942, 4822.469528351879, 5023.924641130386, 5052.873678158038, 5181.663191892552, 5190.143626301656, 5224.268602395668, 5698.601097923147, 5701.344345400249, 5701.372848986608, 5725.6278341908055, 5737.483626473596, 5536.4186760390385, 5722.656640601577, 5735.455131762517, 5750.913736293959, 5759.222504961818, 5296.232046353296, 5324.148136298212, 5341.946580534145, 5346.331708536433, 5384.1923711443205, 5801.970990145022, 5823.621464604787, 5824.446677565709, 5833.416658334218, 5834.504067154255, 5477.178423236467, 5543.1685247213245, 5582.190582365534, 5618.0, 5627.212190293362, 5592.133219351007, 5706.172604972338, 5712.514436272881, 5713.257276554022, 5738.110592858114, 5663.263775709132, 5677.801276955287, 5683.204351390808, 5686.175504551899, 5688.089905615165, 5453.318335208099, 5559.193916882029, 5569.192467092249, 5604.271444712162, 5678.943210567842, 4342.913141737147, 4382.780860956939, 4391.429114215131, 4393.0774537347515, 4393.736375817397, 3869.9357676638588, 3886.7473614214987, 3899.064224586079, 3925.156091440297, 3929.0766669832565, 5214.739263036833, 5252.317198764136, 5277.683338999673, 5318.25544423781, 5327.413984461784, 5732.398098199712, 5754.251947246831, 5755.223044888887, 5756.251687280626, 5769.711514424262, 5342.813001544927, 5360.249565060894, 5362.544183744348, 5365.785368585213, 5366.490183432567, 4830.3479030331155, 4915.21356582945, 4916.852494425173, 4972.2790195422185, 5010.248462730619, 5891.764329426861, 5916.1421593868645, 5925.466707996301, 5926.940730592725, 5946.613470124515, 5732.484076433141, 5753.309602847685, 5753.626014309057, 5754.165645981393, 5757.798477053283, 5746.942530574641, 5811.215485909517, 5855.238818953509, 5872.383399743137, 5998.0, 5556.111022236423, 5559.972200138974, 5576.302962129734, 5610.270664813548, 5615.522680572197, 5617.859553511195, 5649.378568357395, 5668.829935101953, 5671.376148623731, 5674.347450043133, 5411.729413529229, 5481.862953426037, 5519.69641669712, 5552.472515111058, 5585.078462053716, 5543.611947163821, 5545.112781954868, 5549.972250138723, 5553.611247212818, 5556.166575013619, 5387.0, 5477.698726570077, 5482.122860342326, 5482.479164479368, 5526.91709624364, 5544.0, 5566.387697353207, 5583.8883222336135, 5602.467765562265, 5660.7169641518585, 5459.0, 5461.644993075437, 5462.153366228241, 5462.3445186577865, 5512.641678290898], "unit": "score", "name": "dojo.html", "value": 5237.982868588186}, {"lowerIsBetter": false, "replicates": [569.0780934885486, 596.7493652665883, 597.3041406761123, 603.8822429626223, 611.4863514647695, 34872.30255394894, 35477.645223547755, 35478.82260588697, 35503.64496355036, 35568.11079723008, 41517.16965660685, 42102.15795684084, 42147.15705685884, 42200.0, 42204.36693449593, 7357.632118394085, 7478.850422991537, 8727.083656216086, 8860.24687901529, 8886.777830554223, 10066.0, 10227.079562839343, 10269.0, 10303.53634086464, 10317.535710893027, 10089.899101009007, 10169.847452288222, 10181.847272290921, 10206.285560010801, 10224.539895704675, 7556.924430755677, 7700.075990881102, 7720.961395193044, 9950.850737238947, 10094.29339946204, 9811.313208075437, 9942.751431214205, 9984.750381240454, 9996.050375214343, 9999.50002499872, 35283.4707479388, 35778.28443431143, 35787.284254315025, 35815.0, 35882.30882683783, 3314.386838434897, 3331.1006028372203, 3366.259422926952, 3376.3922493951077, 3423.2126610879636, 27420.314492137655, 27633.447331053267, 29935.70064299351, 30097.247568810737, 30927.84536077305, 3960.1683646434285, 3982.960170398288, 4035.8183881725395, 4102.097538541516, 4117.794110294473, 203921.0, 204155.0, 205279.0, 206138.9999999985, 206267.0, 51036.48963510317, 52156.47843521592, 55869.0, 57216.71391643015, 57641.42358576361, 56844.0, 56929.0, 57171.71414142986, 57201.0, 57288.42711572831, 14584.0, 14627.0, 14751.557453276419, 14756.778648320069, 14845.331960061823, 10774.838377424345, 10780.083692886192, 10780.245382823126, 10790.838137427945, 10816.405097719544, 18987.33544325942, 19048.80951190498, 19095.90452047731, 19201.61596768057, 19229.326973555857, 7248.96375518119, 7501.924980750232, 7521.05986751656, 7672.5012874163, 7688.769336919901, 918.2929144558786, 953.8473844185036, 976.4824642939111, 1075.0002497677235, 1078.1536493852288, 28009.859950700116, 28317.15048548547, 28575.57136642952, 28767.712322876923, 28805.85597072001, 1048.8793788714395, 1062.2617280989793, 1069.2996087562658, 1112.554978008803, 1207.3480320626763, 14478.131312121306, 14539.709205816036, 14641.34113964874, 14818.629534261514, 14959.810874704492, 302898.0, 309193.0, 310263.0, 310400.0, 311185.0, 43558.0, 44256.11487770227, 51080.74459627678, 51100.0, 51297.743511282206, 1213.836132122152, 1251.9186252893533, 1345.7981302804462, 1349.8110264562772, 1362.7683293839873, 25643.230703078938, 25855.353616159748, 26420.867895660398, 27907.720922791323, 28743.85628071846, 41994.37008444815, 42370.15259694727, 43631.78184109059, 44276.33585496285, 47469.762651186524, 201467.0, 202577.0, 204723.0, 205275.0, 205355.0, 31986.0, 32363.51454728134, 32404.0, 32411.51382729308, 32442.0, 42285.788571056946, 42974.140517190106, 43169.13661726685, 43258.0, 43728.56271437245, 35685.82157089198, 36161.81919090388, 36360.90917272486, 36596.81701591475, 37623.623763762014, 36194.0, 36732.0, 36904.63095369012, 36935.0, 37009.25981480409, 34955.0, 35079.0, 35353.46969795404, 35643.46534801928, 35715.82142089273, 26843.0, 27436.314092147855, 28994.42011159723, 29909.70090299156, 31853.681463185072, 24027.759722402552, 24150.864347774266, 24386.51226975486, 24641.876790615934, 24735.134270300452], "unit": "score", "name": "ext.html", "value": 17939.513096923103}, {"lowerIsBetter": false, "replicates": [361.7359327690784, 366.6150541930972, 367.59013699724807, 369.329666655021, 371.63208423660586, 13726.519571814988, 13962.860371396284, 16235.51293461195, 17176.39882604109, 18171.364002259925, 14912.62718432037, 16431.17844107796, 16756.497305080866, 17714.822851771478, 17719.822801771978, 4498.887527811815, 5300.840974770763, 5422.864428389283, 5423.810166644168, 5425.159100339453, 3948.802559872009, 4059.4113853491226, 5766.106253530688, 5896.675682837442, 5938.524918006549, 5818.0, 5864.325602555718, 5901.881962360751, 5914.645121292736, 5915.1718759373725, 5705.2012718219485, 5824.417558244184, 5830.125481177814, 5840.912386314209, 5849.6197747146725, 5128.230765385222, 5146.485351464861, 5152.355955505562, 5174.896502069938, 5176.197689358156, 19109.1400886959, 19893.602127957503, 20250.17748402651, 20845.68731469029, 21000.789992100035, 2148.8603240789457, 2259.20927675314, 2333.0551126793675, 2433.9878300608384, 2655.3361659585103, 12865.67835804103, 12973.766757906977, 13002.154859934075, 13251.13867598603, 13265.535706250235, 1784.8661350398772, 1787.8748487605874, 1820.4447643468736, 1822.4441545328668, 1874.4189301316635, 51761.482385176045, 55718.72140639312, 55870.720646396505, 56185.15722264169, 56697.149542756895, 9555.18780903631, 9792.51037448139, 9900.108990190918, 9900.455474948947, 9948.154406875497, 12948.0, 12961.351932403342, 12970.481180752664, 12971.740565188644, 13024.720673882033, 7346.963265183746, 7369.078865141857, 7416.369608583331, 7419.109706835215, 7422.888656670154, 7316.890246646304, 7340.4861659684375, 7344.96327518359, 7370.96314518424, 7373.820188769771, 4296.871093867189, 4357.607815296638, 4392.912141757147, 4395.230834603932, 4398.560143985575, 1702.1999660159704, 1709.4529750479728, 1746.9650606987789, 1754.2719771295026, 1782.5632719983428, 846.4202021615213, 926.1201858234704, 975.1662328708993, 987.9901200987898, 1000.8548760429696, 12425.19236249641, 16177.67644647124, 16830.41093561744, 16974.15129243533, 17160.914195428944, 874.0822136756381, 875.5753459572103, 914.835329640671, 990.8018396320621, 1004.8444289067485, 9458.716238512856, 9476.573554190078, 9698.903010969942, 9722.222222222204, 9771.267154963407, 438699.0, 439836.0, 443455.0, 444693.0, 474087.0, 78942.6052869732, 81005.0, 81584.0, 81827.18172818195, 82106.17893821104, 1148.1733152130453, 1149.8160294352863, 1155.7284038251005, 1156.7455159864817, 1158.4497363752319, 15338.233088345762, 15590.610234744223, 15734.527964161094, 15908.602284942506, 15978.60053498672, 31199.84400077985, 31685.841570792, 31741.04776856698, 32059.679403205668, 32653.510197346583, 38128.0, 41300.0, 48872.75563622302, 49486.257706133714, 50989.235161471865, 9560.378575392577, 9744.512774361396, 9943.950280248553, 9947.303688741718, 9963.800723985625, 16414.753778693568, 17222.483325500256, 17461.825381746527, 17924.283028678707, 17984.0, 13840.23878686682, 14162.716745665235, 14193.361298741787, 14225.359858806585, 14325.355359009078, 12891.548795792101, 14221.573352799433, 14552.49066282675, 14776.261186940395, 15341.386344546094, 14850.40598376053, 14914.477993270184, 15265.084094954338, 15276.388944442542, 15295.235238238267, 9442.622295108393, 9692.854607180758, 9885.258605604464, 9984.650537231162, 9998.150157236716, 10260.486975651038, 10343.224258180517, 13606.863931360956, 13847.307634618028, 14304.785428218793], "unit": "score", "name": "jquery.html", "value": 8857.883540723717}, {"lowerIsBetter": false, "replicates": [1222.4193508083656, 1474.0934325389887, 1493.7161939231546, 1626.5770899566116, 1828.8171182881722, 6722.79831605052, 7340.743073992411, 7445.664945077471, 7447.664855081521, 7461.104667439908, 7363.374113200384, 7385.778426647195, 7459.067616547932, 7459.179490256068, 7477.214892436297, 1954.667706489893, 1983.4049785064494, 2266.3087758233733, 2303.101790301775, 2308.145985985188, 2325.6744055832196, 2348.518553696488, 2352.6000579901374, 2352.6000579901374, 2355.5877721398774, 2267.1611503743557, 2284.0407029047838, 2303.2053941390195, 2308.4921317310163, 2311.56080344734, 2283.4633861042644, 2285.371522831218, 2287.062304455182, 2306.7001289832297, 2326.360250930999, 2294.7016887804643, 2301.2405906050963, 2325.5930212212793, 2328.499372634875, 2336.0538981712434, 7589.392848572101, 7654.502457340255, 7695.384369250447, 7703.499272547267, 7731.304182623591, 4731.716097034155, 4772.73749943753, 4773.665843390964, 4799.592034677056, 4810.855674329776, 3051.755859531232, 3096.736777373926, 3142.025971948703, 3151.2437015116207, 3162.9683703162905, 1002.5187909803335, 1028.70167651381, 1028.9485525723685, 1068.3483075324045, 1081.2863510083307, 10075.748106297327, 10238.078572928398, 10283.07452329294, 10292.794144117152, 10298.845517317246, 4066.268071747114, 4092.0, 4162.313218318944, 4310.827566897289, 4313.051128751669, 8325.750227493185, 8494.362922780816, 8496.745097647081, 8509.829803403898, 8511.446755960842, 4760.119377915097, 4761.4524329701835, 4786.7845946932475, 4804.855854324376, 4810.39870016248, 4347.152305300436, 4356.19410409069, 4396.450443694538, 4428.645708343325, 4428.977855110704, 3253.6908993645566, 3288.046466524681, 3423.4522476403654, 3447.620761716209, 3473.409520381491, 1055.767731099157, 1060.2260349944584, 1067.4662668665667, 1070.7911957168278, 1089.2865173311493, 1074.001178903627, 1080.0225795654944, 1127.3855748617023, 1262.4571434283346, 1376.0436496634743, 6691.397774200345, 6705.161854768154, 6793.830154246183, 6802.115724955724, 7131.393831524379, 624.1168746224133, 638.6072565372356, 641.233725697796, 644.7421031587403, 776.9961150194213, 5580.525655319262, 5613.354464236583, 5739.770409183586, 5767.942320576824, 5783.132530120515, 8791.692290769792, 9095.0, 9096.0, 9116.726498205064, 9147.451152930846, 8500.362472814564, 8714.782130446663, 8717.0, 8755.56222188888, 8860.246879015227, 7097.609631470319, 7128.215896251409, 7154.7495837646475, 7221.819454513679, 7230.56616602995, 6869.210040845167, 6951.9652401739695, 6979.022936788752, 6998.510104292651, 7000.61496617691, 7888.921110789048, 8030.478018928985, 8064.314533264738, 8118.715844945398, 8141.8371632568205, 8232.958835205785, 8305.543195124326, 8385.58072096405, 8421.157884211774, 8505.36209784281, 6468.191476065492, 6490.318516555693, 6538.705758240795, 6549.24683661385, 6555.344465553407, 7412.258774122544, 7474.402047836269, 7482.625868706652, 7486.625668716433, 7503.699852005859, 6999.09011828459, 7073.328033836778, 7085.539439936388, 7219.422446204396, 7269.454790890599, 6622.569532980341, 6973.0, 7026.859462810818, 7092.929070709433, 7160.283971602798, 6730.427913627396, 6739.123913891162, 6748.69630866622, 6749.898751518829, 6753.054572359972, 5790.9420905792085, 5801.245838041028, 5802.47777700009, 5811.360750317546, 6167.475764560063, 6389.361063893573, 6402.03969404593, 6426.453751430994, 6430.067640192239, 6434.0], "unit": "score", "name": "mootools.html", "value": 4333.594490490677}, {"lowerIsBetter": false, "replicates": [338.71040260577206, 342.0593368237347, 344.5555233748465, 346.923676791106, 347.77394693449264, 5830.3586605473365, 5888.293404791426, 5902.468777809996, 5930.377310382407, 5982.491488223506, 5709.143628455734, 5889.263842019747, 5902.527797776178, 5909.409059094089, 5971.910421343683, 4582.1064892346, 4585.403897493321, 4588.380568623244, 4591.035882464686, 4591.747453890035, 4326.502452218004, 4398.164348773723, 4500.932486012713, 4567.794449249775, 4588.885277868063, 4474.865754027384, 4505.684602077856, 4519.4124763780665, 4523.841665541707, 4527.479339875924, 4512.9097418051615, 4530.66020048496, 4565.338025986247, 4572.657050721176, 4586.701864378805, 4055.188962207541, 4056.1684854604737, 4061.0862555924978, 4067.796610169509, 4068.084680946793, 5489.752961116759, 5620.185073164409, 5622.8313150605545, 5629.437056294379, 5645.745941432604, 5240.34495688039, 5257.237700533401, 5265.499332690165, 5266.894662106736, 5277.47225277473, 5998.190244317005, 6291.276503202144, 6295.213098362705, 6299.9370006299805, 6300.991841305415, 4287.785610719483, 4289.678274129422, 4371.191329604034, 4388.144311859189, 4402.163588918127, 6422.26143993442, 6510.93489065108, 6519.282878883319, 6519.837004074889, 6524.543281970216, 4492.865214043584, 4498.077894031716, 4498.640108791289, 4500.752458614742, 4501.7974191161475, 4417.712848664826, 4542.750148741785, 4547.272436410159, 4549.45406551216, 4580.4045474088825, 5234.110201265794, 5234.7906083756225, 5242.633015688942, 5243.292155559027, 5260.579153667697, 6255.937440625627, 6262.843428914222, 6263.467605253604, 6267.091271765568, 6281.555242294298, 1575.220265968353, 1603.871690264776, 1604.5587463447646, 1606.983930160707, 1609.8470645288678, 1063.5905176507101, 1069.1286601419818, 1071.132382769959, 1083.1118482843992, 1097.2703152403562, 6027.939720602825, 6029.276486821609, 6035.245594300713, 6035.547333949971, 6039.78860739872, 6422.967885160544, 6434.613923164625, 6436.292007879223, 6440.935590644033, 6481.28705842357, 5801.7099145042575, 5979.372165922602, 6004.6097003695495, 6019.69901504923, 6028.758849646053, 3455.9136021599156, 3514.262004978932, 3515.964840351615, 3516.2088530081037, 3518.1028837646236, 6647.700853461606, 6685.331466853373, 6695.531312808057, 6709.027191057269, 6715.328467153246, 6573.704183311763, 6577.309382514863, 6586.8353291168105, 6593.044008618724, 6602.9009564855605, 6541.901871471931, 6696.531242812956, 6710.664466776641, 6720.025596288511, 6723.294054124344, 6343.270523889627, 6458.063580780855, 6462.644554549545, 6464.030395440722, 6468.126802881551, 6280.685965701605, 6437.517186210959, 6454.419102280817, 6472.967635161794, 6479.870402592016, 6685.130932978682, 6697.129373181455, 6697.497687673346, 6698.531102822755, 6699.966500167663, 4361.149575832682, 4534.183846907456, 4545.272756358967, 4546.522615125365, 4549.909001820011, 6366.204224471941, 6389.9680501597195, 6404.071409645669, 6420.454261387835, 6423.132877061536, 6253.5622506424115, 6254.093156492374, 6262.123302737529, 6286.685665716787, 6326.019466982625, 6206.906896396467, 6239.844003899939, 6247.812565623039, 6252.843678907881, 6254.312025677263, 6197.101420294122, 6234.127222188988, 6242.906356404748, 6245.281792593728, 6257.624542527463, 6366.363363663597, 6396.968015159894, 6410.391012853772, 6411.51913606472, 6413.262474815269, 6138.969305153446, 6219.844503887439, 6230.6884655767935, 6253.6560489173535, 6253.937460625518], "unit": "score", "name": "prototype.html", "value": 4749.286831888048}, {"lowerIsBetter": false, "replicates": [755.9697612095516, 770.8381239939614, 807.7778610882007, 815.3762371785581, 884.4825776920501, 13578.321083945813, 13819.861801381983, 13828.17030978142, 13829.861701382983, 13871.861281387182, 13125.606231813037, 13203.0, 13220.40508177132, 13240.602781916534, 13262.270575118364, 679.9694013769392, 680.9387155156035, 819.5533434278303, 828.2256090555335, 830.8421399934024, 833.4540875726409, 837.1461109668165, 838.0195171649154, 840.2857571064608, 840.8024114333127, 709.3899246647878, 877.9209871111599, 879.5909901895617, 879.9868001979976, 880.7357792662208, 709.1242315740056, 860.9354298427612, 873.4366333714751, 875.8773771671971, 878.3851304087165, 640.2317219336815, 646.8253571535658, 647.1974751308344, 647.4917190005823, 648.0473703655618, 12859.485620575166, 12988.935055324662, 13011.089223754341, 13014.0, 13061.412236449383, 11548.480318385693, 11610.6516804496, 11641.0, 12487.188332758342, 12543.56097536582, 9743.0, 10069.09378155962, 10090.9495452523, 10161.745956351077, 10251.53868075931, 3524.8766293179874, 3560.3235385276716, 3571.928561428757, 3581.3732596795717, 3711.183539621279, 43435.131297374195, 43764.12471750579, 43783.562164378585, 43970.90072748175, 44061.33907991383, 8829.823403532022, 9041.141091596288, 9125.726228213165, 9158.358914876027, 9216.493092879957, 16922.830771692126, 16928.57678558021, 16956.321747130223, 16961.745573816403, 17618.2071806769, 7489.588072656056, 7603.771886843404, 7729.227077292338, 7766.417518686121, 7783.066032076187, 4383.320585309282, 4446.510883802779, 4485.170243504962, 4517.88705282364, 4555.088982203572, 3063.0963865659237, 3080.122165182957, 3101.5347697845505, 3135.247540590242, 3136.1532386255585, 568.6019786149711, 570.3156212544963, 576.1674380520192, 577.4687287695331, 584.9824505264849, 535.8472835241937, 565.9292588426447, 573.2719446303255, 599.7301214453513, 619.3404024713666, 7893.802654933673, 8108.5540295283145, 8117.472364296302, 8202.794930126794, 8221.753347399588, 445.84618306684143, 457.04477641728283, 461.0387342391085, 562.8086450606813, 591.8254115036075, 3681.8711345102793, 3709.5919448860604, 3794.867179648699, 3874.9806250968563, 4233.470816147981, 44959.19742457099, 46577.53422465732, 49651.77959873379, 52143.478565214624, 53526.46473535215, 45832.0, 46702.29946550805, 46908.0, 47060.0, 47276.0, 42509.57490425056, 43478.130437391075, 44038.77980610076, 44214.99999999936, 44351.11297774027, 8058.194180581895, 8071.112177660335, 8233.094359620318, 8257.876131858147, 8337.166283371615, 33518.0, 33573.15347655804, 34181.82909085538, 34381.656183437844, 34490.13774655654, 38611.6138838608, 41411.37882931698, 42460.0, 43133.137337252454, 43247.0, 10392.324498907547, 10597.523111460157, 10648.201384896009, 10754.0, 11175.888241117485, 11069.225154239126, 11200.943995279971, 11239.494222759831, 11433.828492572451, 11458.19792614509, 10685.145188384755, 10706.143508519144, 10891.618793342195, 10932.836007460053, 11286.66140015801, 10379.377237365783, 10483.266171367932, 10587.788244235226, 10613.150947923994, 10942.343459392461, 7961.562114083549, 9398.2951278653, 10504.527296271533, 10517.263791534519, 10621.362718236931, 8976.0, 9411.764705882133, 9693.9030609693, 9702.846574863339, 9756.902430975599, 8707.303415726854, 8724.65101395937, 8728.127187281476, 8953.865692014495, 9279.62881484733], "unit": "score", "name": "yui.html", "value": 6034.615963480219}], "name": "dromaeo_css", "value": 6850.859614497204}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 105.0, 110.0, 110.0, 110.0, 97.0, 109.0, 110.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [161.0, 127.0, 154.0, 163.0, 133.0, 147.0, 149.0, 127.0, 175.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 159.0, 161.0, 161.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 88.0, 92.0, 71.0, 73.0, 70.0, 99.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 141.0, 96.0, 96.0, 96.0, 146.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 59.0, 59.0, 57.0, 58.0, 61.0, 67.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 84.0, 84.0, 85.0, 83.0, 85.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 116.0, 114.0, 127.0, 122.0, 119.0, 129.0, 116.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 152.0, 155.0, 152.0, 143.0, 154.0, 152.0, 158.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 69.0, 69.0, 66.0, 67.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1503.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [189.3580761219466], "unit": "score", "name": "DeltaBlue", "value": 349.16915799999987}, {"lowerIsBetter": false, "replicates": [281.0567734682406], "unit": "score", "name": "Encrypt", "value": 947.0719979999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26500.0], "unit": "score", "name": "RegExp", "value": 34.37679245283018}, {"lowerIsBetter": false, "replicates": [638.9776357827476], "unit": "score", "name": "Splay", "value": 127.53341499999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20846.797665992115}]} 13:16:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20846.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1503.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6850.86"}}} 13:16:18 INFO - Return code: 0 13:16:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:16:18 ERROR - # TBPL SUCCESS # 13:16:18 INFO - Running post-action listener: _resource_record_post_action 13:16:18 INFO - Running post-run listener: _resource_record_post_run 13:16:19 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546590720; Read time: 44; Write time: 918828 13:16:19 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 235409408; Read time: 0; Write time: 547032 13:16:19 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311181312; Read time: 44; Write time: 371796 13:16:19 INFO - Running post-run listener: _upload_blobber_files 13:16:19 INFO - Blob upload gear active. 13:16:19 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:16:19 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 13:16:19 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'] 13:16:19 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 13:16:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:20 INFO - (blobuploader) - INFO - Done attempting. 13:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:16:21 INFO - (blobuploader) - INFO - Done attempting. 13:16:21 INFO - (blobuploader) - INFO - Iteration through files over. 13:16:21 INFO - Return code: 0 13:16:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:16:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:16:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b50fcccb2a3e3e4f2e4722a70291ad1c81715523494a5a8faf9c257e437173c944a4d6e551e1c103f77684a1efafe829726e3a4f4c2a9c08a9d65ae749cd227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0dbf77c3e926a69cca37b1babfd9f86d74ea6a95897bfedc8907bd5a3d5b51230f31fbe24305c87138d8f72c214217f318a72babdfb4955e398f2b963fa3462"} 13:16:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:16:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:16:21 INFO - Contents: 13:16:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b50fcccb2a3e3e4f2e4722a70291ad1c81715523494a5a8faf9c257e437173c944a4d6e551e1c103f77684a1efafe829726e3a4f4c2a9c08a9d65ae749cd227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0dbf77c3e926a69cca37b1babfd9f86d74ea6a95897bfedc8907bd5a3d5b51230f31fbe24305c87138d8f72c214217f318a72babdfb4955e398f2b963fa3462"} 13:16:21 INFO - Copying logs to upload dir... 13:16:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.811380 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-23 13:16:21.116806) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 13:16:21.119842) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b50fcccb2a3e3e4f2e4722a70291ad1c81715523494a5a8faf9c257e437173c944a4d6e551e1c103f77684a1efafe829726e3a4f4c2a9c08a9d65ae749cd227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0dbf77c3e926a69cca37b1babfd9f86d74ea6a95897bfedc8907bd5a3d5b51230f31fbe24305c87138d8f72c214217f318a72babdfb4955e398f2b963fa3462"} build_url:https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011489 build_url: 'https://queue.taskcluster.net/v1/task/ffZXnqVPRfWrPlaSrqU9Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4b50fcccb2a3e3e4f2e4722a70291ad1c81715523494a5a8faf9c257e437173c944a4d6e551e1c103f77684a1efafe829726e3a4f4c2a9c08a9d65ae749cd227", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d0dbf77c3e926a69cca37b1babfd9f86d74ea6a95897bfedc8907bd5a3d5b51230f31fbe24305c87138d8f72c214217f318a72babdfb4955e398f2b963fa3462"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 13:16:21.143982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 13:16:21.144260) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1450904115.573306-473830261 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 13:16:21.228106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 13:16:21.228415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 13:16:21.228707) ========= ========= Total master_lag: 0.23 =========