builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1450442677.72 results: success (0) buildid: 20151218023001 builduid: b16d85f4677548ba8ad8b2ac084003a5 revision: 36f697d1307c0af010329aad2a0d5f37cad1f67f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.715504) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.715999) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.716304) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.751858) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.752204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.772936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.773295) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.822721) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.823007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.823357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:37.823680) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 04:44:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-18 04:44:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.016733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.017089) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013898 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.068684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.069132) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 36f697d1307c0af010329aad2a0d5f37cad1f67f --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/b2g-inbound --rev 36f697d1307c0af010329aad2a0d5f37cad1f67f --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 04:44:38,790 truncating revision to first 12 chars 2015-12-18 04:44:38,790 Setting DEBUG logging. 2015-12-18 04:44:38,790 attempt 1/10 2015-12-18 04:44:38,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/36f697d1307c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 04:44:39,045 unpacking tar archive at: b2g-inbound-36f697d1307c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568648 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.652521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.652982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.662102) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.662512) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 04:44:38.663006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 04:44:38.663319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:39 INFO - MultiFileLogger online at 20151218 04:44:39 in /builds/slave/test-pgo 04:44:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:44:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:44:39 INFO - {'append_to_log': False, 04:44:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:44:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:44:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:44:39 INFO - 'branch': 'B2G-Inbound', 04:44:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:39 INFO - 'config_files': ('talos/linux_config.py',), 04:44:39 INFO - 'default_actions': ('clobber', 04:44:39 INFO - 'read-buildbot-config', 04:44:39 INFO - 'download-and-extract', 04:44:39 INFO - 'populate-webroot', 04:44:39 INFO - 'create-virtualenv', 04:44:39 INFO - 'install', 04:44:39 INFO - 'run-tests'), 04:44:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:39 INFO - 'download_minidump_stackwalk': True, 04:44:39 INFO - 'download_symbols': 'ondemand', 04:44:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:39 INFO - 'installer_path': 'installer.exe', 04:44:39 INFO - 'log_level': 'info', 04:44:39 INFO - 'log_name': 'talos', 04:44:39 INFO - 'log_to_console': True, 04:44:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:39 INFO - 'opt_config_files': (), 04:44:39 INFO - 'pip_index': False, 04:44:39 INFO - 'sps_profile': False, 04:44:39 INFO - 'sps_profile_interval': 0, 04:44:39 INFO - 'suite': 'dromaeojs', 04:44:39 INFO - 'system_bits': '64', 04:44:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:39 INFO - 'title': 'talos-linux64-ix-035', 04:44:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:39 INFO - 'use_talos_json': True, 04:44:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:44:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:39 INFO - 'work_dir': 'build'} 04:44:39 INFO - ##### 04:44:39 INFO - ##### Running clobber step. 04:44:39 INFO - ##### 04:44:39 INFO - Running pre-action listener: _resource_record_pre_action 04:44:39 INFO - Running main action method: clobber 04:44:39 INFO - rmtree: /builds/slave/test-pgo/build 04:44:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:44:39 INFO - Running post-action listener: _resource_record_post_action 04:44:39 INFO - ##### 04:44:39 INFO - ##### Running read-buildbot-config step. 04:44:39 INFO - ##### 04:44:39 INFO - Running pre-action listener: _resource_record_pre_action 04:44:39 INFO - Running main action method: read_buildbot_config 04:44:39 INFO - Using buildbot properties: 04:44:39 INFO - { 04:44:39 INFO - "project": "", 04:44:39 INFO - "product": "firefox", 04:44:39 INFO - "script_repo_revision": "production", 04:44:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:44:39 INFO - "repository": "", 04:44:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:44:39 INFO - "buildid": "20151218023001", 04:44:39 INFO - "pgo_build": "True", 04:44:39 INFO - "basedir": "/builds/slave/test-pgo", 04:44:39 INFO - "buildnumber": 1066, 04:44:39 INFO - "slavename": "talos-linux64-ix-035", 04:44:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:44:39 INFO - "platform": "ubuntu64_hw", 04:44:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:44:39 INFO - "branch": "b2g-inbound", 04:44:39 INFO - "repo_path": "integration/b2g-inbound", 04:44:39 INFO - "revision": "36f697d1307c0af010329aad2a0d5f37cad1f67f", 04:44:39 INFO - "stage_platform": "linux64-pgo", 04:44:39 INFO - "builduid": "b16d85f4677548ba8ad8b2ac084003a5", 04:44:39 INFO - "slavebuilddir": "test" 04:44:39 INFO - } 04:44:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:44:39 INFO - Running post-action listener: _resource_record_post_action 04:44:39 INFO - ##### 04:44:39 INFO - ##### Running download-and-extract step. 04:44:39 INFO - ##### 04:44:39 INFO - Running pre-action listener: _resource_record_pre_action 04:44:39 INFO - Running main action method: download_and_extract 04:44:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:44:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:39 INFO - https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:44:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/test_packages.json 04:44:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/test_packages.json 04:44:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:44:43 INFO - Downloaded 1302 bytes. 04:44:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:44:43 INFO - Using the following test package requirements: 04:44:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'jsshell-linux-x86_64.zip'], 04:44:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:44:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:44:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44: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')]} 04:44:43 INFO - https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:44 INFO - Downloaded 23119638 bytes. 04:44:44 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 04:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:44 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 04:44:45 INFO - Return code: 0 04:44:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:45 INFO - https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:52 INFO - Downloaded 23119638 bytes. 04:44:52 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 04:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:44:52 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 04:44:53 INFO - Return code: 0 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:53 INFO - https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:44:54 INFO - Downloaded 11132039 bytes. 04:44:54 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 04:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:54 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 04:44:54 INFO - Return code: 0 04:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:54 INFO - https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:44:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:44:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:44:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:44:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:44:56 INFO - Downloaded 54653393 bytes. 04:44:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:44:56 INFO - mkdir: /builds/slave/test-pgo/properties 04:44:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:44:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:44:56 INFO - Contents: 04:44:56 INFO - build_url:https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:44:56 INFO - Running post-action listener: _resource_record_post_action 04:44:56 INFO - Running post-action listener: set_extra_try_arguments 04:44:56 INFO - ##### 04:44:56 INFO - ##### Running populate-webroot step. 04:44:56 INFO - ##### 04:44:56 INFO - Running pre-action listener: _resource_record_pre_action 04:44:56 INFO - Running main action method: populate_webroot 04:44:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:56 INFO - '--tppagecycles', 04:44:56 INFO - '7'], 04:44:56 INFO - 'tests': ['tsvgm']}}, 04:44:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:44:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:44:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:44:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'tests': ['damp', 'tps']}, 04:44:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['damp', 'tps']}, 04:44:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:44:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:56 INFO - 'other': {'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'other_l64': {'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'other_nol64': {'tests': ['a11yr', 04:44:56 INFO - 'ts_paint', 04:44:56 INFO - 'tpaint', 04:44:56 INFO - 'sessionrestore', 04:44:56 INFO - 'sessionrestore_no_auto_restore']}, 04:44:56 INFO - 'svgr': {'tests': ['tsvgx', 04:44:56 INFO - 'tsvgr_opacity', 04:44:56 INFO - 'tart', 04:44:56 INFO - 'tscrollx', 04:44:56 INFO - 'cart']}, 04:44:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['tsvgx', 04:44:56 INFO - 'tsvgr_opacity', 04:44:56 INFO - 'tart', 04:44:56 INFO - 'tscrollx', 04:44:56 INFO - 'cart']}, 04:44:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'tests': ['tp5o']}, 04:44:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'talos_options': ['--e10s'], 04:44:56 INFO - 'tests': ['tp5o']}, 04:44:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'talos_options': ['--xperf_path', 04:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:56 INFO - 'tests': ['tp5n']}, 04:44:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:56 INFO - 'talos_options': ['--e10s', 04:44:56 INFO - '--xperf_path', 04:44:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:56 INFO - 'tests': ['tp5n']}}, 04:44:56 INFO - 'talos.zip': {'path': '', 04:44:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:56 INFO - Running post-action listener: _resource_record_post_action 04:44:56 INFO - ##### 04:44:56 INFO - ##### Running create-virtualenv step. 04:44:56 INFO - ##### 04:44:56 INFO - Running pre-action listener: _resource_record_pre_action 04:44:56 INFO - Running main action method: create_virtualenv 04:44:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:44:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 04:44:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:44:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:56 INFO - Using real prefix '/usr' 04:44:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:44:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:58 INFO - Installing pip.................done. 04:44:58 INFO - Return code: 0 04:44:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:58 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 04:44:58 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 04:44:58 INFO - Using env: {'DISPLAY': ':0', 04:44:58 INFO - 'HOME': '/home/cltbld', 04:44:58 INFO - 'LANG': 'en_US.UTF-8', 04:44:58 INFO - 'LANGUAGE': 'en_US:en', 04:44:58 INFO - 'LOGNAME': 'cltbld', 04:44:58 INFO - 'MAIL': '/var/mail/cltbld', 04:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:58 INFO - 'MOZ_NO_REMOTE': '1', 04:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:58 INFO - 'NO_EM_RESTART': '1', 04:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:44:58 INFO - 'SHELL': '/bin/bash', 04:44:58 INFO - 'SHLVL': '1', 04:44:58 INFO - 'TERM': 'linux', 04:44:58 INFO - 'TMOUT': '86400', 04:44:58 INFO - 'USER': 'cltbld', 04:44:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:58 INFO - '_': '/tools/buildbot/bin/python'} 04:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:44:58 INFO - Cleaning up... 04:44:58 INFO - Return code: 0 04:44:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:44:58 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 04:44:58 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 04:44:58 INFO - Using env: {'DISPLAY': ':0', 04:44:58 INFO - 'HOME': '/home/cltbld', 04:44:58 INFO - 'LANG': 'en_US.UTF-8', 04:44:58 INFO - 'LANGUAGE': 'en_US:en', 04:44:58 INFO - 'LOGNAME': 'cltbld', 04:44:58 INFO - 'MAIL': '/var/mail/cltbld', 04:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:58 INFO - 'MOZ_NO_REMOTE': '1', 04:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:58 INFO - 'NO_EM_RESTART': '1', 04:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:44:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:44:58 INFO - 'SHELL': '/bin/bash', 04:44:58 INFO - 'SHLVL': '1', 04:44:58 INFO - 'TERM': 'linux', 04:44:58 INFO - 'TMOUT': '86400', 04:44:58 INFO - 'USER': 'cltbld', 04:44:58 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:58 INFO - '_': '/tools/buildbot/bin/python'} 04:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:59 INFO - Downloading/unpacking psutil>=0.7.1 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:45:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:45:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:00 INFO - Installing collected packages: psutil 04:45:00 INFO - Running setup.py install for psutil 04:45:01 INFO - building 'psutil._psutil_linux' extension 04:45:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:45:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:45:01 INFO - building 'psutil._psutil_posix' extension 04:45:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:45:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:01 INFO - Successfully installed psutil 04:45:01 INFO - Cleaning up... 04:45:01 INFO - Return code: 0 04:45:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:01 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:01 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 04:45:01 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 04:45:01 INFO - Using env: {'DISPLAY': ':0', 04:45:01 INFO - 'HOME': '/home/cltbld', 04:45:01 INFO - 'LANG': 'en_US.UTF-8', 04:45:01 INFO - 'LANGUAGE': 'en_US:en', 04:45:01 INFO - 'LOGNAME': 'cltbld', 04:45:01 INFO - 'MAIL': '/var/mail/cltbld', 04:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:01 INFO - 'MOZ_NO_REMOTE': '1', 04:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:01 INFO - 'NO_EM_RESTART': '1', 04:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:01 INFO - 'SHELL': '/bin/bash', 04:45:01 INFO - 'SHLVL': '1', 04:45:01 INFO - 'TERM': 'linux', 04:45:01 INFO - 'TMOUT': '86400', 04:45:01 INFO - 'USER': 'cltbld', 04:45:01 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:01 INFO - '_': '/tools/buildbot/bin/python'} 04:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:45:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:45:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:45:03 INFO - Installing collected packages: mozsystemmonitor 04:45:03 INFO - Running setup.py install for mozsystemmonitor 04:45:03 INFO - Successfully installed mozsystemmonitor 04:45:03 INFO - Cleaning up... 04:45:03 INFO - Return code: 0 04:45:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:03 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 04:45:03 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 04:45:03 INFO - Using env: {'DISPLAY': ':0', 04:45:03 INFO - 'HOME': '/home/cltbld', 04:45:03 INFO - 'LANG': 'en_US.UTF-8', 04:45:03 INFO - 'LANGUAGE': 'en_US:en', 04:45:03 INFO - 'LOGNAME': 'cltbld', 04:45:03 INFO - 'MAIL': '/var/mail/cltbld', 04:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:03 INFO - 'MOZ_NO_REMOTE': '1', 04:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:03 INFO - 'NO_EM_RESTART': '1', 04:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:03 INFO - 'SHELL': '/bin/bash', 04:45:03 INFO - 'SHLVL': '1', 04:45:03 INFO - 'TERM': 'linux', 04:45:03 INFO - 'TMOUT': '86400', 04:45:03 INFO - 'USER': 'cltbld', 04:45:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:03 INFO - '_': '/tools/buildbot/bin/python'} 04:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:45:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:45:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:06 INFO - Downloading docopt-0.6.1.tar.gz 04:45:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:45:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:06 INFO - Running setup.py install for blobuploader 04:45:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:45:06 INFO - Running setup.py install for requests 04:45:06 INFO - Running setup.py install for docopt 04:45:06 INFO - Successfully installed blobuploader requests docopt 04:45:06 INFO - Cleaning up... 04:45:06 INFO - Return code: 0 04:45:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:06 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:06 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 04:45:06 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 04:45:06 INFO - Using env: {'DISPLAY': ':0', 04:45:06 INFO - 'HOME': '/home/cltbld', 04:45:06 INFO - 'LANG': 'en_US.UTF-8', 04:45:06 INFO - 'LANGUAGE': 'en_US:en', 04:45:06 INFO - 'LOGNAME': 'cltbld', 04:45:06 INFO - 'MAIL': '/var/mail/cltbld', 04:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:06 INFO - 'MOZ_NO_REMOTE': '1', 04:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:06 INFO - 'NO_EM_RESTART': '1', 04:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:06 INFO - 'SHELL': '/bin/bash', 04:45:06 INFO - 'SHLVL': '1', 04:45:06 INFO - 'TERM': 'linux', 04:45:06 INFO - 'TMOUT': '86400', 04:45:06 INFO - 'USER': 'cltbld', 04:45:06 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:06 INFO - '_': '/tools/buildbot/bin/python'} 04:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:06 INFO - Running setup.py (path:/tmp/pip-7E77yi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:07 INFO - Running setup.py (path:/tmp/pip-AkXjhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:07 INFO - Running setup.py (path:/tmp/pip-DTtia8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:07 INFO - Running setup.py (path:/tmp/pip-rJXPT1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:07 INFO - Running setup.py (path:/tmp/pip-7JWiQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:07 INFO - Running setup.py (path:/tmp/pip-imYwFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:07 INFO - Running setup.py (path:/tmp/pip-JkQorO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:07 INFO - Running setup.py (path:/tmp/pip-1JrCMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:07 INFO - Running setup.py (path:/tmp/pip-FOJPtc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:07 INFO - Running setup.py (path:/tmp/pip-Q3vwZ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:07 INFO - Running setup.py (path:/tmp/pip-MI8vf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:07 INFO - Running setup.py (path:/tmp/pip-GUucLc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:07 INFO - Running setup.py (path:/tmp/pip-efq094-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:07 INFO - Running setup.py (path:/tmp/pip-CMLa5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:08 INFO - Running setup.py (path:/tmp/pip-7eKPWv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:08 INFO - Running setup.py (path:/tmp/pip-pVh_LA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:08 INFO - Running setup.py (path:/tmp/pip-zXQ2fg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:08 INFO - Running setup.py install for manifestparser 04:45:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:45:08 INFO - Running setup.py install for mozcrash 04:45:08 INFO - Running setup.py install for mozdebug 04:45:08 INFO - Running setup.py install for mozdevice 04:45:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:45:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:45:08 INFO - Running setup.py install for mozfile 04:45:08 INFO - Running setup.py install for mozhttpd 04:45:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:45:08 INFO - Running setup.py install for mozinfo 04:45:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:45:08 INFO - Running setup.py install for mozInstall 04:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Running setup.py install for mozleak 04:45:09 INFO - Running setup.py install for mozlog 04:45:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Running setup.py install for moznetwork 04:45:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Running setup.py install for mozprocess 04:45:09 INFO - Running setup.py install for mozprofile 04:45:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Running setup.py install for mozrunner 04:45:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:45:09 INFO - Running setup.py install for mozscreenshot 04:45:09 INFO - Running setup.py install for moztest 04:45:09 INFO - Running setup.py install for mozversion 04:45:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:10 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 04:45:10 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 04:45:10 INFO - Using env: {'DISPLAY': ':0', 04:45:10 INFO - 'HOME': '/home/cltbld', 04:45:10 INFO - 'LANG': 'en_US.UTF-8', 04:45:10 INFO - 'LANGUAGE': 'en_US:en', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MAIL': '/var/mail/cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SHLVL': '1', 04:45:10 INFO - 'TERM': 'linux', 04:45:10 INFO - 'TMOUT': '86400', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - '_': '/tools/buildbot/bin/python'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:10 INFO - Running setup.py (path:/tmp/pip-9Q6zhq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:10 INFO - Running setup.py (path:/tmp/pip-x9rNwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:10 INFO - Running setup.py (path:/tmp/pip-A4ei8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:10 INFO - Running setup.py (path:/tmp/pip-mbp7WA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:45:10 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)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:10 INFO - Running setup.py (path:/tmp/pip-xebdGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:10 INFO - Running setup.py (path:/tmp/pip-8g5FwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:10 INFO - Running setup.py (path:/tmp/pip-q5tQLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:10 INFO - Running setup.py (path:/tmp/pip-h19cSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:10 INFO - Running setup.py (path:/tmp/pip-ZTJqUa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:10 INFO - Running setup.py (path:/tmp/pip-GKpPhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:10 INFO - Running setup.py (path:/tmp/pip-a60uAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:11 INFO - Running setup.py (path:/tmp/pip-WUAKLm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:11 INFO - Running setup.py (path:/tmp/pip-mjcphx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:11 INFO - Running setup.py (path:/tmp/pip-MlLBy8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:11 INFO - Running setup.py (path:/tmp/pip-D01f6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:11 INFO - Running setup.py (path:/tmp/pip-VWRp6u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 04:45:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:11 INFO - Running setup.py (path:/tmp/pip-GBXxet-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 04:45:11 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)) 04:45:11 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)) 04:45:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:13 INFO - Downloading blessings-1.5.1.tar.gz 04:45:13 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 04:45:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:13 INFO - Installing collected packages: blessings 04:45:13 INFO - Running setup.py install for blessings 04:45:13 INFO - Successfully installed blessings 04:45:13 INFO - Cleaning up... 04:45:13 INFO - Return code: 0 04:45:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:45:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:45:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:45:13 INFO - Reading from file tmpfile_stdout 04:45:13 INFO - Current package versions: 04:45:13 INFO - argparse == 1.2.1 04:45:13 INFO - blessings == 1.5.1 04:45:13 INFO - blobuploader == 1.2.4 04:45:13 INFO - docopt == 0.6.1 04:45:13 INFO - manifestparser == 1.1 04:45:13 INFO - mozInstall == 1.12 04:45:13 INFO - mozcrash == 0.16 04:45:13 INFO - mozdebug == 0.1 04:45:13 INFO - mozdevice == 0.47 04:45:13 INFO - mozfile == 1.2 04:45:13 INFO - mozhttpd == 0.7 04:45:13 INFO - mozinfo == 0.9 04:45:13 INFO - mozleak == 0.1 04:45:13 INFO - mozlog == 3.1 04:45:13 INFO - moznetwork == 0.27 04:45:13 INFO - mozprocess == 0.22 04:45:13 INFO - mozprofile == 0.27 04:45:13 INFO - mozrunner == 6.11 04:45:13 INFO - mozscreenshot == 0.1 04:45:13 INFO - mozsystemmonitor == 0.0 04:45:13 INFO - moztest == 0.7 04:45:13 INFO - mozversion == 1.4 04:45:13 INFO - psutil == 3.1.1 04:45:13 INFO - requests == 1.2.3 04:45:13 INFO - wsgiref == 0.1.2 04:45:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:13 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:13 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 04:45:13 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 04:45:13 INFO - Using env: {'DISPLAY': ':0', 04:45:13 INFO - 'HOME': '/home/cltbld', 04:45:13 INFO - 'LANG': 'en_US.UTF-8', 04:45:13 INFO - 'LANGUAGE': 'en_US:en', 04:45:13 INFO - 'LOGNAME': 'cltbld', 04:45:13 INFO - 'MAIL': '/var/mail/cltbld', 04:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:13 INFO - 'MOZ_NO_REMOTE': '1', 04:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:13 INFO - 'NO_EM_RESTART': '1', 04:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:13 INFO - 'SHELL': '/bin/bash', 04:45:13 INFO - 'SHLVL': '1', 04:45:13 INFO - 'TERM': 'linux', 04:45:13 INFO - 'TMOUT': '86400', 04:45:13 INFO - 'USER': 'cltbld', 04:45:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:13 INFO - '_': '/tools/buildbot/bin/python'} 04:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:13 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 1)) 04:45:13 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 2)) 04:45:13 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 3)) 04:45:13 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 4)) 04:45:13 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 5)) 04:45:13 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 6)) 04:45:13 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 7)) 04:45:13 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 8)) 04:45:13 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:45:13 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 3)) 04:45:13 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 04:45:13 INFO - Cleaning up... 04:45:13 INFO - Return code: 0 04:45:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:13 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:13 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 04:45:13 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 04:45:13 INFO - Using env: {'DISPLAY': ':0', 04:45:13 INFO - 'HOME': '/home/cltbld', 04:45:13 INFO - 'LANG': 'en_US.UTF-8', 04:45:13 INFO - 'LANGUAGE': 'en_US:en', 04:45:13 INFO - 'LOGNAME': 'cltbld', 04:45:13 INFO - 'MAIL': '/var/mail/cltbld', 04:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:13 INFO - 'MOZ_NO_REMOTE': '1', 04:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:13 INFO - 'NO_EM_RESTART': '1', 04:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:13 INFO - 'SHELL': '/bin/bash', 04:45:13 INFO - 'SHLVL': '1', 04:45:13 INFO - 'TERM': 'linux', 04:45:13 INFO - 'TMOUT': '86400', 04:45:13 INFO - 'USER': 'cltbld', 04:45:13 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:13 INFO - '_': '/tools/buildbot/bin/python'} 04:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:14 INFO - Downloading/unpacking jsonschema 04:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:15 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 04:45:15 INFO - Downloading/unpacking functools32 (from jsonschema) 04:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:45:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:15 INFO - warning: no files found matching '*.txt' 04:45:15 INFO - no previously-included directories found matching 'build' 04:45:15 INFO - no previously-included directories found matching 'dist' 04:45:15 INFO - no previously-included directories found matching '.git*' 04:45:15 INFO - Installing collected packages: jsonschema, functools32 04:45:16 INFO - Running setup.py install for functools32 04:45:16 INFO - warning: no files found matching '*.txt' 04:45:16 INFO - no previously-included directories found matching 'build' 04:45:16 INFO - no previously-included directories found matching 'dist' 04:45:16 INFO - no previously-included directories found matching '.git*' 04:45:16 INFO - Successfully installed jsonschema functools32 04:45:16 INFO - Cleaning up... 04:45:16 INFO - Return code: 0 04:45:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:16 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 0x7f613cdadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f95600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:45:16 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 04:45:16 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 04:45:16 INFO - Using env: {'DISPLAY': ':0', 04:45:16 INFO - 'HOME': '/home/cltbld', 04:45:16 INFO - 'LANG': 'en_US.UTF-8', 04:45:16 INFO - 'LANGUAGE': 'en_US:en', 04:45:16 INFO - 'LOGNAME': 'cltbld', 04:45:16 INFO - 'MAIL': '/var/mail/cltbld', 04:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:16 INFO - 'MOZ_NO_REMOTE': '1', 04:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:16 INFO - 'NO_EM_RESTART': '1', 04:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:16 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:16 INFO - 'SHELL': '/bin/bash', 04:45:16 INFO - 'SHLVL': '1', 04:45:16 INFO - 'TERM': 'linux', 04:45:16 INFO - 'TMOUT': '86400', 04:45:16 INFO - 'USER': 'cltbld', 04:45:16 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:16 INFO - '_': '/tools/buildbot/bin/python'} 04:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:16 INFO - Downloading/unpacking flake8 04:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:45:18 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 04:45:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:45:18 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 04:45:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 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 04:45:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:45:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:18 INFO - no previously-included directories found matching 'docs/_build' 04:45:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:45:18 INFO - Running setup.py install for pep8 04:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:45:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:45:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:45:18 INFO - no previously-included directories found matching 'docs/_build' 04:45:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:45:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:45:18 INFO - Cleaning up... 04:45:18 INFO - Return code: 0 04:45:18 INFO - Running post-action listener: _resource_record_post_action 04:45:18 INFO - Running post-action listener: _start_resource_monitoring 04:45:18 INFO - Starting resource monitoring. 04:45:18 INFO - ##### 04:45:18 INFO - ##### Running install step. 04:45:18 INFO - ##### 04:45:18 INFO - Running pre-action listener: _resource_record_pre_action 04:45:18 INFO - Running main action method: install 04:45:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:45:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:45:19 INFO - Reading from file tmpfile_stdout 04:45:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:45:19 INFO - Reading from file tmpfile_stdout 04:45:19 INFO - Output received: 04:45:19 INFO - Usage: mozinstall [options] installer 04:45:19 INFO - Options: 04:45:19 INFO - -h, --help show this help message and exit 04:45:19 INFO - -d DEST, --destination=DEST 04:45:19 INFO - Directory to install application into. [default: 04:45:19 INFO - "/builds/slave/test-pgo"] 04:45:19 INFO - --app=APP Application being installed. [default: firefox] 04:45:19 INFO - mkdir: /builds/slave/test-pgo/build/application 04:45:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:45:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:45:35 INFO - Reading from file tmpfile_stdout 04:45:35 INFO - Output received: 04:45:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:45:35 INFO - Running post-action listener: _resource_record_post_action 04:45:35 INFO - ##### 04:45:35 INFO - ##### Running run-tests step. 04:45:35 INFO - ##### 04:45:35 INFO - Running pre-action listener: _resource_record_pre_action 04:45:35 INFO - Running main action method: run_tests 04:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:45:35 INFO - Python 2.7.3 04:45:35 INFO - Return code: 0 04:45:35 INFO - grabbing minidump binary from tooltool 04:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:45:35 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 0x2024350>, '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 0x2025250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20256e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:45:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 04:45:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:45:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:35 INFO - Return code: 0 04:45:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:45:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:45:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:45:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:45:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:45:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:45:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:45:36 INFO - Return code: 0 04:45:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:45:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 04:45:36 INFO - Using env: {'DISPLAY': ':0', 04:45:36 INFO - 'HOME': '/home/cltbld', 04:45:36 INFO - 'LANG': 'en_US.UTF-8', 04:45:36 INFO - 'LANGUAGE': 'en_US:en', 04:45:36 INFO - 'LOGNAME': 'cltbld', 04:45:36 INFO - 'MAIL': '/var/mail/cltbld', 04:45:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:45:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:36 INFO - 'MOZ_NO_REMOTE': '1', 04:45:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:36 INFO - 'NO_EM_RESTART': '1', 04:45:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:45:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:45:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:45:36 INFO - 'SHELL': '/bin/bash', 04:45:36 INFO - 'SHLVL': '1', 04:45:36 INFO - 'TERM': 'linux', 04:45:36 INFO - 'TMOUT': '86400', 04:45:36 INFO - 'USER': 'cltbld', 04:45:36 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952', 04:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:36 INFO - '_': '/tools/buildbot/bin/python'} 04:45:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 04:45:36 INFO - mozversion INFO | application_buildid: 20151218023001 04:45:36 INFO - mozversion INFO | application_changeset: 36f697d1307c0af010329aad2a0d5f37cad1f67f 04:45:36 INFO - mozversion INFO | application_display_name: Nightly 04:45:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:36 INFO - mozversion INFO | application_name: Firefox 04:45:36 INFO - mozversion INFO | application_remotingname: firefox 04:45:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:45:36 INFO - mozversion INFO | application_vendor: Mozilla 04:45:36 INFO - mozversion INFO | application_version: 46.0a1 04:45:36 INFO - mozversion INFO | platform_buildid: 20151218023001 04:45:36 INFO - mozversion INFO | platform_changeset: 36f697d1307c0af010329aad2a0d5f37cad1f67f 04:45:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:45:36 INFO - mozversion INFO | platform_version: 46.0a1 04:45:36 INFO - 2015-12-18 04:45:36,228 DEBUG : using testdate: 1450442736 04:45:36 INFO - 2015-12-18 04:45:36,228 DEBUG : actual date: 1450442736 04:45:36 INFO - 2015-12-18 04:45:36,316 INFO : starting webserver on 'localhost:40770' 04:45:36 INFO - 2015-12-18 04:45:36,317 INFO : Starting test suite talos-linux64-ix-035 04:45:36 INFO - 2015-12-18 04:45:36,317 INFO : Starting test dromaeo_css 04:45:36 INFO - 2015-12-18 04:45:36,317 DEBUG : operating with platform_type : linux_ 04:45:36 INFO - 2015-12-18 04:45:36,318 INFO : Initialising browser for dromaeo_css test... 04:45:36 INFO - 2015-12-18 04:45:36,332 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUyfsGU/profile http://localhost:40770/getInfo.html 04:45:40 INFO - 2015-12-18 04:45:40,495 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:40 INFO - 2015-12-18 04:45:40,495 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:40 INFO - 2015-12-18 04:45:40,495 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:40 INFO - 2015-12-18 04:45:40,495 DEBUG : BROWSER_OUTPUT: __metrics 04:45:40 INFO - 2015-12-18 04:45:40,612 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:45:40 INFO - 2015-12-18 04:45:40,660 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:41 INFO - 2015-12-18 04:45:41,551 INFO : Browser initialized. 04:45:41 INFO - 2015-12-18 04:45:41,551 INFO : Running cycle 1/1 for dromaeo_css test... 04:45:41 INFO - 2015-12-18 04:45:41,552 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUyfsGU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:45:53 INFO - 2015-12-18 04:45:53,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 149696512 04:45:53 INFO - 2015-12-18 04:45:53,328 DEBUG : BROWSER_OUTPUT: 04:46:44 INFO - 2015-12-18 04:46:44,719 DEBUG : BROWSER_OUTPUT: 1450442804718 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:48:53 INFO - 2015-12-18 04:48:53,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40770/tests/dromaeo/cssquery-ext.html) 04:48:54 INFO - 2015-12-18 04:48:54,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 263057408 04:48:54 INFO - 2015-12-18 04:48:54,493 DEBUG : BROWSER_OUTPUT: 04:51:56 INFO - 2015-12-18 04:51:56,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-ext.html (next: http://localhost:40770/tests/dromaeo/cssquery-jquery.html) 04:51:57 INFO - 2015-12-18 04:51:57,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 229916672 04:51:57 INFO - 2015-12-18 04:51:57,436 DEBUG : BROWSER_OUTPUT: 04:54:59 INFO - 2015-12-18 04:54:59,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40770/tests/dromaeo/cssquery-mootools.html) 04:54:59 INFO - 2015-12-18 04:54:59,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 221282304 04:54:59 INFO - 2015-12-18 04:54:59,924 DEBUG : BROWSER_OUTPUT: 04:58:01 INFO - 2015-12-18 04:58:01,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40770/tests/dromaeo/cssquery-prototype.html) 04:58:02 INFO - 2015-12-18 04:58:02,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 208470016 04:58:02 INFO - 2015-12-18 04:58:02,351 DEBUG : BROWSER_OUTPUT: 05:01:04 INFO - 2015-12-18 05:01:04,853 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40770/tests/dromaeo/cssquery-yui.html) 05:01:05 INFO - 2015-12-18 05:01:05,422 DEBUG : BROWSER_OUTPUT: RSS: Main: 215060480 05:01:05 INFO - 2015-12-18 05:01:05,422 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/dromaeo/cssquery-yui.html (next: http://localhost:40770/tests/dromaeo/cssquery-dojo.html) 05:04:08 INFO - 2015-12-18 05:04:08,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 249303040 05:04:08 INFO - 2015-12-18 05:04:08,594 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,595 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:04:08 INFO - 2015-12-18 05:04:08,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:04:08 INFO - 2015-12-18 05:04:08,595 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:04:08 INFO - 2015-12-18 05:04:08,595 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:04:08 INFO - 2015-12-18 05:04:08,596 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3118.9844050779748;3162;3203.4233837909183;3206.070239630506;3230.9030729078127;5043.924341134886;5138.049460849746;5227.738613069346;5304.018756530045;5355.169948657959;5233.842984710455;5239.659422137558;5290.1800220965815;5296.390915044762;5339.652922560041;4767.4755776864695;4769;4778.426588809348;4964.354633897607;4971.030649023442;4902.632302577304;4913.066517361708;4981.676191047589;4989.800407983676;4992.525710057539;4653.441587009564;4719.433667959833;4783.28250762385;4823.638227132979;4836.032793441326;4863.19757240055;4867.561919427233;4874.341963834872;4879.072976134523;4909.140900342426;4795.328653988445;4822.276658501218;4830.033993201374;4867.36724225852;4893.0703166398625;4973.303737476756;5071.239314102877;5079.898402031976;5083.05963396769;5088.389393272794;5510.090835012218;5565.916511252334;5735.541156707453;5788.102844059177;5838.620489668158;5801.129830525413;5819.79630712923;5820.796272130455;5833.32916714579;5847.415258474161;5219.1388420910125;5438.945610543883;5439.347278326587;5448.536874365684;5451.781928722847;5645.463680950304;5731.942680573225;5735.4551317624755;5775.422457754275;5784.132380142928;5592.720363981784;5599.524040456526;5651.378348381675;5654.151877218368;5660.915086273709;5500.50495455411;5630.71846407678;5653.406392328829;5673.31920169574;5673.574481913873;5577.414371491016;5584.720763961785;5657.858553536194;5661.1508273758445;5698.259226300637;5614.101743720985;5615.522680572116;5622.297212848394;5633.690147041952;5642.097264437671;4300.397944287803;4347.7173983690955;4353.542877997765;4365.170617582649;4391.84628538006;3887.6501114899793;3919.8824035278985;3935.6064393560414;3958.5645578986287;3970.3448930926074;5275.155975044051;5331.306930099062;5344.251804747339;5350.30446042012;5353.357597088374;5484.972575137099;5593.077142271561;5726.9691455538405;5734.799282025109;5736.282964629421;5192.8961420771375;5218.060749065129;5238.345206849144;5259.868503287448;5286.81496147633;4912.533309335608;4954.628402869799;4956.430010548761;4966.354373931365;5011.448740638527;5475.808346707846;5606.411326810789;5757.280339957505;5767.279090113736;5777.711114444345;5618.915716264341;5739.167820666064;5824.970875145597;5827.8834423310445;5885.14665373527;5807.941920580909;5812.534997200299;5816.360200377871;5818.854528636818;5822.272215973004;5581.5813813963305;5659.547236221175;5660.179274005164;5662.178984047207;5694.430556944272;5649.971750141223;5701.714914254354;5709.743061562157;5716.42835716425;5744.798932037359;5599.776008959596;5619.634723742944;5644.548436125182;5645.491905728504;5649.322081350264;5302.8939421212135;5459.317585301837;5615.915761263666;5631.267935168402;5632.662040277432;5389.973050134881;5433.9456605435025;5444.373897001896;5446.809361672323;5484.341878974548;5597.244372009726;5649.802256920988;5676.262085928803;5683.147527870852;5731.541476681772;5317.548008419328;5420.186971954238;5426.186072089218;5554.2779438672715;5555.694436806015 05:04:08 INFO - 2015-12-18 05:04:08,600 DEBUG : BROWSER_OUTPUT: |1;ext.html;573.2547688005592;607.1924340626966;611.7491828350376;626.0734113512005;626.6428135962503;30317.848410757942;30816.38367232654;39081.60918390812;39687.206255874866;39737.8013109934;43492.565074349244;43888.12223755523;44040.119197616026;44060.3390949136;44119.55880441202;8675.52284624347;8832.514211718353;8834.072422395653;8834.73495795124;8836.779080522974;7777.261160189773;7955.443118981673;10090.495475226246;10180.745481362952;10238.436885971269;10211.48942552873;10309.84535231972;10314.638987635435;10340.121089707347;10368.377897326147;7551.886721699179;7679.500832445873;10078.697639070802;10159.441230732344;10159.89840101597;7496.212897645778;10258.692239232834;10651.520681569347;10680.679579612624;10697.251192416534;39930.40104398436;40586;40594;40595.18809623791;40638.59361406407;3277.7869438486423;3292.061762397729;3391.6777906098882;3411.403004474207;3660.0300920256154;29860.55209171864;30493.390132197455;30556;30662.693373066206;30933.0720078398;3825.052505101566;3856.7878766667823;3949.605039496056;4044.777537235451;4079.673626109904;253513;254416;254527;255126;393287;45427;56451.43548564544;57225;57226.7138664304;57315;59189.704051479464;59200;59272;59513;59514;13365.198088114745;13401.93299033518;13475.932620336836;13487.730245395234;13513.054086214068;10024.699259022242;10063.39619622825;10112.848307275397;10118.190544756402;10128;19271.51821204453;19483.610327793365;19585.706214406797;19600.411987640393;19610.215591376185;7706.7687969361;7924.286814186751;7929.405294602928;8024.839503209903;8060.314873235723;903.5662881816634;913.72588223534;979.9216062714966;1008.8890222075565;1072.5012869015945;28178.154655360373;28375.858120709265;28832.855835720686;28854.567181492293;28864;987.0721521769514;1001.1440218612981;1012.7721262715977;1019.9847002294972;1036.9785761025385;14619.342129604192;14810.111393316436;14829.480968166063;15117.16855572932;15130;302489;304428;306683;307158;307314;52130.739346303024;52357;52417.737911310964;52437;52437.47562524402;1127.718070482363;1253.4296894912793;1311.114997376767;1325.5426877727168;1328.3955800110925;21170.788292117497;29294.853525732236;29549.409011819214;30080.849595752756;30100.698993010665;48249.27626085541;48475.5152448471;48689.75655121702;48712.26931595958;48741;280005;282049;282360;288775;398533;30009;30010.3997920036;30172.09483715492;30372.392552149275;30529.54205686961;39899.80050099847;40365.1926961465;40559.797201013804;41261.58738412698;41564.58435415607;34123.14692132617;34347.14132146716;34473;34661.826690866386;35004.19966402733;34570.65429345674;35133.297334053685;35390.64609353874;35581.82209088938;35653;32179.839100805282;35166.472502911965;35322;35562.82218588891;35885.28229435449;28823.85588072046;29587.556186656788;29966.400671986874;30222.68771352353;30401.69598303989;24411.633825492987;24806.309764779442;24849.1302804401;25006.999720011725;25135.371615709755 05:04:08 INFO - 2015-12-18 05:04:08,600 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.86869858152505;357.61556326948505;359.30653838092474;362.5540585080351;365.9377905756022;14054.297285135728;14109.506167284122;16458.34166633335;16657.666846663076;17268.22292996815;10041.799164016715;12489.250644961308;13072.73854522909;14869.776953345681;15007.924960375183;4806.375171227744;4866.294387313837;4907.9263811042865;4911.484294149116;4912.38595175603;3623.7825730456125;4853.490383509734;4883.6337274704365;4884.096442158212;5538;5851.76592936282;5878.353381128072;5893.675847828367;5894.351621321651;5897.587168898157;5358.5981051421295;5361.651492652965;5361.812336568221;5394.406615272317;5851.180834683148;5101.540861322499;5120.974395128038;5121.385433747937;5128.282040514331;5132.692038477666;11828.940855295754;12616.558420455332;12632.68418289541;12638.810417843739;12640.873591264062;2016.5361966747585;2024.4230394337544;2055.4553043443498;2062.896855157251;2076.2317942361424;9266.58300376478;9347.672831450935;9426.387284826464;9518.809623807554;9601.567929443192;1821.480877949778;1885.4155211884222;1891.4547132550642;1902.9809701902943;1925.2010415677478;57455;59963.70018149881;60834.39165608332;61279.693601531704;61393.38606613921;9709.417434953926;9816.950915245521;9910.702678919644;9944.45305508204;9973.351732137533;12961.611151665466;12974.091813572959;12975.480980760663;12997.415116319788;13019;6910.7581234656545;6933.83464629585;6977.092977912839;7012.754553590702;7092.6099064551945;6500.674966251669;6515.120458738104;6562.917118675365;6595.670216489157;6638.17022872141;4224.070704445017;4228.217779710763;4241.936370954438;4248.893777655583;4255.702100852911;1622.8377162283678;1684.6967545841621;1712.546175263556;1726.266336806852;1754.885932414389;419.70410860343384;430.838435586655;446.89721364086444;938.9859152112724;977.8924318324979;9948.35335703177;10238.744031399274;10248.48757562119;10315.948420257851;10569.524371403306;423.927932251518;435.9928565014826;442.7343593843668;445.9598636122765;462.82875336125846;4350.630196433339;5765.913511297334;5833.154192642043;5843.590948633555;9620.807583848284;546323;549240;556875;558505;565197;80143;80354;80557;81201;81527.59236203782;1125.8705248896317;1127.1377396291844;1139.7093741096132;1140.560884059643;1143.2168964259674;15829.287682054104;15847.52457426279;15935.282912268744;16010.839891600936;16014.27935742871;32281.67718322787;32579.837100814344;33707.3258534823;33884.152896176805;34743;39157.2168556633;39464.60535394609;39834.800825995684;40453;40783.59216407798;9250.352475326663;9300.441973481613;9512.667056652985;9599.47202903847;9625;13770.65573360674;17344.826551734826;17454;17922.91038544851;17923.28306867763;11540.94229528847;11870.82193767077;13749.450021999008;13873.167609943435;14272.500462483764;13465.596032119052;13731.519396821062;13922.721545569235;14034.508792192224;14102.788458173341;14253.35859886287;14791.112533248039;14893.106413615218;15084.472043478425;15619.765703514684;7619.047619047619;7919.08930473003;9346.906530934875;9386.765330866783;9819.656312029045;11209.775804484028;13526.86473135256;13760.380782864595;14265.358058887583;14565.85434145645 05:04:08 INFO - 2015-12-18 05:04:08,600 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1440.6254373862794;1489.4935721854567;1536.385445821672;1599.5681166085158;1772.6100257943249;6771.424428923541;7259.092613423322;7383.372413344859;7424.591647459388;7428.182899881022;6957.61733104679;7207.711691532346;7208.855822883553;7220.133583969931;7233.385162261214;1922.0485859499497;1961.8724782889137;2135.7543882453483;2161.7622061573293;2176.7279090113734;2203.173809821317;2209.436593668612;2210.5357874846222;2216.7118274624277;2217.8780167090804;2126.829853611707;2185.104107316001;2189.704389907366;2192.440927563469;2193.035064571591;2163.816075633581;2183.792539708725;2183.825293976478;2186.04906865514;2214.723159605049;2186.147402513021;2189.0915270162864;2200.8899555022185;2201.3175915466095;2206.2829580386438;7609.201033891417;7692.730754423568;7699.461037727361;7708;7713.112992005935;4385.583369579885;4473.4408198975125;4478.820847166109;4484.282514797649;4489.169503641804;2994.5358469437274;3020.5620185073262;3036.3623639035827;3077.2306923269184;3123.1879711275233;983.6557204978201;1006.2101250518308;1011.9797604047877;1024.830902901028;1054.5834395413845;9882.209423246122;9983.550740216635;9984.650537231235;9993.10062094415;10019.448930308903;3972.7020473464027;4024;4054.5134583850127;4059.89850253746;4101.446304748881;8423.620937057847;8431.15688431152;8452.8732069019;8474.533900635524;8502.44734092282;4357.520672725997;4363.280058790264;4370.8033138508845;4380.69335146543;4384.386185933972;3902.9609703902597;3947.2500224957166;3949.2693851636964;3957.683385329167;3977.3835055566433;3197.6322722886703;3197.728193103566;3218.1632775478542;3233.4503134467195;3386.745994050456;1080.8216644253766;1093.6609651008214;1100.312304809494;1106.4910141335076;1109.778044391125;1003.693873368615;1025;1088.5156105532963;1313.4089659653193;1316.8683131686755;7039.803233450326;7044.894326585106;7046.541974771623;7046.612436316052;7130.572165670076;590.439082871274;597.250450684397;611.6360765344613;619.0992106485054;751.1587022534796;5560.7219639017885;5607.186957891165;5675.290588676416;5695.231143795618;5702.54379649627;8914.86627700585;9152.496612686233;9191.816163676689;9252.352335336596;9271.768205794775;8586.398952073296;8995.28037756991;9027.548622568846;9037.68368107113;9091.81816363669;7160.212376638566;7234.74678386254;7239.131304243419;7303.561786292733;7307.976883236457;7178.60517671533;7253.492255542062;7272.41820654357;7272.927270727225;7306.4885458017425;7931.405144614062;8165.550894700848;8213.055498617736;8219.712310069119;8346.499210047417;7747.612619368896;8365.163483651586;8391.035030971272;8494.57527123629;8570;7131;7199.028131202221;7264.128304603481;7269;7281;6122.602030868157;6195.783147589813;6196.690165491617;7035.05026821393;7383.704651813868;6847.897281540881;6883.724651013903;6962.825929351807;7017.649117544204;7032.648367581703;6778.186617605918;6784.423324017316;6859.382655561023;6945.965270173617;6965.303469652994;6979.057827193264;6989.26612705679;7012.50912436145;7026.8945965809535;7037.296270373126;6209.813705588839;6266.373362663697;6282.434580887742;6373.330800265905;6406.615603063831;6230.00319948806;6249.093881387083;6253.7185826637;6263.78076767311;6263.78076767311 05:04:08 INFO - 2015-12-18 05:04:08,601 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.70975396528036;332.27232361129126;340.75635920316967;341.5406278555345;349.16375281201505;5782.9879771040005;5813.389594092618;5850.356460789315;5897.823065308047;5916.142159386892;5631.63394379366;5777.19119323295;5779.335376431712;5807.680577568232;5841.824745257639;4554.180247555439;4583.1062942726185;4584.335271385664;4587.632989360844;4590.678652494326;4350.564943505656;4417.624501917341;4421.557844215585;4557.840475583355;4581.152486789938;4516.480604730449;4524.796384162721;4530.343100250462;4537.228671125917;4539.614132798716;4507.887302817423;4522.4346956630425;4522.9547704522865;4524.434445694288;4524.751138687371;3984.5218573771044;3986.681065514752;3990.6009399060154;3991.9201615967518;3993.28120938231;5393.460653934614;5574.136008918624;5592.356878958891;5596.496315331639;5626.324841019063;5265.210218467222;5265.736713164327;5271.341082364705;5274.578033757329;5275.155975044013;5902.852428689274;6244.313125556185;6249.312575616678;6250.312465628777;6250.749970001195;4228.344606585984;4265.594768497019;4386.780660966939;4389.846355377578;4389.912201755947;6434.260060093103;6476.838079047967;6487.286398496161;6493.805185844432;6512.869742605121;4390.05613793036;4407.713498622579;4409.757463339547;4411.338299255138;4412.977935110304;4457.108578284357;4460.821567137278;4471.731696098244;4473.261911784519;4506.301523263899;5196.9740151299;5202.557782588522;5208.0365132450615;5211.8175863845345;5211.921821172686;6269.498440124779;6271.843203919939;6275.184226050585;6277.121203031579;6283.622982621057;1580.826109127995;1603.446810850255;1606.2771752711094;1607.7909871716602;1608.6380564373158;1060.8833028366873;1062.3678911047914;1074.511097450658;1078.7087486378634;1090.4438736244413;5989.970050149808;5995.160677505153;5997.640141591519;6013.098035294741;6015.969920150371;6448.516361272923;6451.548391612542;6471.579347342407;6475.061116138134;6476.125723027331;5990.9700451497465;5994.910076348859;5998.400159983967;5999.970000150059;6000.639961602318;3418.1283772637817;3490.6683865032783;3502.9824850876093;3504.8247587620517;3506.8246587670515;6607;6619.702113404908;6646.401823835878;6646.800595982031;6648.700808463631;6716.093327400836;6722.731090756412;6727.327267273234;6731.49513786468;6735.797926062226;6490;6618.404343609098;6662.5003124765835;6672.065910772592;6674.23246326669;6231.158793562811;6420.1974753155855;6522;6524.412802847766;6537;6312.526560508072;6344.397282258363;6349.333320001518;6487.286398496256;6491;6633.767818126343;6654.633995130314;6668.06647069401;6669.666516674244;6677.76627818024;4439.62263207631;4451.643868490578;4476.641868650435;4478.664100192434;4491.124230774967;6372.139761132374;6390.520710946605;6451.516136289703;6471.902921456088;6475.805725828232;6294.244690637152;6302.306746257999;6303.684815759286;6311.621302721851;6313.084602732486;6175;6234.0025595904435;6279.843003924756;6280.905786413299;6283.183186185766;6148.200733904564;6154.692265386802;6155.1382806406245;6156.969215153896;6159.1377207190135;6291.874162516632;6295.811125666238;6297.086922396318;6300.243970723543;6300.495960323255;6037.027233545262;6125.84685382869;6141.293751218667;6156.753729850756;6157.1072194532435 05:04:08 INFO - 2015-12-18 05:04:08,602 DEBUG : BROWSER_OUTPUT: |5;yui.html;841.1336323586701;851.5401683091131;854.226924633207;861.2162931732125;879.8680197970303;13679.726405471885;13997.160170389783;14065.859341406584;14080.084794488352;14097.78853317201;13343.53297634583;13455.865441345584;13471.259080750579;13471.932640336809;13474.663133421669;674.1808702426563;680.2075581947025;820.1183727492939;821.57278215328;835.6490274084869;814.2752949874587;816.244973399606;821.2321479416764;821.9835603287961;822.5558198572763;707.8902770070647;870.1342164546286;875.2735229759317;875.5053394831931;876.5748611923212;709.3296834491408;851.9435899484656;863.0420233540796;871.398734872942;871.4640496094919;645.8417687666505;646.2923099206362;647.6340867409898;647.7311915555039;648.176815444383;13043.739125217537;13325.400356983959;13352.799708004388;13366.198028118344;13370.598882033555;11992.28046317215;12109.15235933485;12114.757704845853;12261.754764904741;12285.69285767854;10247.231457640706;10427.478626068667;10760.892391076068;10840.67477975662;10950.178736594708;3613.313470440608;3649.105969037603;3680.2455496623397;3768.1898391845884;3770.811459427018;45894.77052614749;47798;47806.760966195296;47826;47856.76071619619;9701.805963880683;9706.660266890625;10130.44282564466;10314.432706201082;10360.792784144274;17674.5581360467;17679.38122165718;17689.823101768816;17708.203130859143;17714;7471.327580517779;7500.62496875165;7538.585377804164;7542.698292068256;7558.811029724191;4175.498940127143;4198.202341555095;4388.4953230378915;4520.276755719069;4532.546745325441;2954.7340739333563;2975.2561859535117;2996.4306781711407;3002.939941201164;3006.188329151161;536.5117742854062;547.9726013699299;553.9944600554023;554.4123229376873;555.0093083845397;623.4856243599049;639.3670266436195;682.757621044522;696.6586372677351;704.4470090978557;8117.837643247102;8905.154010369135;8945.776355591162;8965.50689712072;9062.410943288796;533.6531254684486;595.5860676829562;683.1904193530582;710.1442761472414;726.3825748114166;3859.421086836997;4055.533613634411;4104.281750693676;4187.953011747063;4224.5353011168745;54576;55830;55909.72045139748;58805.117923231184;59432;47218;48350.27474587884;48788.512114878395;49732.254016189785;50642.74678626583;45695.54304456979;46767.76616116898;46797;47279.05441891143;48100.5189948096;8596.097409771884;8620.741377758677;8750.737477875675;8896.733098007071;9092.227160691415;34180.48729269113;34547.82726086354;35242.82378588091;35337.46993795044;36124.81937590295;45725;46309;46317.305240422094;46967.76516117534;47183;10782.211495307703;10979.615713449992;11430;11564.826527602261;11894.821577676168;11666;11757.823632645346;12298.692532686755;12421.93789031049;12502.937485312515;11369.374684392438;11580.536778528765;11662.53349865996;11945.522179112739;12057.216280941711;11272.267302625303;11643.88356116462;11703.882961170279;11890.762184756084;12078.21491603043;11163.330200188015;11676.182667213214;11697.356645384585;11746.471408786796;12006.2195957266;9465;9692.951535242279;9716.514174291398;9913.752156196153;9925.553350099119;8346.95758152246;8922.55387230623;9019.66817705829;10039.552761001227;10044.146247569039 05:04:08 INFO - 2015-12-18 05:04:08,602 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,851 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: __startTimestamp1450443848593__endTimestamp 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5273.16 Median:5451.78 stddev:578.78 (10.6%) stddev-sans-first:555.34 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: Values: 3119.0 3162.0 3203.4 3206.1 3230.9 5043.9 5138.0 5227.7 5304.0 5355.2 5233.8 5239.7 5290.2 5296.4 5339.7 4767.5 4769.0 4778.4 4964.4 4971.0 4902.6 4913.1 4981.7 4989.8 4992.5 4653.4 4719.4 4783.3 4823.6 4836.0 4863.2 4867.6 4874.3 4879.1 4909.1 4795.3 4822.3 4830.0 4867.4 4893.1 4973.3 5071.2 5079.9 5083.1 5088.4 5510.1 5565.9 5735.5 5788.1 5838.6 5801.1 5819.8 5820.8 5833.3 5847.4 5219.1 5438.9 5439.3 5448.5 5451.8 5645.5 5731.9 5735.5 5775.4 5784.1 5592.7 5599.5 5651.4 5654.2 5660.9 5500.5 5630.7 5653.4 5673.3 5673.6 5577.4 5584.7 5657.9 5661.2 5698.3 5614.1 5615.5 5622.3 5633.7 5642.1 4300.4 4347.7 4353.5 4365.2 4391.8 3887.7 3919.9 3935.6 3958.6 3970.3 5275.2 5331.3 5344.3 5350.3 5353.4 5485.0 5593.1 5727.0 5734.8 5736.3 5192.9 5218.1 5238.3 5259.9 5286.8 4912.5 4954.6 4956.4 4966.4 5011.4 5475.8 5606.4 5757.3 5767.3 5777.7 5618.9 5739.2 5825.0 5827.9 5885.1 5807.9 5812.5 5816.4 5818.9 5822.3 5581.6 5659.5 5660.2 5662.2 5694.4 5650.0 5701.7 5709.7 5716.4 5744.8 5599.8 5619.6 5644.5 5645.5 5649.3 5302.9 5459.3 5615.9 5631.3 5632.7 5390.0 5433.9 5444.4 5446.8 5484.3 5597.2 5649.8 5676.3 5683.1 5731.5 5317.5 5420.2 5426.2 5554.3 5555.7 05:04:08 INFO - 2015-12-18 05:04:08,603 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,605 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46426.52 Median:31556.46 stddev:78875.59 (250.0%) stddev-sans-first:79021.72 05:04:08 INFO - 2015-12-18 05:04:08,605 DEBUG : BROWSER_OUTPUT: Values: 573.3 607.2 611.7 626.1 626.6 30317.8 30816.4 39081.6 39687.2 39737.8 43492.6 43888.1 44040.1 44060.3 44119.6 8675.5 8832.5 8834.1 8834.7 8836.8 7777.3 7955.4 10090.5 10180.7 10238.4 10211.5 10309.8 10314.6 10340.1 10368.4 7551.9 7679.5 10078.7 10159.4 10159.9 7496.2 10258.7 10651.5 10680.7 10697.3 39930.4 40586.0 40594.0 40595.2 40638.6 3277.8 3292.1 3391.7 3411.4 3660.0 29860.6 30493.4 30556.0 30662.7 30933.1 3825.1 3856.8 3949.6 4044.8 4079.7 253513.0 254416.0 254527.0 255126.0 393287.0 45427.0 56451.4 57225.0 57226.7 57315.0 59189.7 59200.0 59272.0 59513.0 59514.0 13365.2 13401.9 13475.9 13487.7 13513.1 10024.7 10063.4 10112.8 10118.2 10128.0 19271.5 19483.6 19585.7 19600.4 19610.2 7706.8 7924.3 7929.4 8024.8 8060.3 903.6 913.7 979.9 1008.9 1072.5 28178.2 28375.9 28832.9 28854.6 28864.0 987.1 1001.1 1012.8 1020.0 1037.0 14619.3 14810.1 14829.5 15117.2 15130.0 302489.0 304428.0 306683.0 307158.0 307314.0 52130.7 52357.0 52417.7 52437.0 52437.5 1127.7 1253.4 1311.1 1325.5 1328.4 21170.8 29294.9 29549.4 30080.8 30100.7 48249.3 48475.5 48689.8 48712.3 48741.0 280005.0 282049.0 282360.0 288775.0 398533.0 30009.0 30010.4 30172.1 30372.4 30529.5 39899.8 40365.2 40559.8 41261.6 41564.6 34123.1 34347.1 34473.0 34661.8 35004.2 34570.7 35133.3 35390.6 35581.8 35653.0 32179.8 35166.5 35322.0 35562.8 35885.3 28823.9 29587.6 29966.4 30222.7 30401.7 24411.6 24806.3 24849.1 25007.0 25135.4 05:04:08 INFO - 2015-12-18 05:04:08,605 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,605 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28282.28 Median:2321.89 stddev:90807.91 (3911.0%) stddev-sans-first:91038.44 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: Values: 354.9 357.6 359.3 362.6 365.9 14054.3 14109.5 16458.3 16657.7 17268.2 10041.8 12489.3 13072.7 14869.8 15007.9 4806.4 4866.3 4907.9 4911.5 4912.4 3623.8 4853.5 4883.6 4884.1 5538.0 5851.8 5878.4 5893.7 5894.4 5897.6 5358.6 5361.7 5361.8 5394.4 5851.2 5101.5 5121.0 5121.4 5128.3 5132.7 11828.9 12616.6 12632.7 12638.8 12640.9 2016.5 2024.4 2055.5 2062.9 2076.2 9266.6 9347.7 9426.4 9518.8 9601.6 1821.5 1885.4 1891.5 1903.0 1925.2 57455.0 59963.7 60834.4 61279.7 61393.4 9709.4 9817.0 9910.7 9944.5 9973.4 12961.6 12974.1 12975.5 12997.4 13019.0 6910.8 6933.8 6977.1 7012.8 7092.6 6500.7 6515.1 6562.9 6595.7 6638.2 4224.1 4228.2 4241.9 4248.9 4255.7 1622.8 1684.7 1712.5 1726.3 1754.9 419.7 430.8 446.9 939.0 977.9 9948.4 10238.7 10248.5 10315.9 10569.5 423.9 436.0 442.7 446.0 462.8 4350.6 5765.9 5833.2 5843.6 9620.8 546323.0 549240.0 556875.0 558505.0 565197.0 80143.0 80354.0 80557.0 81201.0 81527.6 1125.9 1127.1 1139.7 1140.6 1143.2 15829.3 15847.5 15935.3 16010.8 16014.3 32281.7 32579.8 33707.3 33884.2 34743.0 39157.2 39464.6 39834.8 40453.0 40783.6 9250.4 9300.4 9512.7 9599.5 9625.0 13770.7 17344.8 17454.0 17922.9 17923.3 11540.9 11870.8 13749.5 13873.2 14272.5 13465.6 13731.5 13922.7 14034.5 14102.8 14253.4 14791.1 14893.1 15084.5 15619.8 7619.0 7919.1 9346.9 9386.8 9819.7 11209.8 13526.9 13760.4 14265.4 14565.9 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5249.21 Median:6258.75 stddev:2742.58 (43.8%) stddev-sans-first:2735.33 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: Values: 1440.6 1489.5 1536.4 1599.6 1772.6 6771.4 7259.1 7383.4 7424.6 7428.2 6957.6 7207.7 7208.9 7220.1 7233.4 1922.0 1961.9 2135.8 2161.8 2176.7 2203.2 2209.4 2210.5 2216.7 2217.9 2126.8 2185.1 2189.7 2192.4 2193.0 2163.8 2183.8 2183.8 2186.0 2214.7 2186.1 2189.1 2200.9 2201.3 2206.3 7609.2 7692.7 7699.5 7708.0 7713.1 4385.6 4473.4 4478.8 4484.3 4489.2 2994.5 3020.6 3036.4 3077.2 3123.2 983.7 1006.2 1012.0 1024.8 1054.6 9882.2 9983.6 9984.7 9993.1 10019.4 3972.7 4024.0 4054.5 4059.9 4101.4 8423.6 8431.2 8452.9 8474.5 8502.4 4357.5 4363.3 4370.8 4380.7 4384.4 3903.0 3947.3 3949.3 3957.7 3977.4 3197.6 3197.7 3218.2 3233.5 3386.7 1080.8 1093.7 1100.3 1106.5 1109.8 1003.7 1025.0 1088.5 1313.4 1316.9 7039.8 7044.9 7046.5 7046.6 7130.6 590.4 597.3 611.6 619.1 751.2 5560.7 5607.2 5675.3 5695.2 5702.5 8914.9 9152.5 9191.8 9252.4 9271.8 8586.4 8995.3 9027.5 9037.7 9091.8 7160.2 7234.7 7239.1 7303.6 7308.0 7178.6 7253.5 7272.4 7272.9 7306.5 7931.4 8165.6 8213.1 8219.7 8346.5 7747.6 8365.2 8391.0 8494.6 8570.0 7131.0 7199.0 7264.1 7269.0 7281.0 6122.6 6195.8 6196.7 7035.1 7383.7 6847.9 6883.7 6962.8 7017.6 7032.6 6778.2 6784.4 6859.4 6946.0 6965.3 6979.1 6989.3 7012.5 7026.9 7037.3 6209.8 6266.4 6282.4 6373.3 6406.6 6230.0 6249.1 6253.7 6263.8 6263.8 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,607 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5232.46 Median:5953.06 stddev:1569.61 (26.4%) stddev-sans-first:1530.30 05:04:08 INFO - 2015-12-18 05:04:08,608 DEBUG : BROWSER_OUTPUT: Values: 331.7 332.3 340.8 341.5 349.2 5783.0 5813.4 5850.4 5897.8 5916.1 5631.6 5777.2 5779.3 5807.7 5841.8 4554.2 4583.1 4584.3 4587.6 4590.7 4350.6 4417.6 4421.6 4557.8 4581.2 4516.5 4524.8 4530.3 4537.2 4539.6 4507.9 4522.4 4523.0 4524.4 4524.8 3984.5 3986.7 3990.6 3991.9 3993.3 5393.5 5574.1 5592.4 5596.5 5626.3 5265.2 5265.7 5271.3 5274.6 5275.2 5902.9 6244.3 6249.3 6250.3 6250.7 4228.3 4265.6 4386.8 4389.8 4389.9 6434.3 6476.8 6487.3 6493.8 6512.9 4390.1 4407.7 4409.8 4411.3 4413.0 4457.1 4460.8 4471.7 4473.3 4506.3 5197.0 5202.6 5208.0 5211.8 5211.9 6269.5 6271.8 6275.2 6277.1 6283.6 1580.8 1603.4 1606.3 1607.8 1608.6 1060.9 1062.4 1074.5 1078.7 1090.4 5990.0 5995.2 5997.6 6013.1 6016.0 6448.5 6451.5 6471.6 6475.1 6476.1 5991.0 5994.9 5998.4 6000.0 6000.6 3418.1 3490.7 3503.0 3504.8 3506.8 6607.0 6619.7 6646.4 6646.8 6648.7 6716.1 6722.7 6727.3 6731.5 6735.8 6490.0 6618.4 6662.5 6672.1 6674.2 6231.2 6420.2 6522.0 6524.4 6537.0 6312.5 6344.4 6349.3 6487.3 6491.0 6633.8 6654.6 6668.1 6669.7 6677.8 4439.6 4451.6 4476.6 4478.7 4491.1 6372.1 6390.5 6451.5 6471.9 6475.8 6294.2 6302.3 6303.7 6311.6 6313.1 6175.0 6234.0 6279.8 6280.9 6283.2 6148.2 6154.7 6155.1 6157.0 6159.1 6291.9 6295.8 6297.1 6300.2 6300.5 6037.0 6125.8 6141.3 6156.8 6157.1 05:04:08 INFO - 2015-12-18 05:04:08,608 DEBUG : BROWSER_OUTPUT: 05:04:08 INFO - 2015-12-18 05:04:08,609 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13819.92 Median:46782.38 stddev:15840.07 (33.9%) stddev-sans-first:15854.52 05:04:08 INFO - 2015-12-18 05:04:08,609 DEBUG : BROWSER_OUTPUT: Values: 841.1 851.5 854.2 861.2 879.9 13679.7 13997.2 14065.9 14080.1 14097.8 13343.5 13455.9 13471.3 13471.9 13474.7 674.2 680.2 820.1 821.6 835.6 814.3 816.2 821.2 822.0 822.6 707.9 870.1 875.3 875.5 876.6 709.3 851.9 863.0 871.4 871.5 645.8 646.3 647.6 647.7 648.2 13043.7 13325.4 13352.8 13366.2 13370.6 11992.3 12109.2 12114.8 12261.8 12285.7 10247.2 10427.5 10760.9 10840.7 10950.2 3613.3 3649.1 3680.2 3768.2 3770.8 45894.8 47798.0 47806.8 47826.0 47856.8 9701.8 9706.7 10130.4 10314.4 10360.8 17674.6 17679.4 17689.8 17708.2 17714.0 7471.3 7500.6 7538.6 7542.7 7558.8 4175.5 4198.2 4388.5 4520.3 4532.5 2954.7 2975.3 2996.4 3002.9 3006.2 536.5 548.0 554.0 554.4 555.0 623.5 639.4 682.8 696.7 704.4 8117.8 8905.2 8945.8 8965.5 9062.4 533.7 595.6 683.2 710.1 726.4 3859.4 4055.5 4104.3 4188.0 4224.5 54576.0 55830.0 55909.7 58805.1 59432.0 47218.0 48350.3 48788.5 49732.3 50642.7 45695.5 46767.8 46797.0 47279.1 48100.5 8596.1 8620.7 8750.7 8896.7 9092.2 34180.5 34547.8 35242.8 35337.5 36124.8 45725.0 46309.0 46317.3 46967.8 47183.0 10782.2 10979.6 11430.0 11564.8 11894.8 11666.0 11757.8 12298.7 12421.9 12502.9 11369.4 11580.5 11662.5 11945.5 12057.2 11272.3 11643.9 11703.9 11890.8 12078.2 11163.3 11676.2 11697.4 11746.5 12006.2 9465.0 9693.0 9716.5 9913.8 9925.6 8347.0 8922.6 9019.7 10039.6 10044.1 05:04:08 INFO - 2015-12-18 05:04:08,609 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:04:08 INFO - 2015-12-18 05:04:08,609 DEBUG : BROWSER_OUTPUT: 05:04:09 INFO - 2015-12-18 05:04:09,279 INFO : Browser exited with error code: 0 05:04:09 INFO - 2015-12-18 05:04:09,300 INFO : Completed test dromaeo_css (00:18:32) 05:04:09 INFO - 2015-12-18 05:04:09,300 INFO : Starting test kraken 05:04:09 INFO - 2015-12-18 05:04:09,300 DEBUG : operating with platform_type : linux_ 05:04:09 INFO - 2015-12-18 05:04:09,300 INFO : Initialising browser for kraken test... 05:04:09 INFO - 2015-12-18 05:04:09,306 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJBOTZQ/profile http://localhost:40770/getInfo.html 05:04:12 INFO - 2015-12-18 05:04:12,882 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:04:12 INFO - 2015-12-18 05:04:12,883 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:04:12 INFO - 2015-12-18 05:04:12,883 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:04:12 INFO - 2015-12-18 05:04:12,883 DEBUG : BROWSER_OUTPUT: __metrics 05:04:12 INFO - 2015-12-18 05:04:12,979 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:04:13 INFO - 2015-12-18 05:04:13,040 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:14 INFO - 2015-12-18 05:04:14,077 INFO : Browser initialized. 05:04:14 INFO - 2015-12-18 05:04:14,077 INFO : Running cycle 1/1 for kraken test... 05:04:14 INFO - 2015-12-18 05:04:14,077 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJBOTZQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:04:25 INFO - 2015-12-18 05:04:25,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 149757952 05:04:25 INFO - 2015-12-18 05:04:25,882 DEBUG : BROWSER_OUTPUT: 05:04:28 INFO - 2015-12-18 05:04:28,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40770/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:28 INFO - 2015-12-18 05:04:28,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 185896960 05:04:28 INFO - 2015-12-18 05:04:28,908 DEBUG : BROWSER_OUTPUT: 05:04:31 INFO - 2015-12-18 05:04:31,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40770/tests/kraken/driver.html?testName=audio-dft) 05:04:32 INFO - 2015-12-18 05:04:32,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 177704960 05:04:32 INFO - 2015-12-18 05:04:32,081 DEBUG : BROWSER_OUTPUT: 05:04:34 INFO - 2015-12-18 05:04:34,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40770/tests/kraken/driver.html?testName=audio-fft) 05:04:35 INFO - 2015-12-18 05:04:35,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 160186368 05:04:35 INFO - 2015-12-18 05:04:35,531 DEBUG : BROWSER_OUTPUT: 05:04:37 INFO - 2015-12-18 05:04:37,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40770/tests/kraken/driver.html?testName=audio-oscillator) 05:04:38 INFO - 2015-12-18 05:04:38,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 162693120 05:04:38 INFO - 2015-12-18 05:04:38,068 DEBUG : BROWSER_OUTPUT: 05:04:40 INFO - 2015-12-18 05:04:40,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40770/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:40 INFO - 2015-12-18 05:04:40,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 164249600 05:04:40 INFO - 2015-12-18 05:04:40,837 DEBUG : BROWSER_OUTPUT: 05:04:43 INFO - 2015-12-18 05:04:43,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40770/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:44 INFO - 2015-12-18 05:04:44,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 164143104 05:04:44 INFO - 2015-12-18 05:04:44,303 DEBUG : BROWSER_OUTPUT: 05:04:47 INFO - 2015-12-18 05:04:47,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40770/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:48 INFO - 2015-12-18 05:04:48,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 166072320 05:04:48 INFO - 2015-12-18 05:04:48,253 DEBUG : BROWSER_OUTPUT: 05:04:50 INFO - 2015-12-18 05:04:50,953 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40770/tests/kraken/driver.html?testName=json-parse-financial) 05:04:51 INFO - 2015-12-18 05:04:51,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 165900288 05:04:51 INFO - 2015-12-18 05:04:51,535 DEBUG : BROWSER_OUTPUT: 05:04:53 INFO - 2015-12-18 05:04:53,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40770/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:53 INFO - 2015-12-18 05:04:53,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 182104064 05:04:53 INFO - 2015-12-18 05:04:53,689 DEBUG : BROWSER_OUTPUT: 05:04:55 INFO - 2015-12-18 05:04:55,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:04:56 INFO - 2015-12-18 05:04:56,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 176578560 05:04:56 INFO - 2015-12-18 05:04:56,065 DEBUG : BROWSER_OUTPUT: 05:04:58 INFO - 2015-12-18 05:04:58,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:04:58 INFO - 2015-12-18 05:04:58,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 184184832 05:04:58 INFO - 2015-12-18 05:04:58,678 DEBUG : BROWSER_OUTPUT: 05:05:01 INFO - 2015-12-18 05:05:01,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:01 INFO - 2015-12-18 05:05:01,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 191500288 05:05:01 INFO - 2015-12-18 05:05:01,660 DEBUG : BROWSER_OUTPUT: 05:05:04 INFO - 2015-12-18 05:05:04,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:04 INFO - 2015-12-18 05:05:04,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 191033344 05:05:04 INFO - 2015-12-18 05:05:04,760 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40770/tests/kraken/driver.html?testName=ai-astar) 05:05:06 INFO - 2015-12-18 05:05:06,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 247771136 05:05:06 INFO - 2015-12-18 05:05:06,678 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;110;111;100;109;109;115 05:05:06 INFO - 2015-12-18 05:05:06,682 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;126;153;164;130;155;147;125;168;133 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;160;161;161;162;163;160;162 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;85;92;81;72;73;93;96;71 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;146;94;94;93;140;93;94;144 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;110;109;109;110;109 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;144;145;146;145;145;144;146;145 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;95;96;95;95;95 05:05:06 INFO - 2015-12-18 05:05:06,683 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;59;57;58;57;58;59;59;57 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;66;66;67;68;66;67;67;67 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;83;84;84;84;84;91;84;85 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;115;131;128;117;116;121;116;113;122 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;153;150;151;150;141;150;142;142;139 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;68;68;65;67;68;69;65;68 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:05:06 INFO - 2015-12-18 05:05:06,684 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 05:05:06 INFO - 2015-12-18 05:05:06,685 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:05:06 INFO - 2015-12-18 05:05:06,685 DEBUG : BROWSER_OUTPUT: __startTimestamp1450443906680__endTimestamp 05:05:06 INFO - 2015-12-18 05:05:06,685 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,689 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:05:06 INFO - 2015-12-18 05:05:06,689 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:05:06 INFO - 2015-12-18 05:05:06,689 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,689 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 05:05:06 INFO - 2015-12-18 05:05:06,690 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 110.0 111.0 100.0 109.0 109.0 115.0 05:05:06 INFO - 2015-12-18 05:05:06,690 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,690 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.00 Median:154.00 stddev:16.24 (10.5%) stddev-sans-first:16.53 05:05:06 INFO - 2015-12-18 05:05:06,690 DEBUG : BROWSER_OUTPUT: Values: 159.0 126.0 153.0 164.0 130.0 155.0 147.0 125.0 168.0 133.0 05:05:06 INFO - 2015-12-18 05:05:06,690 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 160.0 161.0 161.0 162.0 163.0 160.0 162.0 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:83.00 stddev:10.08 (12.1%) stddev-sans-first:10.30 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 85.0 92.0 81.0 72.0 73.0 93.0 96.0 71.0 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.50 stddev:24.08 (25.8%) stddev-sans-first:24.88 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 146.0 94.0 94.0 93.0 140.0 93.0 94.0 144.0 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:05:06 INFO - 2015-12-18 05:05:06,691 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 144.0 145.0 146.0 145.0 145.0 144.0 146.0 145.0 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,692 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 59.0 57.0 58.0 57.0 58.0 59.0 59.0 57.0 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 66.0 67.0 68.0 66.0 67.0 67.0 67.0 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.32 (2.8%) stddev-sans-first:2.45 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 83.0 84.0 84.0 84.0 84.0 91.0 84.0 85.0 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.50 stddev:6.49 (5.3%) stddev-sans-first:6.17 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: Values: 129.0 115.0 131.0 128.0 117.0 116.0 121.0 116.0 113.0 122.0 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:150.00 stddev:5.30 (3.5%) stddev-sans-first:5.32 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: Values: 141.0 153.0 150.0 151.0 150.0 141.0 150.0 142.0 142.0 139.0 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: 05:05:06 INFO - 2015-12-18 05:05:06,693 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 05:05:06 INFO - 2015-12-18 05:05:06,694 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 68.0 68.0 65.0 67.0 68.0 69.0 65.0 68.0 05:05:06 INFO - 2015-12-18 05:05:06,694 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:05:06 INFO - 2015-12-18 05:05:06,694 DEBUG : BROWSER_OUTPUT: 05:05:07 INFO - 2015-12-18 05:05:07,511 INFO : Browser exited with error code: 0 05:05:07 INFO - 2015-12-18 05:05:07,567 INFO : Completed test kraken (00:00:58) 05:05:07 INFO - 2015-12-18 05:05:07,567 INFO : Starting test v8_7 05:05:07 INFO - 2015-12-18 05:05:07,567 DEBUG : operating with platform_type : linux_ 05:05:07 INFO - 2015-12-18 05:05:07,567 INFO : Initialising browser for v8_7 test... 05:05:07 INFO - 2015-12-18 05:05:07,573 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsUCYzw/profile http://localhost:40770/getInfo.html 05:05:11 INFO - 2015-12-18 05:05:11,166 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:05:11 INFO - 2015-12-18 05:05:11,166 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:05:11 INFO - 2015-12-18 05:05:11,166 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:05:11 INFO - 2015-12-18 05:05:11,166 DEBUG : BROWSER_OUTPUT: __metrics 05:05:11 INFO - 2015-12-18 05:05:11,255 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:05:11 INFO - 2015-12-18 05:05:11,311 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:05:12 INFO - 2015-12-18 05:05:12,444 INFO : Browser initialized. 05:05:12 INFO - 2015-12-18 05:05:12,444 INFO : Running cycle 1/1 for v8_7 test... 05:05:12 INFO - 2015-12-18 05:05:12,444 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsUCYzw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:05:24 INFO - 2015-12-18 05:05:24,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 149590016 05:05:24 INFO - 2015-12-18 05:05:24,225 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,694 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40770/tests/v8_7/run.html (next: http://localhost:40770/tests/v8_7/run.html) 05:05:45 INFO - 2015-12-18 05:05:45,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 615804928 05:05:45 INFO - 2015-12-18 05:05:45,943 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: |0;Richards;169.1188905800778 05:05:45 INFO - 2015-12-18 05:05:45,944 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.7504718761797 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2070.3933747412007 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |6;Boyer;11988.095238095239 05:05:45 INFO - 2015-12-18 05:05:45,945 DEBUG : BROWSER_OUTPUT: |7;RegExp;25400 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: |8;Splay;688.0546075085324 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: __startTimestamp1450443945941__endTimestamp 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,946 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.12 Median:169.12 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: Values: 169.1 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.75 Median:188.75 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,947 DEBUG : BROWSER_OUTPUT: Values: 188.8 05:05:45 INFO - 2015-12-18 05:05:45,948 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,948 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,948 DEBUG : BROWSER_OUTPUT: Values: 280.0 05:05:45 INFO - 2015-12-18 05:05:45,948 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,948 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: Values: 5117.3 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2070.39 Median:2070.39 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: Values: 2070.4 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,949 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: Values: 779.4 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11988.10 Median:11988.10 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: Values: 11988.1 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,950 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25400.00 Median:25400.00 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: Values: 25400.0 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:688.05 Median:688.05 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: Values: 688.1 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:05:45 INFO - 2015-12-18 05:05:45,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:05:45 INFO - 2015-12-18 05:05:45,952 DEBUG : BROWSER_OUTPUT: 05:05:46 INFO - 2015-12-18 05:05:46,759 INFO : Browser exited with error code: 0 05:05:46 INFO - 2015-12-18 05:05:46,776 INFO : Completed test v8_7 (00:00:39) 05:05:46 INFO - 2015-12-18 05:05:46,914 INFO : Completed test suite (00:20:10) 05:05:46 INFO - 2015-12-18 05:05:46,914 DEBUG : Working with test: dromaeo_css 05:05:46 INFO - 2015-12-18 05:05:46,915 DEBUG : Generating results file: dromaeo_css 05:05:46 INFO - 2015-12-18 05:05:46,916 DEBUG : Working with test: kraken 05:05:46 INFO - 2015-12-18 05:05:46,917 DEBUG : Generating results file: kraken 05:05:46 INFO - 2015-12-18 05:05:46,917 INFO : javascript benchmark 05:05:46 INFO - 2015-12-18 05:05:46,917 DEBUG : Working with test: v8_7 05:05:46 INFO - 2015-12-18 05:05:46,917 DEBUG : Generating results file: v8_7 05:05:46 INFO - 2015-12-18 05:05:46,918 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:05:47 INFO - 2015-12-18 05:05:47,063 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:05:47 INFO - 2015-12-18 05:05:47,063 DEBUG : process_Request line: dromaeo_css 6795.88 graph.html#tests=[[72,201,35]] 05:05:47 INFO - 2015-12-18 05:05:47,063 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:05:47 INFO - 2015-12-18 05:05:47,175 DEBUG : process_Request line: kraken 1497.80 graph.html#tests=[[232,201,35]] 05:05:47 INFO - 2015-12-18 05:05:47,175 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:05:47 INFO - 2015-12-18 05:05:47,285 DEBUG : process_Request line: v8_7 19589.82 graph.html#tests=[[230,201,35]] 05:05:47 INFO - 2015-12-18 05:05:47,286 INFO : javascript benchmark 05:05:47 INFO - 2015-12-18 05:05:47,290 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.9844050779748, 3162.0, 3203.4233837909183, 3206.070239630506, 3230.9030729078127, 5043.924341134886, 5138.049460849746, 5227.738613069346, 5304.018756530045, 5355.169948657959, 5233.842984710455, 5239.659422137558, 5290.1800220965815, 5296.390915044762, 5339.652922560041, 4767.4755776864695, 4769.0, 4778.426588809348, 4964.354633897607, 4971.030649023442, 4902.632302577304, 4913.066517361708, 4981.676191047589, 4989.800407983676, 4992.525710057539, 4653.441587009564, 4719.433667959833, 4783.28250762385, 4823.638227132979, 4836.032793441326, 4863.19757240055, 4867.561919427233, 4874.341963834872, 4879.072976134523, 4909.140900342426, 4795.328653988445, 4822.276658501218, 4830.033993201374, 4867.36724225852, 4893.0703166398625, 4973.303737476756, 5071.239314102877, 5079.898402031976, 5083.05963396769, 5088.389393272794, 5510.090835012218, 5565.916511252334, 5735.541156707453, 5788.102844059177, 5838.620489668158, 5801.129830525413, 5819.79630712923, 5820.796272130455, 5833.32916714579, 5847.415258474161, 5219.1388420910125, 5438.945610543883, 5439.347278326587, 5448.536874365684, 5451.781928722847, 5645.463680950304, 5731.942680573225, 5735.4551317624755, 5775.422457754275, 5784.132380142928, 5592.720363981784, 5599.524040456526, 5651.378348381675, 5654.151877218368, 5660.915086273709, 5500.50495455411, 5630.71846407678, 5653.406392328829, 5673.31920169574, 5673.574481913873, 5577.414371491016, 5584.720763961785, 5657.858553536194, 5661.1508273758445, 5698.259226300637, 5614.101743720985, 5615.522680572116, 5622.297212848394, 5633.690147041952, 5642.097264437671, 4300.397944287803, 4347.7173983690955, 4353.542877997765, 4365.170617582649, 4391.84628538006, 3887.6501114899793, 3919.8824035278985, 3935.6064393560414, 3958.5645578986287, 3970.3448930926074, 5275.155975044051, 5331.306930099062, 5344.251804747339, 5350.30446042012, 5353.357597088374, 5484.972575137099, 5593.077142271561, 5726.9691455538405, 5734.799282025109, 5736.282964629421, 5192.8961420771375, 5218.060749065129, 5238.345206849144, 5259.868503287448, 5286.81496147633, 4912.533309335608, 4954.628402869799, 4956.430010548761, 4966.354373931365, 5011.448740638527, 5475.808346707846, 5606.411326810789, 5757.280339957505, 5767.279090113736, 5777.711114444345, 5618.915716264341, 5739.167820666064, 5824.970875145597, 5827.8834423310445, 5885.14665373527, 5807.941920580909, 5812.534997200299, 5816.360200377871, 5818.854528636818, 5822.272215973004, 5581.5813813963305, 5659.547236221175, 5660.179274005164, 5662.178984047207, 5694.430556944272, 5649.971750141223, 5701.714914254354, 5709.743061562157, 5716.42835716425, 5744.798932037359, 5599.776008959596, 5619.634723742944, 5644.548436125182, 5645.491905728504, 5649.322081350264, 5302.8939421212135, 5459.317585301837, 5615.915761263666, 5631.267935168402, 5632.662040277432, 5389.973050134881, 5433.9456605435025, 5444.373897001896, 5446.809361672323, 5484.341878974548, 5597.244372009726, 5649.802256920988, 5676.262085928803, 5683.147527870852, 5731.541476681772, 5317.548008419328, 5420.186971954238, 5426.186072089218, 5554.2779438672715, 5555.694436806015], "unit": "score", "name": "dojo.html", "value": 5236.196741823517}, {"lowerIsBetter": false, "replicates": [573.2547688005592, 607.1924340626966, 611.7491828350376, 626.0734113512005, 626.6428135962503, 30317.848410757942, 30816.38367232654, 39081.60918390812, 39687.206255874866, 39737.8013109934, 43492.565074349244, 43888.12223755523, 44040.119197616026, 44060.3390949136, 44119.55880441202, 8675.52284624347, 8832.514211718353, 8834.072422395653, 8834.73495795124, 8836.779080522974, 7777.261160189773, 7955.443118981673, 10090.495475226246, 10180.745481362952, 10238.436885971269, 10211.48942552873, 10309.84535231972, 10314.638987635435, 10340.121089707347, 10368.377897326147, 7551.886721699179, 7679.500832445873, 10078.697639070802, 10159.441230732344, 10159.89840101597, 7496.212897645778, 10258.692239232834, 10651.520681569347, 10680.679579612624, 10697.251192416534, 39930.40104398436, 40586.0, 40594.0, 40595.18809623791, 40638.59361406407, 3277.7869438486423, 3292.061762397729, 3391.6777906098882, 3411.403004474207, 3660.0300920256154, 29860.55209171864, 30493.390132197455, 30556.0, 30662.693373066206, 30933.0720078398, 3825.052505101566, 3856.7878766667823, 3949.605039496056, 4044.777537235451, 4079.673626109904, 253513.0, 254416.0, 254527.0, 255126.0, 393287.0, 45427.0, 56451.43548564544, 57225.0, 57226.7138664304, 57315.0, 59189.704051479464, 59200.0, 59272.0, 59513.0, 59514.0, 13365.198088114745, 13401.93299033518, 13475.932620336836, 13487.730245395234, 13513.054086214068, 10024.699259022242, 10063.39619622825, 10112.848307275397, 10118.190544756402, 10128.0, 19271.51821204453, 19483.610327793365, 19585.706214406797, 19600.411987640393, 19610.215591376185, 7706.7687969361, 7924.286814186751, 7929.405294602928, 8024.839503209903, 8060.314873235723, 903.5662881816634, 913.72588223534, 979.9216062714966, 1008.8890222075565, 1072.5012869015945, 28178.154655360373, 28375.858120709265, 28832.855835720686, 28854.567181492293, 28864.0, 987.0721521769514, 1001.1440218612981, 1012.7721262715977, 1019.9847002294972, 1036.9785761025385, 14619.342129604192, 14810.111393316436, 14829.480968166063, 15117.16855572932, 15130.0, 302489.0, 304428.0, 306683.0, 307158.0, 307314.0, 52130.739346303024, 52357.0, 52417.737911310964, 52437.0, 52437.47562524402, 1127.718070482363, 1253.4296894912793, 1311.114997376767, 1325.5426877727168, 1328.3955800110925, 21170.788292117497, 29294.853525732236, 29549.409011819214, 30080.849595752756, 30100.698993010665, 48249.27626085541, 48475.5152448471, 48689.75655121702, 48712.26931595958, 48741.0, 280005.0, 282049.0, 282360.0, 288775.0, 398533.0, 30009.0, 30010.3997920036, 30172.09483715492, 30372.392552149275, 30529.54205686961, 39899.80050099847, 40365.1926961465, 40559.797201013804, 41261.58738412698, 41564.58435415607, 34123.14692132617, 34347.14132146716, 34473.0, 34661.826690866386, 35004.19966402733, 34570.65429345674, 35133.297334053685, 35390.64609353874, 35581.82209088938, 35653.0, 32179.839100805282, 35166.472502911965, 35322.0, 35562.82218588891, 35885.28229435449, 28823.85588072046, 29587.556186656788, 29966.400671986874, 30222.68771352353, 30401.69598303989, 24411.633825492987, 24806.309764779442, 24849.1302804401, 25006.999720011725, 25135.371615709755], "unit": "score", "name": "ext.html", "value": 18373.303257817868}, {"lowerIsBetter": false, "replicates": [354.86869858152505, 357.61556326948505, 359.30653838092474, 362.5540585080351, 365.9377905756022, 14054.297285135728, 14109.506167284122, 16458.34166633335, 16657.666846663076, 17268.22292996815, 10041.799164016715, 12489.250644961308, 13072.73854522909, 14869.776953345681, 15007.924960375183, 4806.375171227744, 4866.294387313837, 4907.9263811042865, 4911.484294149116, 4912.38595175603, 3623.7825730456125, 4853.490383509734, 4883.6337274704365, 4884.096442158212, 5538.0, 5851.76592936282, 5878.353381128072, 5893.675847828367, 5894.351621321651, 5897.587168898157, 5358.5981051421295, 5361.651492652965, 5361.812336568221, 5394.406615272317, 5851.180834683148, 5101.540861322499, 5120.974395128038, 5121.385433747937, 5128.282040514331, 5132.692038477666, 11828.940855295754, 12616.558420455332, 12632.68418289541, 12638.810417843739, 12640.873591264062, 2016.5361966747585, 2024.4230394337544, 2055.4553043443498, 2062.896855157251, 2076.2317942361424, 9266.58300376478, 9347.672831450935, 9426.387284826464, 9518.809623807554, 9601.567929443192, 1821.480877949778, 1885.4155211884222, 1891.4547132550642, 1902.9809701902943, 1925.2010415677478, 57455.0, 59963.70018149881, 60834.39165608332, 61279.693601531704, 61393.38606613921, 9709.417434953926, 9816.950915245521, 9910.702678919644, 9944.45305508204, 9973.351732137533, 12961.611151665466, 12974.091813572959, 12975.480980760663, 12997.415116319788, 13019.0, 6910.7581234656545, 6933.83464629585, 6977.092977912839, 7012.754553590702, 7092.6099064551945, 6500.674966251669, 6515.120458738104, 6562.917118675365, 6595.670216489157, 6638.17022872141, 4224.070704445017, 4228.217779710763, 4241.936370954438, 4248.893777655583, 4255.702100852911, 1622.8377162283678, 1684.6967545841621, 1712.546175263556, 1726.266336806852, 1754.885932414389, 419.70410860343384, 430.838435586655, 446.89721364086444, 938.9859152112724, 977.8924318324979, 9948.35335703177, 10238.744031399274, 10248.48757562119, 10315.948420257851, 10569.524371403306, 423.927932251518, 435.9928565014826, 442.7343593843668, 445.9598636122765, 462.82875336125846, 4350.630196433339, 5765.913511297334, 5833.154192642043, 5843.590948633555, 9620.807583848284, 546323.0, 549240.0, 556875.0, 558505.0, 565197.0, 80143.0, 80354.0, 80557.0, 81201.0, 81527.59236203782, 1125.8705248896317, 1127.1377396291844, 1139.7093741096132, 1140.560884059643, 1143.2168964259674, 15829.287682054104, 15847.52457426279, 15935.282912268744, 16010.839891600936, 16014.27935742871, 32281.67718322787, 32579.837100814344, 33707.3258534823, 33884.152896176805, 34743.0, 39157.2168556633, 39464.60535394609, 39834.800825995684, 40453.0, 40783.59216407798, 9250.352475326663, 9300.441973481613, 9512.667056652985, 9599.47202903847, 9625.0, 13770.65573360674, 17344.826551734826, 17454.0, 17922.91038544851, 17923.28306867763, 11540.94229528847, 11870.82193767077, 13749.450021999008, 13873.167609943435, 14272.500462483764, 13465.596032119052, 13731.519396821062, 13922.721545569235, 14034.508792192224, 14102.788458173341, 14253.35859886287, 14791.112533248039, 14893.106413615218, 15084.472043478425, 15619.765703514684, 7619.047619047619, 7919.08930473003, 9346.906530934875, 9386.765330866783, 9819.656312029045, 11209.775804484028, 13526.86473135256, 13760.380782864595, 14265.358058887583, 14565.85434145645], "unit": "score", "name": "jquery.html", "value": 8007.5750577652825}, {"lowerIsBetter": false, "replicates": [1440.6254373862794, 1489.4935721854567, 1536.385445821672, 1599.5681166085158, 1772.6100257943249, 6771.424428923541, 7259.092613423322, 7383.372413344859, 7424.591647459388, 7428.182899881022, 6957.61733104679, 7207.711691532346, 7208.855822883553, 7220.133583969931, 7233.385162261214, 1922.0485859499497, 1961.8724782889137, 2135.7543882453483, 2161.7622061573293, 2176.7279090113734, 2203.173809821317, 2209.436593668612, 2210.5357874846222, 2216.7118274624277, 2217.8780167090804, 2126.829853611707, 2185.104107316001, 2189.704389907366, 2192.440927563469, 2193.035064571591, 2163.816075633581, 2183.792539708725, 2183.825293976478, 2186.04906865514, 2214.723159605049, 2186.147402513021, 2189.0915270162864, 2200.8899555022185, 2201.3175915466095, 2206.2829580386438, 7609.201033891417, 7692.730754423568, 7699.461037727361, 7708.0, 7713.112992005935, 4385.583369579885, 4473.4408198975125, 4478.820847166109, 4484.282514797649, 4489.169503641804, 2994.5358469437274, 3020.5620185073262, 3036.3623639035827, 3077.2306923269184, 3123.1879711275233, 983.6557204978201, 1006.2101250518308, 1011.9797604047877, 1024.830902901028, 1054.5834395413845, 9882.209423246122, 9983.550740216635, 9984.650537231235, 9993.10062094415, 10019.448930308903, 3972.7020473464027, 4024.0, 4054.5134583850127, 4059.89850253746, 4101.446304748881, 8423.620937057847, 8431.15688431152, 8452.8732069019, 8474.533900635524, 8502.44734092282, 4357.520672725997, 4363.280058790264, 4370.8033138508845, 4380.69335146543, 4384.386185933972, 3902.9609703902597, 3947.2500224957166, 3949.2693851636964, 3957.683385329167, 3977.3835055566433, 3197.6322722886703, 3197.728193103566, 3218.1632775478542, 3233.4503134467195, 3386.745994050456, 1080.8216644253766, 1093.6609651008214, 1100.312304809494, 1106.4910141335076, 1109.778044391125, 1003.693873368615, 1025.0, 1088.5156105532963, 1313.4089659653193, 1316.8683131686755, 7039.803233450326, 7044.894326585106, 7046.541974771623, 7046.612436316052, 7130.572165670076, 590.439082871274, 597.250450684397, 611.6360765344613, 619.0992106485054, 751.1587022534796, 5560.7219639017885, 5607.186957891165, 5675.290588676416, 5695.231143795618, 5702.54379649627, 8914.86627700585, 9152.496612686233, 9191.816163676689, 9252.352335336596, 9271.768205794775, 8586.398952073296, 8995.28037756991, 9027.548622568846, 9037.68368107113, 9091.81816363669, 7160.212376638566, 7234.74678386254, 7239.131304243419, 7303.561786292733, 7307.976883236457, 7178.60517671533, 7253.492255542062, 7272.41820654357, 7272.927270727225, 7306.4885458017425, 7931.405144614062, 8165.550894700848, 8213.055498617736, 8219.712310069119, 8346.499210047417, 7747.612619368896, 8365.163483651586, 8391.035030971272, 8494.57527123629, 8570.0, 7131.0, 7199.028131202221, 7264.128304603481, 7269.0, 7281.0, 6122.602030868157, 6195.783147589813, 6196.690165491617, 7035.05026821393, 7383.704651813868, 6847.897281540881, 6883.724651013903, 6962.825929351807, 7017.649117544204, 7032.648367581703, 6778.186617605918, 6784.423324017316, 6859.382655561023, 6945.965270173617, 6965.303469652994, 6979.057827193264, 6989.26612705679, 7012.50912436145, 7026.8945965809535, 7037.296270373126, 6209.813705588839, 6266.373362663697, 6282.434580887742, 6373.330800265905, 6406.615603063831, 6230.00319948806, 6249.093881387083, 6253.7185826637, 6263.78076767311, 6263.78076767311], "unit": "score", "name": "mootools.html", "value": 4262.847189274627}, {"lowerIsBetter": false, "replicates": [331.70975396528036, 332.27232361129126, 340.75635920316967, 341.5406278555345, 349.16375281201505, 5782.9879771040005, 5813.389594092618, 5850.356460789315, 5897.823065308047, 5916.142159386892, 5631.63394379366, 5777.19119323295, 5779.335376431712, 5807.680577568232, 5841.824745257639, 4554.180247555439, 4583.1062942726185, 4584.335271385664, 4587.632989360844, 4590.678652494326, 4350.564943505656, 4417.624501917341, 4421.557844215585, 4557.840475583355, 4581.152486789938, 4516.480604730449, 4524.796384162721, 4530.343100250462, 4537.228671125917, 4539.614132798716, 4507.887302817423, 4522.4346956630425, 4522.9547704522865, 4524.434445694288, 4524.751138687371, 3984.5218573771044, 3986.681065514752, 3990.6009399060154, 3991.9201615967518, 3993.28120938231, 5393.460653934614, 5574.136008918624, 5592.356878958891, 5596.496315331639, 5626.324841019063, 5265.210218467222, 5265.736713164327, 5271.341082364705, 5274.578033757329, 5275.155975044013, 5902.852428689274, 6244.313125556185, 6249.312575616678, 6250.312465628777, 6250.749970001195, 4228.344606585984, 4265.594768497019, 4386.780660966939, 4389.846355377578, 4389.912201755947, 6434.260060093103, 6476.838079047967, 6487.286398496161, 6493.805185844432, 6512.869742605121, 4390.05613793036, 4407.713498622579, 4409.757463339547, 4411.338299255138, 4412.977935110304, 4457.108578284357, 4460.821567137278, 4471.731696098244, 4473.261911784519, 4506.301523263899, 5196.9740151299, 5202.557782588522, 5208.0365132450615, 5211.8175863845345, 5211.921821172686, 6269.498440124779, 6271.843203919939, 6275.184226050585, 6277.121203031579, 6283.622982621057, 1580.826109127995, 1603.446810850255, 1606.2771752711094, 1607.7909871716602, 1608.6380564373158, 1060.8833028366873, 1062.3678911047914, 1074.511097450658, 1078.7087486378634, 1090.4438736244413, 5989.970050149808, 5995.160677505153, 5997.640141591519, 6013.098035294741, 6015.969920150371, 6448.516361272923, 6451.548391612542, 6471.579347342407, 6475.061116138134, 6476.125723027331, 5990.9700451497465, 5994.910076348859, 5998.400159983967, 5999.970000150059, 6000.639961602318, 3418.1283772637817, 3490.6683865032783, 3502.9824850876093, 3504.8247587620517, 3506.8246587670515, 6607.0, 6619.702113404908, 6646.401823835878, 6646.800595982031, 6648.700808463631, 6716.093327400836, 6722.731090756412, 6727.327267273234, 6731.49513786468, 6735.797926062226, 6490.0, 6618.404343609098, 6662.5003124765835, 6672.065910772592, 6674.23246326669, 6231.158793562811, 6420.1974753155855, 6522.0, 6524.412802847766, 6537.0, 6312.526560508072, 6344.397282258363, 6349.333320001518, 6487.286398496256, 6491.0, 6633.767818126343, 6654.633995130314, 6668.06647069401, 6669.666516674244, 6677.76627818024, 4439.62263207631, 4451.643868490578, 4476.641868650435, 4478.664100192434, 4491.124230774967, 6372.139761132374, 6390.520710946605, 6451.516136289703, 6471.902921456088, 6475.805725828232, 6294.244690637152, 6302.306746257999, 6303.684815759286, 6311.621302721851, 6313.084602732486, 6175.0, 6234.0025595904435, 6279.843003924756, 6280.905786413299, 6283.183186185766, 6148.200733904564, 6154.692265386802, 6155.1382806406245, 6156.969215153896, 6159.1377207190135, 6291.874162516632, 6295.811125666238, 6297.086922396318, 6300.243970723543, 6300.495960323255, 6037.027233545262, 6125.84685382869, 6141.293751218667, 6156.753729850756, 6157.1072194532435], "unit": "score", "name": "prototype.html", "value": 4725.708403902495}, {"lowerIsBetter": false, "replicates": [841.1336323586701, 851.5401683091131, 854.226924633207, 861.2162931732125, 879.8680197970303, 13679.726405471885, 13997.160170389783, 14065.859341406584, 14080.084794488352, 14097.78853317201, 13343.53297634583, 13455.865441345584, 13471.259080750579, 13471.932640336809, 13474.663133421669, 674.1808702426563, 680.2075581947025, 820.1183727492939, 821.57278215328, 835.6490274084869, 814.2752949874587, 816.244973399606, 821.2321479416764, 821.9835603287961, 822.5558198572763, 707.8902770070647, 870.1342164546286, 875.2735229759317, 875.5053394831931, 876.5748611923212, 709.3296834491408, 851.9435899484656, 863.0420233540796, 871.398734872942, 871.4640496094919, 645.8417687666505, 646.2923099206362, 647.6340867409898, 647.7311915555039, 648.176815444383, 13043.739125217537, 13325.400356983959, 13352.799708004388, 13366.198028118344, 13370.598882033555, 11992.28046317215, 12109.15235933485, 12114.757704845853, 12261.754764904741, 12285.69285767854, 10247.231457640706, 10427.478626068667, 10760.892391076068, 10840.67477975662, 10950.178736594708, 3613.313470440608, 3649.105969037603, 3680.2455496623397, 3768.1898391845884, 3770.811459427018, 45894.77052614749, 47798.0, 47806.760966195296, 47826.0, 47856.76071619619, 9701.805963880683, 9706.660266890625, 10130.44282564466, 10314.432706201082, 10360.792784144274, 17674.5581360467, 17679.38122165718, 17689.823101768816, 17708.203130859143, 17714.0, 7471.327580517779, 7500.62496875165, 7538.585377804164, 7542.698292068256, 7558.811029724191, 4175.498940127143, 4198.202341555095, 4388.4953230378915, 4520.276755719069, 4532.546745325441, 2954.7340739333563, 2975.2561859535117, 2996.4306781711407, 3002.939941201164, 3006.188329151161, 536.5117742854062, 547.9726013699299, 553.9944600554023, 554.4123229376873, 555.0093083845397, 623.4856243599049, 639.3670266436195, 682.757621044522, 696.6586372677351, 704.4470090978557, 8117.837643247102, 8905.154010369135, 8945.776355591162, 8965.50689712072, 9062.410943288796, 533.6531254684486, 595.5860676829562, 683.1904193530582, 710.1442761472414, 726.3825748114166, 3859.421086836997, 4055.533613634411, 4104.281750693676, 4187.953011747063, 4224.5353011168745, 54576.0, 55830.0, 55909.72045139748, 58805.117923231184, 59432.0, 47218.0, 48350.27474587884, 48788.512114878395, 49732.254016189785, 50642.74678626583, 45695.54304456979, 46767.76616116898, 46797.0, 47279.05441891143, 48100.5189948096, 8596.097409771884, 8620.741377758677, 8750.737477875675, 8896.733098007071, 9092.227160691415, 34180.48729269113, 34547.82726086354, 35242.82378588091, 35337.46993795044, 36124.81937590295, 45725.0, 46309.0, 46317.305240422094, 46967.76516117534, 47183.0, 10782.211495307703, 10979.615713449992, 11430.0, 11564.826527602261, 11894.821577676168, 11666.0, 11757.823632645346, 12298.692532686755, 12421.93789031049, 12502.937485312515, 11369.374684392438, 11580.536778528765, 11662.53349865996, 11945.522179112739, 12057.216280941711, 11272.267302625303, 11643.88356116462, 11703.882961170279, 11890.762184756084, 12078.21491603043, 11163.330200188015, 11676.182667213214, 11697.356645384585, 11746.471408786796, 12006.2195957266, 9465.0, 9692.951535242279, 9716.514174291398, 9913.752156196153, 9925.553350099119, 8346.95758152246, 8922.55387230623, 9019.66817705829, 10039.552761001227, 10044.146247569039], "unit": "score", "name": "yui.html", "value": 6346.925999241975}], "name": "dromaeo_css", "value": 6795.8792240202965}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 111.0, 100.0, 109.0, 109.0, 115.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [159.0, 126.0, 153.0, 164.0, 130.0, 155.0, 147.0, 125.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 85.0, 92.0, 81.0, 72.0, 73.0, 93.0, 96.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 146.0, 94.0, 94.0, 93.0, 140.0, 93.0, 94.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 144.0, 145.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 57.0, 58.0, 57.0, 58.0, 59.0, 59.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 84.0, 84.0, 84.0, 84.0, 91.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [129.0, 115.0, 131.0, 128.0, 117.0, 116.0, 121.0, 116.0, 113.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [141.0, 153.0, 150.0, 151.0, 150.0, 141.0, 150.0, 142.0, 142.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 68.0, 65.0, 67.0, 68.0, 69.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1497.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.1188905800778], "unit": "score", "name": "Richards", "value": 208.74072599999994}, {"lowerIsBetter": false, "replicates": [188.7504718761797], "unit": "score", "name": "DeltaBlue", "value": 350.2931640000001}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [2070.3933747412007], "unit": "score", "name": "RayTrace", "value": 357.41468700000013}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [11988.095238095239], "unit": "score", "name": "Boyer", "value": 55.59373584905661}, {"lowerIsBetter": false, "replicates": [25400.0], "unit": "score", "name": "RegExp", "value": 35.86555118110237}, {"lowerIsBetter": false, "replicates": [688.0546075085324], "unit": "score", "name": "Splay", "value": 118.43682043650792}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19589.820037920566}]} 05:05:47 INFO - RETURN: dromaeo_css: 6795.88 05:05:47 INFO - RETURN: kraken: 1497.80 05:05:47 INFO - RETURN: v8_7: 19589.82 05:05:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19589.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1497.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6795.88"}}} 05:05:47 INFO - Return code: 0 05:05:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:05:47 INFO - # TBPL SUCCESS # 05:05:47 INFO - Running post-action listener: _resource_record_post_action 05:05:47 INFO - Running post-run listener: _resource_record_post_run 05:05:48 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 545087488; Read time: 216; Write time: 383656 05:05:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 233648128; Read time: 156; Write time: 188356 05:05:48 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 310575104; Read time: 60; Write time: 195244 05:05:48 INFO - Running post-run listener: _upload_blobber_files 05:05:48 INFO - Blob upload gear active. 05:05:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:05:48 INFO - Copying logs to upload dir... 05:05:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.181095 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-18 05:05:47.868505) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:05:47.872525) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009978 build_url: 'https://queue.taskcluster.net/v1/task/__yRAme4SIOtPm9bfo0JMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 05:05:47.924445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:05:47.924798) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450440868.923279-731003952 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 05:05:47.975416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:05:47.975764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 05:05:47.976126) ========= ========= Total master_lag: 0.25 =========