builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1450633773.39 results: success (0) buildid: 20151220073155 builduid: a6404afcf5cc46b78df3656778396aae revision: e1a98377eb38679bda820456ee6d20bdc17eaa8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.393802) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.394194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.394499) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006469 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.449268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.449566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.560074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.560361) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.613620) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.613877) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.614233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.614518) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-20 09:49:33-- 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% 64.4M=0s 2015-12-20 09:49:33 (64.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179879 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.821916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.822381) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016662 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.880376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:33.880898) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e1a98377eb38679bda820456ee6d20bdc17eaa8e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e1a98377eb38679bda820456ee6d20bdc17eaa8e --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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-20 09:49:34,052 truncating revision to first 12 chars 2015-12-20 09:49:34,052 Setting DEBUG logging. 2015-12-20 09:49:34,052 attempt 1/10 2015-12-20 09:49:34,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e1a98377eb38?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-20 09:49:34,295 unpacking tar archive at: mozilla-inbound-e1a98377eb38/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557004 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:34.467220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:34.467668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:34.500181) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:34.500562) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-20 09:49:34.501406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-20 09:49:34.501693) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:34 INFO - MultiFileLogger online at 20151220 09:49:34 in /builds/slave/test-pgo 09:49:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:49:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:49:34 INFO - {'append_to_log': False, 09:49:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:49:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:49:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:49:34 INFO - 'branch': 'Mozilla-Inbound', 09:49:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:34 INFO - 'config_files': ('talos/linux_config.py',), 09:49:34 INFO - 'default_actions': ('clobber', 09:49:34 INFO - 'read-buildbot-config', 09:49:34 INFO - 'download-and-extract', 09:49:34 INFO - 'populate-webroot', 09:49:34 INFO - 'create-virtualenv', 09:49:34 INFO - 'install', 09:49:34 INFO - 'run-tests'), 09:49:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:34 INFO - 'download_minidump_stackwalk': True, 09:49:34 INFO - 'download_symbols': 'ondemand', 09:49:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:34 INFO - 'installer_path': 'installer.exe', 09:49:34 INFO - 'log_level': 'info', 09:49:34 INFO - 'log_name': 'talos', 09:49:34 INFO - 'log_to_console': True, 09:49:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:34 INFO - 'opt_config_files': (), 09:49:34 INFO - 'pip_index': False, 09:49:34 INFO - 'sps_profile': False, 09:49:34 INFO - 'sps_profile_interval': 0, 09:49:34 INFO - 'suite': 'dromaeojs', 09:49:34 INFO - 'system_bits': '64', 09:49:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:34 INFO - 'title': 'talos-linux64-ix-003', 09:49:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:34 INFO - 'use_talos_json': True, 09:49:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:49:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:34 INFO - 'work_dir': 'build'} 09:49:34 INFO - ##### 09:49:34 INFO - ##### Running clobber step. 09:49:34 INFO - ##### 09:49:34 INFO - Running pre-action listener: _resource_record_pre_action 09:49:34 INFO - Running main action method: clobber 09:49:34 INFO - rmtree: /builds/slave/test-pgo/build 09:49:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:49:35 INFO - Running post-action listener: _resource_record_post_action 09:49:35 INFO - ##### 09:49:35 INFO - ##### Running read-buildbot-config step. 09:49:35 INFO - ##### 09:49:35 INFO - Running pre-action listener: _resource_record_pre_action 09:49:35 INFO - Running main action method: read_buildbot_config 09:49:35 INFO - Using buildbot properties: 09:49:35 INFO - { 09:49:35 INFO - "project": "", 09:49:35 INFO - "product": "firefox", 09:49:35 INFO - "script_repo_revision": "production", 09:49:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:49:35 INFO - "repository": "", 09:49:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:49:35 INFO - "buildid": "20151220073155", 09:49:35 INFO - "pgo_build": "True", 09:49:35 INFO - "basedir": "/builds/slave/test-pgo", 09:49:35 INFO - "buildnumber": 563, 09:49:35 INFO - "slavename": "talos-linux64-ix-003", 09:49:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:49:35 INFO - "platform": "ubuntu64_hw", 09:49:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:49:35 INFO - "branch": "mozilla-inbound", 09:49:35 INFO - "repo_path": "integration/mozilla-inbound", 09:49:35 INFO - "revision": "e1a98377eb38679bda820456ee6d20bdc17eaa8e", 09:49:35 INFO - "stage_platform": "linux64-pgo", 09:49:35 INFO - "builduid": "a6404afcf5cc46b78df3656778396aae", 09:49:35 INFO - "slavebuilddir": "test" 09:49:35 INFO - } 09:49:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 09:49:35 INFO - Running post-action listener: _resource_record_post_action 09:49:35 INFO - ##### 09:49:35 INFO - ##### Running download-and-extract step. 09:49:35 INFO - ##### 09:49:35 INFO - Running pre-action listener: _resource_record_pre_action 09:49:35 INFO - Running main action method: download_and_extract 09:49:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:49: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')]} 09:49:35 INFO - https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/test_packages.json 09:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/test_packages.json 09:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:49:40 INFO - Downloaded 1302 bytes. 09:49:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:49:40 INFO - Using the following test package requirements: 09:49:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'jsshell-linux-x86_64.zip'], 09:49:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:49:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:49:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 09:49:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 09:49:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49:40 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')]} 09:49:40 INFO - https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:43 INFO - Downloaded 23175075 bytes. 09:49:43 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 09:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:43 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 09:49:44 INFO - Return code: 0 09:49:44 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 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:44 INFO - https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:45 INFO - Downloaded 23175075 bytes. 09:49:45 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 09:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 09:49:45 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 09:49:46 INFO - Return code: 0 09:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:46 INFO - https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:49:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:48 INFO - Downloaded 11132277 bytes. 09:49:48 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 09:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 09:49:48 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 09:49:48 INFO - Return code: 0 09:49:48 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')]} 09:49:48 INFO - https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/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 09:49:50 INFO - Downloaded 54952015 bytes. 09:49:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:50 INFO - mkdir: /builds/slave/test-pgo/properties 09:49:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:49:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:49:50 INFO - Contents: 09:49:50 INFO - build_url:https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 09:49:50 INFO - Running post-action listener: _resource_record_post_action 09:49:50 INFO - Running post-action listener: set_extra_try_arguments 09:49:50 INFO - ##### 09:49:50 INFO - ##### Running populate-webroot step. 09:49:50 INFO - ##### 09:49:50 INFO - Running pre-action listener: _resource_record_pre_action 09:49:50 INFO - Running main action method: populate_webroot 09:49:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:50 INFO - '--tppagecycles', 09:49:50 INFO - '7'], 09:49:50 INFO - 'tests': ['tsvgm']}}, 09:49:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:49:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'tests': ['damp', 'tps']}, 09:49:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['damp', 'tps']}, 09:49:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:49:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:50 INFO - 'other': {'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'other_l64': {'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'other_nol64': {'tests': ['a11yr', 09:49:50 INFO - 'ts_paint', 09:49:50 INFO - 'tpaint', 09:49:50 INFO - 'sessionrestore', 09:49:50 INFO - 'sessionrestore_no_auto_restore']}, 09:49:50 INFO - 'svgr': {'tests': ['tsvgx', 09:49:50 INFO - 'tsvgr_opacity', 09:49:50 INFO - 'tart', 09:49:50 INFO - 'tscrollx', 09:49:50 INFO - 'cart']}, 09:49:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['tsvgx', 09:49:50 INFO - 'tsvgr_opacity', 09:49:50 INFO - 'tart', 09:49:50 INFO - 'tscrollx', 09:49:50 INFO - 'cart']}, 09:49:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'tests': ['tp5o']}, 09:49:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'talos_options': ['--e10s'], 09:49:50 INFO - 'tests': ['tp5o']}, 09:49:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'talos_options': ['--xperf_path', 09:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:50 INFO - 'tests': ['tp5n']}, 09:49:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:50 INFO - 'talos_options': ['--e10s', 09:49:50 INFO - '--xperf_path', 09:49:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:50 INFO - 'tests': ['tp5n']}}, 09:49:50 INFO - 'talos.zip': {'path': '', 09:49:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:50 INFO - Running post-action listener: _resource_record_post_action 09:49:50 INFO - ##### 09:49:50 INFO - ##### Running create-virtualenv step. 09:49:50 INFO - ##### 09:49:50 INFO - Running pre-action listener: _resource_record_pre_action 09:49:50 INFO - Running main action method: create_virtualenv 09:49:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:49:50 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 09:49:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:49:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:50 INFO - Using real prefix '/usr' 09:49:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:49:51 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:53 INFO - Installing pip.................done. 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:53 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:49:53 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 09:49:53 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 09:49:53 INFO - Using env: {'DISPLAY': ':0', 09:49:53 INFO - 'HOME': '/home/cltbld', 09:49:53 INFO - 'LANG': 'en_US.UTF-8', 09:49:53 INFO - 'LANGUAGE': 'en_US:en', 09:49:53 INFO - 'LOGNAME': 'cltbld', 09:49:53 INFO - 'MAIL': '/var/mail/cltbld', 09:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:53 INFO - 'MOZ_NO_REMOTE': '1', 09:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:53 INFO - 'NO_EM_RESTART': '1', 09:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:53 INFO - 'SHELL': '/bin/bash', 09:49:53 INFO - 'SHLVL': '1', 09:49:53 INFO - 'TERM': 'linux', 09:49:53 INFO - 'TMOUT': '86400', 09:49:53 INFO - 'USER': 'cltbld', 09:49:53 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:53 INFO - '_': '/tools/buildbot/bin/python'} 09:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:53 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 09:49:53 INFO - Cleaning up... 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:54 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:49:54 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 09:49:54 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 09:49:54 INFO - Using env: {'DISPLAY': ':0', 09:49:54 INFO - 'HOME': '/home/cltbld', 09:49:54 INFO - 'LANG': 'en_US.UTF-8', 09:49:54 INFO - 'LANGUAGE': 'en_US:en', 09:49:54 INFO - 'LOGNAME': 'cltbld', 09:49:54 INFO - 'MAIL': '/var/mail/cltbld', 09:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:54 INFO - 'MOZ_NO_REMOTE': '1', 09:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:54 INFO - 'NO_EM_RESTART': '1', 09:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:54 INFO - 'SHELL': '/bin/bash', 09:49:54 INFO - 'SHLVL': '1', 09:49:54 INFO - 'TERM': 'linux', 09:49:54 INFO - 'TMOUT': '86400', 09:49:54 INFO - 'USER': 'cltbld', 09:49:54 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:54 INFO - '_': '/tools/buildbot/bin/python'} 09:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:54 INFO - Downloading/unpacking psutil>=0.7.1 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:49:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:49:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:56 INFO - Installing collected packages: psutil 09:49:56 INFO - Running setup.py install for psutil 09:49:56 INFO - building 'psutil._psutil_linux' extension 09:49:56 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 09:49:56 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 09:49:56 INFO - building 'psutil._psutil_posix' extension 09:49:56 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 09:49:56 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 09:49:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:56 INFO - Successfully installed psutil 09:49:56 INFO - Cleaning up... 09:49:56 INFO - Return code: 0 09:49:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:49:56 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')]} 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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')]} 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:56 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:49:56 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 09:49:56 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 09:49:56 INFO - Using env: {'DISPLAY': ':0', 09:49:56 INFO - 'HOME': '/home/cltbld', 09:49:56 INFO - 'LANG': 'en_US.UTF-8', 09:49:56 INFO - 'LANGUAGE': 'en_US:en', 09:49:56 INFO - 'LOGNAME': 'cltbld', 09:49:56 INFO - 'MAIL': '/var/mail/cltbld', 09:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:56 INFO - 'MOZ_NO_REMOTE': '1', 09:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:56 INFO - 'NO_EM_RESTART': '1', 09:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:56 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:56 INFO - 'SHELL': '/bin/bash', 09:49:56 INFO - 'SHLVL': '1', 09:49:56 INFO - 'TERM': 'linux', 09:49:56 INFO - 'TMOUT': '86400', 09:49:56 INFO - 'USER': 'cltbld', 09:49:56 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:56 INFO - '_': '/tools/buildbot/bin/python'} 09:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:56 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 09:49:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:49:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:58 INFO - Installing collected packages: mozsystemmonitor 09:49:58 INFO - Running setup.py install for mozsystemmonitor 09:49:58 INFO - Successfully installed mozsystemmonitor 09:49:58 INFO - Cleaning up... 09:49:58 INFO - Return code: 0 09:49:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:49: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')]} 09:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:49: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:49: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 blobuploader==1.2.4 09:49:58 INFO - Using env: {'DISPLAY': ':0', 09:49:58 INFO - 'HOME': '/home/cltbld', 09:49:58 INFO - 'LANG': 'en_US.UTF-8', 09:49:58 INFO - 'LANGUAGE': 'en_US:en', 09:49:58 INFO - 'LOGNAME': 'cltbld', 09:49:58 INFO - 'MAIL': '/var/mail/cltbld', 09:49:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:58 INFO - 'MOZ_NO_REMOTE': '1', 09:49:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:58 INFO - 'NO_EM_RESTART': '1', 09:49:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:58 INFO - 'SHELL': '/bin/bash', 09:49:58 INFO - 'SHLVL': '1', 09:49:58 INFO - 'TERM': 'linux', 09:49:58 INFO - 'TMOUT': '86400', 09:49:58 INFO - 'USER': 'cltbld', 09:49:58 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:49:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:58 INFO - '_': '/tools/buildbot/bin/python'} 09:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:58 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:00 INFO - Downloading blobuploader-1.2.4.tar.gz 09:50:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:50:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:50:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:02 INFO - Downloading docopt-0.6.1.tar.gz 09:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:50:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:50:02 INFO - Running setup.py install for blobuploader 09:50:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:50:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:50:02 INFO - Running setup.py install for requests 09:50:02 INFO - Running setup.py install for docopt 09:50:02 INFO - Successfully installed blobuploader requests docopt 09:50:02 INFO - Cleaning up... 09:50:02 INFO - Return code: 0 09:50:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:02 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')]} 09:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:02 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')]} 09:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:02 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:50:02 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 09:50:02 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 09:50:02 INFO - Using env: {'DISPLAY': ':0', 09:50:02 INFO - 'HOME': '/home/cltbld', 09:50:02 INFO - 'LANG': 'en_US.UTF-8', 09:50:02 INFO - 'LANGUAGE': 'en_US:en', 09:50:02 INFO - 'LOGNAME': 'cltbld', 09:50:02 INFO - 'MAIL': '/var/mail/cltbld', 09:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:02 INFO - 'MOZ_NO_REMOTE': '1', 09:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:02 INFO - 'NO_EM_RESTART': '1', 09:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:02 INFO - 'SHELL': '/bin/bash', 09:50:02 INFO - 'SHLVL': '1', 09:50:02 INFO - 'TERM': 'linux', 09:50:02 INFO - 'TMOUT': '86400', 09:50:02 INFO - 'USER': 'cltbld', 09:50:02 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:02 INFO - '_': '/tools/buildbot/bin/python'} 09:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:02 INFO - Running setup.py (path:/tmp/pip-oj_d5y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:03 INFO - Running setup.py (path:/tmp/pip-SVzfoM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:03 INFO - Running setup.py (path:/tmp/pip-DTnfUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:03 INFO - Running setup.py (path:/tmp/pip-D_LPUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:03 INFO - Running setup.py (path:/tmp/pip-3709lW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:03 INFO - Running setup.py (path:/tmp/pip-KRiVj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:03 INFO - Running setup.py (path:/tmp/pip-wtIqxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:03 INFO - Running setup.py (path:/tmp/pip-S00mwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:03 INFO - Running setup.py (path:/tmp/pip-vi5Yrh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:03 INFO - Running setup.py (path:/tmp/pip-MejOc4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:03 INFO - Running setup.py (path:/tmp/pip-AjqaTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:03 INFO - Running setup.py (path:/tmp/pip-QavAe1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:03 INFO - Running setup.py (path:/tmp/pip-YboLRF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:03 INFO - Running setup.py (path:/tmp/pip-CFJSoT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:03 INFO - Running setup.py (path:/tmp/pip-LSwmNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:04 INFO - Running setup.py (path:/tmp/pip-tqQ4A6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:04 INFO - Running setup.py (path:/tmp/pip-424cWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:04 INFO - Running setup.py install for manifestparser 09:50:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Running setup.py install for mozcrash 09:50:04 INFO - Running setup.py install for mozdebug 09:50:04 INFO - Running setup.py install for mozdevice 09:50:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Running setup.py install for mozfile 09:50:04 INFO - Running setup.py install for mozhttpd 09:50:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Running setup.py install for mozinfo 09:50:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Running setup.py install for mozInstall 09:50:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:50:04 INFO - Running setup.py install for mozleak 09:50:05 INFO - Running setup.py install for mozlog 09:50:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Running setup.py install for moznetwork 09:50:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Running setup.py install for mozprocess 09:50:05 INFO - Running setup.py install for mozprofile 09:50:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Running setup.py install for mozrunner 09:50:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Running setup.py install for mozscreenshot 09:50:05 INFO - Running setup.py install for moztest 09:50:05 INFO - Running setup.py install for mozversion 09:50:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:50:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:05 INFO - Cleaning up... 09:50:05 INFO - Return code: 0 09:50:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:05 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:50:05 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 09:50:05 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 09:50:05 INFO - Using env: {'DISPLAY': ':0', 09:50:05 INFO - 'HOME': '/home/cltbld', 09:50:05 INFO - 'LANG': 'en_US.UTF-8', 09:50:05 INFO - 'LANGUAGE': 'en_US:en', 09:50:05 INFO - 'LOGNAME': 'cltbld', 09:50:05 INFO - 'MAIL': '/var/mail/cltbld', 09:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:05 INFO - 'MOZ_NO_REMOTE': '1', 09:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:05 INFO - 'NO_EM_RESTART': '1', 09:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:05 INFO - 'SHELL': '/bin/bash', 09:50:05 INFO - 'SHLVL': '1', 09:50:05 INFO - 'TERM': 'linux', 09:50:05 INFO - 'TMOUT': '86400', 09:50:05 INFO - 'USER': 'cltbld', 09:50:05 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:05 INFO - '_': '/tools/buildbot/bin/python'} 09:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:06 INFO - Running setup.py (path:/tmp/pip-pYWEmW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:06 INFO - Running setup.py (path:/tmp/pip-nQoTjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:06 INFO - Running setup.py (path:/tmp/pip-EwBDDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:06 INFO - Running setup.py (path:/tmp/pip-XAcMgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:06 INFO - Running setup.py (path:/tmp/pip-WSuwGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:06 INFO - Running setup.py (path:/tmp/pip-N450H3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:06 INFO - Running setup.py (path:/tmp/pip-xemREC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:06 INFO - Running setup.py (path:/tmp/pip-IC_Lfv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:06 INFO - Running setup.py (path:/tmp/pip-VpxLSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:06 INFO - Running setup.py (path:/tmp/pip-1bV9yG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:06 INFO - Running setup.py (path:/tmp/pip-z85wAA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:50:06 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)) 09:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:06 INFO - Running setup.py (path:/tmp/pip-IyFIEv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:50:07 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)) 09:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:07 INFO - Running setup.py (path:/tmp/pip-cFdy7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:07 INFO - Running setup.py (path:/tmp/pip-7TKsjd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:50:07 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)) 09:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:07 INFO - Running setup.py (path:/tmp/pip-dhQiGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:50:07 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)) 09:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:07 INFO - Running setup.py (path:/tmp/pip-tCiwMY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:50:07 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)) 09:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:07 INFO - Running setup.py (path:/tmp/pip-pC8Tso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:50:07 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)) 09:50:07 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)) 09:50:07 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)) 09:50:07 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)) 09:50:07 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)) 09:50:07 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)) 09:50:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:50:07 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 09:50:07 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 09:50:07 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 09:50:07 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 09:50:07 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 09:50:07 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 09:50:09 INFO - Downloading blessings-1.5.1.tar.gz 09:50:09 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 09:50:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:09 INFO - Installing collected packages: blessings 09:50:09 INFO - Running setup.py install for blessings 09:50:09 INFO - Successfully installed blessings 09:50:09 INFO - Cleaning up... 09:50:09 INFO - Return code: 0 09:50:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:50:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:09 INFO - Reading from file tmpfile_stdout 09:50:09 INFO - Current package versions: 09:50:09 INFO - argparse == 1.2.1 09:50:09 INFO - blessings == 1.5.1 09:50:09 INFO - blobuploader == 1.2.4 09:50:09 INFO - docopt == 0.6.1 09:50:09 INFO - manifestparser == 1.1 09:50:09 INFO - mozInstall == 1.12 09:50:09 INFO - mozcrash == 0.16 09:50:09 INFO - mozdebug == 0.1 09:50:09 INFO - mozdevice == 0.47 09:50:09 INFO - mozfile == 1.2 09:50:09 INFO - mozhttpd == 0.7 09:50:09 INFO - mozinfo == 0.9 09:50:09 INFO - mozleak == 0.1 09:50:09 INFO - mozlog == 3.1 09:50:09 INFO - moznetwork == 0.27 09:50:09 INFO - mozprocess == 0.22 09:50:09 INFO - mozprofile == 0.28 09:50:09 INFO - mozrunner == 6.11 09:50:09 INFO - mozscreenshot == 0.1 09:50:09 INFO - mozsystemmonitor == 0.0 09:50:09 INFO - moztest == 0.7 09:50:09 INFO - mozversion == 1.4 09:50:09 INFO - psutil == 3.1.1 09:50:09 INFO - requests == 1.2.3 09:50:09 INFO - wsgiref == 0.1.2 09:50:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:50:09 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')]} 09:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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')]} 09:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:50:09 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 09:50:09 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 09:50:09 INFO - Using env: {'DISPLAY': ':0', 09:50:09 INFO - 'HOME': '/home/cltbld', 09:50:09 INFO - 'LANG': 'en_US.UTF-8', 09:50:09 INFO - 'LANGUAGE': 'en_US:en', 09:50:09 INFO - 'LOGNAME': 'cltbld', 09:50:09 INFO - 'MAIL': '/var/mail/cltbld', 09:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:09 INFO - 'MOZ_NO_REMOTE': '1', 09:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:09 INFO - 'NO_EM_RESTART': '1', 09:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:09 INFO - 'SHELL': '/bin/bash', 09:50:09 INFO - 'SHLVL': '1', 09:50:09 INFO - 'TERM': 'linux', 09:50:09 INFO - 'TMOUT': '86400', 09:50:09 INFO - 'USER': 'cltbld', 09:50:09 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:09 INFO - '_': '/tools/buildbot/bin/python'} 09:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:50:09 INFO - Cleaning up... 09:50:09 INFO - Return code: 0 09:50:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:50:09 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')]} 09:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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')]} 09:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:09 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:50:09 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 09:50:09 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 09:50:09 INFO - Using env: {'DISPLAY': ':0', 09:50:09 INFO - 'HOME': '/home/cltbld', 09:50:09 INFO - 'LANG': 'en_US.UTF-8', 09:50:09 INFO - 'LANGUAGE': 'en_US:en', 09:50:09 INFO - 'LOGNAME': 'cltbld', 09:50:09 INFO - 'MAIL': '/var/mail/cltbld', 09:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:09 INFO - 'MOZ_NO_REMOTE': '1', 09:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:09 INFO - 'NO_EM_RESTART': '1', 09:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:09 INFO - 'SHELL': '/bin/bash', 09:50:09 INFO - 'SHLVL': '1', 09:50:09 INFO - 'TERM': 'linux', 09:50:09 INFO - 'TMOUT': '86400', 09:50:09 INFO - 'USER': 'cltbld', 09:50:09 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:09 INFO - '_': '/tools/buildbot/bin/python'} 09:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:10 INFO - Downloading/unpacking jsonschema 09:50:10 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 09:50:10 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 09:50:10 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 09:50:10 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 09:50:10 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 09:50:10 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 09:50:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:50:11 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 09:50:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:50:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:50:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:50:12 INFO - warning: no files found matching '*.txt' 09:50:12 INFO - no previously-included directories found matching 'build' 09:50:12 INFO - no previously-included directories found matching 'dist' 09:50:12 INFO - no previously-included directories found matching '.git*' 09:50:12 INFO - Installing collected packages: jsonschema, functools32 09:50:12 INFO - Running setup.py install for functools32 09:50:12 INFO - warning: no files found matching '*.txt' 09:50:12 INFO - no previously-included directories found matching 'build' 09:50:12 INFO - no previously-included directories found matching 'dist' 09:50:12 INFO - no previously-included directories found matching '.git*' 09:50:12 INFO - Successfully installed jsonschema functools32 09:50:12 INFO - Cleaning up... 09:50:12 INFO - Return code: 0 09:50:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:12 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 0x7f416ae2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ef360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, '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': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', '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 09:50:12 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 09:50:12 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 09:50:12 INFO - Using env: {'DISPLAY': ':0', 09:50:12 INFO - 'HOME': '/home/cltbld', 09:50:12 INFO - 'LANG': 'en_US.UTF-8', 09:50:12 INFO - 'LANGUAGE': 'en_US:en', 09:50:12 INFO - 'LOGNAME': 'cltbld', 09:50:12 INFO - 'MAIL': '/var/mail/cltbld', 09:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:12 INFO - 'MOZ_NO_REMOTE': '1', 09:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:12 INFO - 'NO_EM_RESTART': '1', 09:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:12 INFO - 'SHELL': '/bin/bash', 09:50:12 INFO - 'SHLVL': '1', 09:50:12 INFO - 'TERM': 'linux', 09:50:12 INFO - 'TMOUT': '86400', 09:50:12 INFO - 'USER': 'cltbld', 09:50:12 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:12 INFO - '_': '/tools/buildbot/bin/python'} 09:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:12 INFO - Downloading/unpacking flake8 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:12 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 09:50:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:50:14 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 09:50:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:50:14 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 09:50:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:14 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 09:50:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:14 INFO - no previously-included directories found matching 'docs/_build' 09:50:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:50:14 INFO - Running setup.py install for pep8 09:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:50:14 INFO - no previously-included directories found matching 'docs/_build' 09:50:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:50:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:50:14 INFO - Cleaning up... 09:50:14 INFO - Return code: 0 09:50:14 INFO - Running post-action listener: _resource_record_post_action 09:50:14 INFO - Running post-action listener: _start_resource_monitoring 09:50:15 INFO - Starting resource monitoring. 09:50:15 INFO - ##### 09:50:15 INFO - ##### Running install step. 09:50:15 INFO - ##### 09:50:15 INFO - Running pre-action listener: _resource_record_pre_action 09:50:15 INFO - Running main action method: install 09:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:50:15 INFO - Reading from file tmpfile_stdout 09:50:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:50:15 INFO - Reading from file tmpfile_stdout 09:50:15 INFO - Output received: 09:50:15 INFO - Usage: mozinstall [options] installer 09:50:15 INFO - Options: 09:50:15 INFO - -h, --help show this help message and exit 09:50:15 INFO - -d DEST, --destination=DEST 09:50:15 INFO - Directory to install application into. [default: 09:50:15 INFO - "/builds/slave/test-pgo"] 09:50:15 INFO - --app=APP Application being installed. [default: firefox] 09:50:15 INFO - mkdir: /builds/slave/test-pgo/build/application 09:50:15 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'] 09:50:15 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 09:50:31 INFO - Reading from file tmpfile_stdout 09:50:31 INFO - Output received: 09:50:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:50:31 INFO - Running post-action listener: _resource_record_post_action 09:50:31 INFO - ##### 09:50:31 INFO - ##### Running run-tests step. 09:50:31 INFO - ##### 09:50:31 INFO - Running pre-action listener: _resource_record_pre_action 09:50:31 INFO - Running main action method: run_tests 09:50:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:50:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:50:31 INFO - Python 2.7.3 09:50:31 INFO - Return code: 0 09:50:31 INFO - grabbing minidump binary from tooltool 09:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:31 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 0x247e540>, '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 0x247f440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x247f8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:50:31 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 09:50:31 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 09:50:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:31 INFO - Return code: 0 09:50:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:50:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:50:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:50:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:50:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:50:32 INFO - Return code: 0 09:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 09:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 09:50:32 INFO - Using env: {'DISPLAY': ':0', 09:50:32 INFO - 'HOME': '/home/cltbld', 09:50:32 INFO - 'LANG': 'en_US.UTF-8', 09:50:32 INFO - 'LANGUAGE': 'en_US:en', 09:50:32 INFO - 'LOGNAME': 'cltbld', 09:50:32 INFO - 'MAIL': '/var/mail/cltbld', 09:50:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:32 INFO - 'MOZ_NO_REMOTE': '1', 09:50:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:32 INFO - 'NO_EM_RESTART': '1', 09:50:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:50:32 INFO - 'SHELL': '/bin/bash', 09:50:32 INFO - 'SHLVL': '1', 09:50:32 INFO - 'TERM': 'linux', 09:50:32 INFO - 'TMOUT': '86400', 09:50:32 INFO - 'USER': 'cltbld', 09:50:32 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1450625372.56614-57961688', 09:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:32 INFO - '_': '/tools/buildbot/bin/python'} 09:50:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:50:32 INFO - mozversion application_buildid: 20151220073155 09:50:32 INFO - mozversion application_changeset: e1a98377eb38679bda820456ee6d20bdc17eaa8e 09:50:32 INFO - mozversion application_display_name: Nightly 09:50:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:32 INFO - mozversion application_name: Firefox 09:50:32 INFO - mozversion application_remotingname: firefox 09:50:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:50:32 INFO - mozversion application_vendor: Mozilla 09:50:32 INFO - mozversion application_version: 46.0a1 09:50:32 INFO - mozversion platform_buildid: 20151220073155 09:50:32 INFO - mozversion platform_changeset: e1a98377eb38679bda820456ee6d20bdc17eaa8e 09:50:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:50:32 INFO - mozversion platform_version: 46.0a1 09:50:32 INFO - using testdate: 1450633832 09:50:32 INFO - actual date: 1450633832 09:50:32 INFO - starting webserver on 'localhost:60752' 09:50:32 INFO - SUITE-START | Running 3 tests 09:50:32 INFO - TEST-START | dromaeo_css 09:50:32 INFO - operating with platform_type : linux_ 09:50:32 INFO - Initialising browser for dromaeo_css test... 09:50:32 INFO - TEST-INFO | started process 7863 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvCyeiZ/profile http://localhost:60752/getInfo.html) 09:50:36 INFO - PROCESS | 7863 | __metrics Screen width/height:1600/1200 09:50:36 INFO - PROCESS | 7863 | colorDepth:24 09:50:36 INFO - PROCESS | 7863 | Browser inner width/height: 1024/697 09:50:36 INFO - PROCESS | 7863 | __metrics 09:50:36 INFO - PROCESS | 7863 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:50:36 INFO - PROCESS | 7863 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:38 INFO - TEST-INFO | 7863: exit 0 09:50:38 INFO - Browser initialized. 09:50:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:38 INFO - TEST-INFO | started process 7955 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvCyeiZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:49 INFO - PROCESS | 7955 | RSS: Main: 149299200 09:50:49 INFO - PROCESS | 7955 | 09:51:41 INFO - PROCESS | 7955 | 1450633901261 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] 09:53:49 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60752/tests/dromaeo/cssquery-ext.html) 09:53:50 INFO - PROCESS | 7955 | RSS: Main: 277008384 09:53:50 INFO - PROCESS | 7955 | 09:56:53 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-ext.html (next: http://localhost:60752/tests/dromaeo/cssquery-jquery.html) 09:56:54 INFO - PROCESS | 7955 | RSS: Main: 227319808 09:56:54 INFO - PROCESS | 7955 | 09:59:55 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60752/tests/dromaeo/cssquery-mootools.html) 09:59:56 INFO - PROCESS | 7955 | RSS: Main: 235114496 09:59:56 INFO - PROCESS | 7955 | 10:02:58 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60752/tests/dromaeo/cssquery-prototype.html) 10:02:58 INFO - PROCESS | 7955 | RSS: Main: 212598784 10:02:58 INFO - PROCESS | 7955 | 10:06:01 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60752/tests/dromaeo/cssquery-yui.html) 10:06:01 INFO - PROCESS | 7955 | RSS: Main: 216707072 10:06:01 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | Cycle 1(1): loaded http://localhost:60752/tests/dromaeo/cssquery-yui.html (next: http://localhost:60752/tests/dromaeo/cssquery-dojo.html) 10:09:04 INFO - PROCESS | 7955 | RSS: Main: 263901184 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | __start_tp_report 10:09:04 INFO - PROCESS | 7955 | _x_x_mozilla_page_load 10:09:04 INFO - PROCESS | 7955 | _x_x_mozilla_page_load_details 10:09:04 INFO - PROCESS | 7955 | |i|pagename|runs| 10:09:04 INFO - PROCESS | 7955 | |0;dojo.html;3116.376724655069;3154.02225310154;3176.841157942102;3197.136773071271;3224.1294850390386;5039.672421292623;5190.195519694454;5198.792048318068;5272.58740911685;5285.920711189326;5176.042432150055;5183.06704793138;5197.038547868647;5243.737813109339;5263.421023687391;4568.474625418086;4693.530646935314;4725.432948046231;4775;4838.564529192372;4680.485146633868;4785.90428191436;4841.394825646794;4850.733209673466;5022.096022715909;4612.97693511532;4695.483496815347;4716.834910778106;4729.125111854318;4742.359781429532;4822.6624136310475;4826.734529600871;4834.806607735686;4845.224764037773;4876.926846097312;4648.465426475931;4804.4234691836855;4828.8792780180775;4839.128956787777;4863.829765958175;4997.550220480138;5049.545540901337;5081.085404627165;5081.568066714333;5115.923261151086;5654.74553645087;5677.318721753375;5688.459596338383;5688.97155514224;5691.573132015115;5457.317835270591;5574.9163762543185;5650.406707295716;5790.855228619276;5793.246877905887;5242.18746094356;5303.867403314909;5347.465253474621;5355.946440535545;5367.409584945653;5847.795327163529;5904.881902361929;5934.050551911673;5949.196858424058;5993.940060599425;5451.672899625956;5527.751251193626;5692.971535142297;5717.628354156966;5719.056355701346;5541.6120871539415;5584.748686309126;5586.385497595261;5619;5635.436456354331;5523.944760552424;5565.833025009256;5577.442255774471;5578.581606379537;5612.97193514038;5416.91874621881;5520.392756796749;5622.240997465372;5624.21261023457;5629.380768115504;4280.957190428056;4313.892152696208;4325.891852703645;4337.0892112656065;4355.259605867011;3950.229705207457;3955.169414422946;3968.3849003404516;4005.6194661507693;4007.358822588372;5155.6391052626705;5415.783368665288;5426.968875913563;5431.131019037014;5434.483724046209;5591.552675785927;5605.243292155506;5688.345840228344;5741.5119714824705;5784.652920824764;5360.0351936650995;5360.3031605891765;5393.514583687408;5396.91904621431;5400.297961265011;4765.785539650724;4956.330895329084;4963.553280204726;4967.180415231446;5015.24771284303;5595.888082238333;5622.156676498558;5755.712214389264;5832.94167058324;5876.9118463223085;5766.279215098113;5795.739191736467;5804.1874137619925;5810.099434587646;5812.796552120655;5697.401772813961;5835.387284335254;5856.882862342814;5896.469317761422;5904.468597826044;5518.724063796874;5528.115501519737;5582.944170558405;5643;5681.289838770153;5711.086226203787;5729.4843464088435;5730.341010783646;5735.369109398046;5736.397678243724;5281.128613778684;5580.525655319343;5593.216949626974;5603.579731520071;5614.129809879475;5451.836444906659;5452.154915988028;5478.863028424321;5547.5007249347755;5593.916091258553;5545.972270138785;5562.582806289463;5563.554915606823;5565.554755619622;5565.693886836263;5305.283786688902;5608.046632072639;5638.436156384329;5640.520555752807;5645.237892884408;5337.466253374787;5358.22305765654;5448.863778405572;5459.863503412287;5492.697901615449 10:09:04 INFO - PROCESS | 7955 | |1;ext.html;556.8400770712909;571.6798592788039;596.8388535095525;601.2274227617512;608.2002167150197;28864.422711545783;29596.408071838578;29667;34470.31059378811;34896.476552851665;40399.19201615966;41087.58912410875;41252.58747412525;41284.63299771033;41316.38025429621;8722.520261385636;8911.019787823367;8913.732588022338;8918.420302680337;8921.286297096249;7693.846123077535;7947.364210863146;10048.497575121251;10290.536925838318;10297.588096476133;10085.49572521371;10145.49272536374;10166.339187952759;10191.949040254789;10192.980701929822;7689.577073260968;7931.365490760725;10029.899701002969;10123.139533139729;10132.54403551842;7537;10537.157027437863;10819.188560857967;10836.945815270874;10840.295380800222;38682.61317386818;38922.22155556901;39051.8047409764;39056;39193.60806391928;3360.663933606644;3379.053864917827;3389.2035371687634;3392.3893699134146;3688.6495782900583;29056.564151537743;29471.557926631118;29564.70435295641;29586.556201656993;29908.700912990807;3638.5269914911155;3661.377565813818;3731.776093434403;3742.0270729610224;3743.9438408423894;272649;272681.6365918178;273616;273704;274280;49043.75478122586;51725.48274517282;56610;57411;57424.42575574274;57024.14463783047;57094.7145264271;57190.7140464295;57194.42805571891;57290.71354643283;13207.40566674502;13342.599722008355;13367.799483007762;13371;13373.197608143542;10345.689629311133;10475.790484190273;10479.738006549896;10537.683869483928;10546.103581195532;18744.625107497774;18868.245270189313;18899;18938.526536836413;18976.62046759085;7292.781216563511;7573.46985710995;7584.734534291273;7595.278448547379;7721.073471183494;832.5545832979327;859.8409294280578;912.981740365189;979.5298256836759;1093.8960798724268;24075.879620601783;24600.876995614908;24697;24736.628950565755;24748.133815316378;942.6088173408097;976.1751320134475;991.177322822056;1062.654637242899;1066.6426747039673;14907.92546037263;14965.326560304813;15094.924525377302;15309.234538273042;15375.231238438033;362052;365936;367335;368034;368676;53186.734066330195;53704;53771.73114134404;53863.730681346344;53991;1252.8997680185746;1284.9100562960502;1322.2331047992334;1364.3519328318969;1396.36465408239;28898.13305600751;29321.12036638904;29835;30227.546586801654;30311.848440757654;43257;43785.34321985109;43814.49484041205;43892.12215755731;43916.560834391246;301105;305787;307102;379605;392377;30292.697073028987;30433;30433.543496847124;30468.238294042825;30857.074287771404;38678.6132138675;39625.80187099046;39884;40033.399499006955;40326.79019629416;35264.471032934016;36048.09879752922;36069;36473.45289820708;37110;36562.63437365699;36619.450708238866;36696.81651591725;36853.26293474062;37134.8143259282;39223.41164882472;39626.60373396229;39845.60154398419;39987.60012399955;40357;29756.404871902872;30540.694593053784;31954.20114497156;32882.835585821915;32886.342273153925;24516.264512064667;24610.261692149263;24897.25308240756;25163;25244 10:09:04 INFO - PROCESS | 7955 | |2;jquery.html;349.40252168791363;350.9052555809931;354.7286325960639;355.5271488919737;362.3477740067877;14208.147511149313;14543.563693089225;16037.839621603795;16288;16986.999999999985;13245;13280.33598320085;13285.269310187936;15102.697946041073;16009.119498427612;5158.3552055993005;5208.843734687956;5334.146536554152;5335.759890804904;5379.865503362408;3671.94492082619;3783.716221283401;5285.603579731535;5309.4955979182105;5421.1326187809955;5382.138857782756;5393.164059570773;5395.676259424427;5416.4312747161575;5424.430434804348;5351.0903146465;5469.535089517396;5476.0416927038;5482.17767334899;5482.314710661168;5187.170052791535;5233.528982391603;5237.13587258102;5240.109181439165;5240.659357141773;12612.117151799377;13009;13010.219386836725;13095.738085238338;20522.79477205224;2088.791120887899;2117.237794394017;2120.1095539873136;2131.6482780341225;2131.90344258136;10564.947175264151;12503.49986000559;12702.237865728086;12966.351682415936;13035.217886926815;1750.431109889291;1783.4471313892734;1792.265171279769;1803.2696757813108;1803.8917664940145;59920.96360533697;63052.36947630511;63265.36734632687;63590;63943.68028159876;10071.647492337734;10072.74818129538;10122.696319110439;10128.291019628556;10129.797404051878;13278.867211327957;13349.199048056953;13370.39833207508;13396.320735852674;13408.463661453628;7042.119735033121;7151.642417879189;7159.427245820322;7198.208197098315;7218.855622887513;6438.130852334969;6539.574927629689;6548.937084818363;6679.365460281266;6810.421114205249;4159.854405095807;4178.268802959531;4183.414321994923;4287.849925252601;4306.117245964632;1677.2787701288319;1754.754334393186;1761.8238176182278;1798.5773343264323;1819.4086921750484;761.9881324824802;878.6002368922125;889.9110088991049;896.9327300452492;1031.6079889641887;15900.840991590167;16138.596535086483;16542.338306467846;16590.585235369213;16812.663746724997;870.3341943413294;882.9602667879832;886.7472770260445;912.2656261709255;915.5971372596036;8949.463032218087;9409.529523523797;9605.519724013911;9780.902190977999;9813.11681948628;506568;507158;512573;515321;523854;76534;76895.6931292051;79732;80691;82416;1097.6706987903597;1099.8460215569826;1136.8181091025397;1147.9253848499989;1149.2127892393737;15186.31661575254;15187;15195;15409.614759631098;15681.372745090524;33552;33723.3255334887;33825.830870846476;34100.488492672135;34611.653883460844;41366.37950430806;42748.78625606852;44522.77738611286;44581;44925;8239.95880020596;9033.909660903308;9104.317176211944;9138.588763505526;9372.859407109036;10353.534090966075;10369.533370998171;10395.63615273492;13121.475140994253;14793.408263669333;12339.197952133083;12579.182353147016;12734.61796146117;12756.936215318863;12821.23072615646;12180.208286461351;12207.389630518615;12620.810687839506;12770.680732981378;12922.935385323013;12928.870711292766;13250.072494925264;13324.133931294435;13542.932285338511;13657.590272291847;9198.540072996457;9246.722598322061;9258;9276.304277179373;9316.254699623878;12812.551560695703;13047.179710546725;13179.275139867399;13245.470181192644;13443.991700622297 10:09:04 INFO - PROCESS | 7955 | |3;mootools.html;1463;1676.270822192346;1736.5311365931195;1759.1907722447672;1785.8749887507872;6323.525735569833;7146.714131434743;7249.202587715347;7262.527935684177;7266.055412796329;7135.928640713591;7316.048913641219;7324.304191101837;7327.120745510533;7336.0463139791755;2187.332863476639;2204.5150066985316;2216.6231740604057;2225.043231410493;2225.143319821864;2218.245796429214;2262.0273282488524;2274.9545009099807;2275.180934863448;2276.521930394611;2162.5999190149796;2185.67214917762;2193.166596693254;2208.293346129239;2208.856424332413;2193.670949357593;2214.689943407916;2217.933461996143;2239.8320125990454;2242.6075436798496;2218.1127548980376;2250.0999600159903;2252;2257.808086312665;2258.07418958228;7218.8917166242545;7294.197638259787;7299.817504562376;7304.780856574312;7305.305995930378;4374.212641724488;4440.1563702896665;4448.510663826976;4461.866144015685;4465.218586747306;2828.915132546006;2876.3384421582946;2879.7408233259107;2899.869505872241;2919.5620656901424;904.5025236120173;906.7053207707521;922.3128769067088;951.5194826612585;966.6471737815717;9732.90267097327;9772.169365603932;9790.461524616143;9797.16724078447;9814.803703925953;3940.527136743609;3958.426028225891;3959.6634286085427;4010.318245898204;4012.996750812297;8363.916360836314;8375.120612335739;8390.748277551684;8393.24460798531;8409.075001749803;4387.758673272937;4405.273129933525;4409.647228221735;4418.6023257906945;4418.734875907456;3582.749207555446;3686.963130368662;3959.4456776051375;4053.1285773558825;4057.39139129133;3470.35798377301;3470.444728843373;3484.494748261488;3508.7894726316504;3513.3851575974613;1152.3201311226417;1155.6648571914218;1158.2529268621693;1160.8316794064813;1171.291368721928;985.3348989432247;992.1764935103846;1000.6547741029333;1093.6554985179644;1300.648824817294;6816.182058152955;6824.146981627297;6853.554518956252;6853.588784672936;6858.211305699809;449.8380582990121;452.14093222876795;457.1633909944793;458.86004768545916;459.8620413875824;5402.189671549299;5415;5416.350037995466;5417.512423881791;5424.728763561806;7809.258120478546;7982.760517184493;8356.958215208884;8382.161783821692;8538.146185381413;7999.680012799539;8078.8788168177525;8087.231712987257;8127.79680507992;8151;6799.946008368711;6817.420519255918;6868.587884726932;6932;6934.653267336613;7017;7069.081019467436;7074.964625176841;7075.646217689198;7082.18554866197;7752.7674169775;7773.961130194539;7873.645685944261;7901.288884000468;7924.801879952816;7875.054993400829;7929;8221.630026648934;8265.090840007715;8334.666613335641;5778.8266352009505;6171.321154673072;6173.043178307369;6640.402363787282;6713.731450742111;6865.691043902936;6989.440844732308;7013.859722805413;7054.753083642048;7056.223815380406;6381.968090159519;6589.604623722592;6620.073189753342;6641.800745977628;6694.665266736741;6512.153420055362;6577.901331479936;6659.766908158192;6702.994550817221;6719.865602687821;6728.899066513908;6778.4916131289365;6779.254282029072;6783.287754785676;6790.015447759948;5988.221531200916;6124.846878827887;6128.387161284014;6128.63228206309;6133.785317513865;6087.817365479043;6143.477804386677;6145.201123853871;6147.262328520606;6148.815535533941 10:09:04 INFO - PROCESS | 7955 | |4;prototype.html;332.4871833159126;337.0696876620528;337.6792047554824;341.0127680365342;342.6111363602312;5827.096799995997;5916.881662366755;5929.851753706149;5979.103134529817;6017.398260173986;5753.683547404891;5886.852828679285;5896.086106653475;5916.290045194572;5939.88120237595;4613.8615841524725;4618.261078227484;4621.329907163459;4628.328892310613;4628.514006029369;4415.933760993587;4496.168208881368;4524.389207457;4635.072985402916;4650.069986002796;4566.474855391622;4570.565796249351;4573.885652858672;4581.7709114544305;4600.263957766741;4570.931436028445;4571.474280457756;4587.862364129048;4590.862274131781;4611.930821037654;4071.7760523171214;4072.0837811492474;4072.368782838635;4079.1229885574744;4080.2451546463703;5576.107822748381;5616.943830561683;5669.319681638189;5671.914921276184;5675.943240567624;5365.7853685852515;5374.7850085996515;5374.91937620936;5377.0052540279785;5384.326959130109;6070.6357618543025;6302.716377763011;6303.684815759194;6304.369563043705;6305.96847015762;4302.870913872557;4368.213721530124;4379.605835474791;4405.074934263808;4406.647468202568;6512.381323774282;6552.443042341407;6572.76995305162;6586.37429444202;6594.703238354237;4463.285874260103;4490.842820501267;4497.190505709003;4497.280435130363;4502.594766471033;4495.43807024122;4551.613112885376;4557.134144512598;4661.533846615312;4683.461401938753;5315.920261196085;5317.946820531745;5320.813771518056;5322.946770532322;5323.494268044607;6307.590006649553;6309.905351419732;6312.810615681537;6322.209723784527;6326.398992095744;1615.8626516746208;1634.7384418492984;1635.2314412226235;1636.2227941727583;1639.131260431973;1118.3904771899333;1125.5947858770835;1129.711923459529;1131.7057565033151;1153.8846115388562;6067.908981365283;6076.878462430726;6079.696015199311;6079.969600151971;6082.817515474543;6560.278369379364;6564.638944857983;6565.835854103686;6567.080608714784;6571.769988050491;5913.881722365529;6061.181740464981;6069.332373438918;6073.362296958844;6075.908861367083;3532.6290739471983;3562.7327950403824;3563.625819288989;3563.893083207508;3564.572251329805;6659.567128136656;6661.034150048215;6668.266490686021;6669.166354205724;6670.366315200048;6622.735090596419;6694.297098804653;6710.563813352116;6716;6717.932820671828;6565.409113179837;6724;6729.158855143107;6736.696848641823;6740.494462915203;6393.1369265148605;6528.445082168069;6622.106015688013;6636.104125942936;6641.501887358564;6430.871382572229;6509;6531.967340163269;6532.248791389051;6549.7380104795275;6691.297413771484;6695.263521012587;6699.129113215251;6699.464042876461;6711.63086030273;4345.261305577996;4452.2431186697695;4487.775611219491;4489.77551122436;4492.707973981681;6570.8028759137305;6579.769708060195;6580.243272023587;6586.50601204902;6587.110740050032;6396.872062558816;6404.903926441014;6408.166938297992;6409.9038514423255;6411.070394792636;6286.151369565233;6379.52153588492;6384.329645387167;6386.489080873612;6390.680465976589;6271.43557079865;6273.811785646438;6280.434760871543;6281.277653069956;6284.74861005573;6404.231492220963;6406.711697973696;6418.839529011812;6419.358064193543;6421;6118.2658081028785;6247.187865577446;6247.3440288769025;6247.656378899204;6250.812475625738 10:09:04 INFO - PROCESS | 7955 | |5;yui.html;783.2089589514592;853.0531110467384;874.4141425245085;876.1632640828008;902.4179404284241;13787.58637240883;13864.23746693934;13888.444462221525;13897.166170029805;13901.165930044192;11962;12722.618321450349;12779.872201277984;12794.552190673328;12847.29339886306;664.2095905872021;817.5094943034162;826.6569373709904;827.0241115483727;827.0571548434789;820.2822530285999;827.1108558299821;827.1315119124924;829.6266679993996;830.0951962361025;847.1782371100023;847.6016272351985;849.2484151525913;851.7529916324289;853.3088198559155;685.4105469296401;850.2602735619988;850.3282406898543;850.8085680721819;851.9787005324855;518.0183552168656;622.5642050564622;623.2801114712514;629.062696582094;629.7701339011228;12070.758584828342;12114.454849531705;12160.939195304056;12175.147739658227;12195.573154939624;11573.24773889703;12030.218035827731;12206.511739530408;12554.246745195227;12597.811032834516;9985.151262142726;10004.649837255662;10075.294729368947;10478.79042419155;10663.84004239937;3576.3807781957867;3629.5100161478126;3668.614795446493;3686.299603075407;3694.612065733086;43205.35191972123;43263.78368108171;43331.96676232665;43360.783196083816;43391;9685.564149613285;9954.45250511229;9975.451350175665;9998.650047248457;10040.899591004143;17495.38766143179;17641.206145723216;17665.55836104082;17849.7322540162;18168.909155454137;7156.427485801123;7194.748183813646;7277.636118194069;7392.297731715478;7436.330730234305;4183.937240941388;4278.994436307466;4285.657147428198;4312.482502099705;4323.351497275434;2894.8552572371295;2929.3262549613282;2937.2950491881793;2939.3092623233524;2954.2023653613405;505.36071869085634;515.4819406496447;518.0209404226016;527.8416475057468;530.6444682063027;520.6043407010624;571.3543695623919;587.5064945445846;644.2301449767483;701.6248153618964;8241.25828675422;8414.747557573282;8611.224989750952;9439.669611563562;9485.857712134324;577.5856918082372;621.8725161341914;697.1390332938817;707.2856415020866;737.3695490355668;3929.3713005918917;3969.622885825842;3990.840366385312;4093.6520395766693;4179.749215047107;51580;51602.48397516052;51745.74127129416;52143;52368.73815630974;45760.542394576296;46445.76777116093;47022;47156.764216179385;47600.761996189794;42183.36724949128;42933.35599966003;42942.57057429386;43294.56705432968;43638.56361436345;8343.45767525109;8360.08039115709;8427.279053583905;8650.480971141751;9197.816043679222;32181.195470113435;32883;33746;34177;34376.48435273523;40425;41378;41574.96062598459;41741.79129104335;42428.787856060524;10632.202584806017;11111.611093611686;11189.216754827085;11236.887631123584;11284.548618055185;12186.756264874475;12266.815997759863;12490.56283030126;13076.869231307946;13191.274479903697;11375.20373573875;11731.23746956445;11846.940765296118;11921.642350729491;12235.571754988532;11488.54045838157;11691.941540292244;11767.529298828293;12004.459799308877;12156.62361549859;11212.943935280271;11343.829842552203;11413;11473.942630286796;11759.647210583697;9899.65351212704;10095.091441769982;10214.285000049926;10250.641227557;10601.893981060091;8634.697785577475;8984.416012959136;9133.178013978773;9792.559334829808;9795.216382689225 10:09:04 INFO - PROCESS | 7955 | __end_tp_report 10:09:04 INFO - PROCESS | 7955 | __start_cc_report 10:09:04 INFO - PROCESS | 7955 | _x_x_mozilla_cycle_collect,973 10:09:04 INFO - PROCESS | 7955 | __end_cc_report 10:09:04 INFO - PROCESS | 7955 | __startTimestamp1450634944823__endTimestamp 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | ------- Summary: start ------- 10:09:04 INFO - PROCESS | 7955 | Number of tests: 6 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#0] dojo.html Cycles:165 Average:5255.31 Median:5451.84 stddev:587.34 (10.8%) stddev-sans-first:564.67 10:09:04 INFO - PROCESS | 7955 | Values: 3116.4 3154.0 3176.8 3197.1 3224.1 5039.7 5190.2 5198.8 5272.6 5285.9 5176.0 5183.1 5197.0 5243.7 5263.4 4568.5 4693.5 4725.4 4775.0 4838.6 4680.5 4785.9 4841.4 4850.7 5022.1 4613.0 4695.5 4716.8 4729.1 4742.4 4822.7 4826.7 4834.8 4845.2 4876.9 4648.5 4804.4 4828.9 4839.1 4863.8 4997.6 5049.5 5081.1 5081.6 5115.9 5654.7 5677.3 5688.5 5689.0 5691.6 5457.3 5574.9 5650.4 5790.9 5793.2 5242.2 5303.9 5347.5 5355.9 5367.4 5847.8 5904.9 5934.1 5949.2 5993.9 5451.7 5527.8 5693.0 5717.6 5719.1 5541.6 5584.7 5586.4 5619.0 5635.4 5523.9 5565.8 5577.4 5578.6 5613.0 5416.9 5520.4 5622.2 5624.2 5629.4 4281.0 4313.9 4325.9 4337.1 4355.3 3950.2 3955.2 3968.4 4005.6 4007.4 5155.6 5415.8 5427.0 5431.1 5434.5 5591.6 5605.2 5688.3 5741.5 5784.7 5360.0 5360.3 5393.5 5396.9 5400.3 4765.8 4956.3 4963.6 4967.2 5015.2 5595.9 5622.2 5755.7 5832.9 5876.9 5766.3 5795.7 5804.2 5810.1 5812.8 5697.4 5835.4 5856.9 5896.5 5904.5 5518.7 5528.1 5582.9 5643.0 5681.3 5711.1 5729.5 5730.3 5735.4 5736.4 5281.1 5580.5 5593.2 5603.6 5614.1 5451.8 5452.2 5478.9 5547.5 5593.9 5546.0 5562.6 5563.6 5565.6 5565.7 5305.3 5608.0 5638.4 5640.5 5645.2 5337.5 5358.2 5448.9 5459.9 5492.7 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#1] ext.html Cycles:180 Average:48467.16 Median:35656.28 stddev:86382.65 (242.3%) stddev-sans-first:86550.08 10:09:04 INFO - PROCESS | 7955 | Values: 556.8 571.7 596.8 601.2 608.2 28864.4 29596.4 29667.0 34470.3 34896.5 40399.2 41087.6 41252.6 41284.6 41316.4 8722.5 8911.0 8913.7 8918.4 8921.3 7693.8 7947.4 10048.5 10290.5 10297.6 10085.5 10145.5 10166.3 10191.9 10193.0 7689.6 7931.4 10029.9 10123.1 10132.5 7537.0 10537.2 10819.2 10836.9 10840.3 38682.6 38922.2 39051.8 39056.0 39193.6 3360.7 3379.1 3389.2 3392.4 3688.6 29056.6 29471.6 29564.7 29586.6 29908.7 3638.5 3661.4 3731.8 3742.0 3743.9 272649.0 272681.6 273616.0 273704.0 274280.0 49043.8 51725.5 56610.0 57411.0 57424.4 57024.1 57094.7 57190.7 57194.4 57290.7 13207.4 13342.6 13367.8 13371.0 13373.2 10345.7 10475.8 10479.7 10537.7 10546.1 18744.6 18868.2 18899.0 18938.5 18976.6 7292.8 7573.5 7584.7 7595.3 7721.1 832.6 859.8 913.0 979.5 1093.9 24075.9 24600.9 24697.0 24736.6 24748.1 942.6 976.2 991.2 1062.7 1066.6 14907.9 14965.3 15094.9 15309.2 15375.2 362052.0 365936.0 367335.0 368034.0 368676.0 53186.7 53704.0 53771.7 53863.7 53991.0 1252.9 1284.9 1322.2 1364.4 1396.4 28898.1 29321.1 29835.0 30227.5 30311.8 43257.0 43785.3 43814.5 43892.1 43916.6 301105.0 305787.0 307102.0 379605.0 392377.0 30292.7 30433.0 30433.5 30468.2 30857.1 38678.6 39625.8 39884.0 40033.4 40326.8 35264.5 36048.1 36069.0 36473.5 37110.0 36562.6 36619.5 36696.8 36853.3 37134.8 39223.4 39626.6 39845.6 39987.6 40357.0 29756.4 30540.7 31954.2 32882.8 32886.3 24516.3 24610.3 24897.3 25163.0 25244.0 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#2] jquery.html Cycles:180 Average:27463.70 Median:17480.53 stddev:83961.47 (480.3%) stddev-sans-first:84172.32 10:09:04 INFO - PROCESS | 7955 | Values: 349.4 350.9 354.7 355.5 362.3 14208.1 14543.6 16037.8 16288.0 16987.0 13245.0 13280.3 13285.3 15102.7 16009.1 5158.4 5208.8 5334.1 5335.8 5379.9 3671.9 3783.7 5285.6 5309.5 5421.1 5382.1 5393.2 5395.7 5416.4 5424.4 5351.1 5469.5 5476.0 5482.2 5482.3 5187.2 5233.5 5237.1 5240.1 5240.7 12612.1 13009.0 13010.2 13095.7 20522.8 2088.8 2117.2 2120.1 2131.6 2131.9 10564.9 12503.5 12702.2 12966.4 13035.2 1750.4 1783.4 1792.3 1803.3 1803.9 59921.0 63052.4 63265.4 63590.0 63943.7 10071.6 10072.7 10122.7 10128.3 10129.8 13278.9 13349.2 13370.4 13396.3 13408.5 7042.1 7151.6 7159.4 7198.2 7218.9 6438.1 6539.6 6548.9 6679.4 6810.4 4159.9 4178.3 4183.4 4287.8 4306.1 1677.3 1754.8 1761.8 1798.6 1819.4 762.0 878.6 889.9 896.9 1031.6 15900.8 16138.6 16542.3 16590.6 16812.7 870.3 883.0 886.7 912.3 915.6 8949.5 9409.5 9605.5 9780.9 9813.1 506568.0 507158.0 512573.0 515321.0 523854.0 76534.0 76895.7 79732.0 80691.0 82416.0 1097.7 1099.8 1136.8 1147.9 1149.2 15186.3 15187.0 15195.0 15409.6 15681.4 33552.0 33723.3 33825.8 34100.5 34611.7 41366.4 42748.8 44522.8 44581.0 44925.0 8240.0 9033.9 9104.3 9138.6 9372.9 10353.5 10369.5 10395.6 13121.5 14793.4 12339.2 12579.2 12734.6 12756.9 12821.2 12180.2 12207.4 12620.8 12770.7 12922.9 12928.9 13250.1 13324.1 13542.9 13657.6 9198.5 9246.7 9258.0 9276.3 9316.3 12812.6 13047.2 13179.3 13245.5 13444.0 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#3] mootools.html Cycles:180 Average:5090.87 Median:6248.28 stddev:2596.18 (41.6%) stddev-sans-first:2589.15 10:09:04 INFO - PROCESS | 7955 | Values: 1463.0 1676.3 1736.5 1759.2 1785.9 6323.5 7146.7 7249.2 7262.5 7266.1 7135.9 7316.0 7324.3 7327.1 7336.0 2187.3 2204.5 2216.6 2225.0 2225.1 2218.2 2262.0 2275.0 2275.2 2276.5 2162.6 2185.7 2193.2 2208.3 2208.9 2193.7 2214.7 2217.9 2239.8 2242.6 2218.1 2250.1 2252.0 2257.8 2258.1 7218.9 7294.2 7299.8 7304.8 7305.3 4374.2 4440.2 4448.5 4461.9 4465.2 2828.9 2876.3 2879.7 2899.9 2919.6 904.5 906.7 922.3 951.5 966.6 9732.9 9772.2 9790.5 9797.2 9814.8 3940.5 3958.4 3959.7 4010.3 4013.0 8363.9 8375.1 8390.7 8393.2 8409.1 4387.8 4405.3 4409.6 4418.6 4418.7 3582.7 3687.0 3959.4 4053.1 4057.4 3470.4 3470.4 3484.5 3508.8 3513.4 1152.3 1155.7 1158.3 1160.8 1171.3 985.3 992.2 1000.7 1093.7 1300.6 6816.2 6824.1 6853.6 6853.6 6858.2 449.8 452.1 457.2 458.9 459.9 5402.2 5415.0 5416.4 5417.5 5424.7 7809.3 7982.8 8357.0 8382.2 8538.1 7999.7 8078.9 8087.2 8127.8 8151.0 6799.9 6817.4 6868.6 6932.0 6934.7 7017.0 7069.1 7075.0 7075.6 7082.2 7752.8 7774.0 7873.6 7901.3 7924.8 7875.1 7929.0 8221.6 8265.1 8334.7 5778.8 6171.3 6173.0 6640.4 6713.7 6865.7 6989.4 7013.9 7054.8 7056.2 6382.0 6589.6 6620.1 6641.8 6694.7 6512.2 6577.9 6659.8 6703.0 6719.9 6728.9 6778.5 6779.3 6783.3 6790.0 5988.2 6124.8 6128.4 6128.6 6133.8 6087.8 6143.5 6145.2 6147.3 6148.8 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#4] prototype.html Cycles:180 Average:5306.68 Median:6039.29 stddev:1584.06 (26.2%) stddev-sans-first:1543.88 10:09:04 INFO - PROCESS | 7955 | Values: 332.5 337.1 337.7 341.0 342.6 5827.1 5916.9 5929.9 5979.1 6017.4 5753.7 5886.9 5896.1 5916.3 5939.9 4613.9 4618.3 4621.3 4628.3 4628.5 4415.9 4496.2 4524.4 4635.1 4650.1 4566.5 4570.6 4573.9 4581.8 4600.3 4570.9 4571.5 4587.9 4590.9 4611.9 4071.8 4072.1 4072.4 4079.1 4080.2 5576.1 5616.9 5669.3 5671.9 5675.9 5365.8 5374.8 5374.9 5377.0 5384.3 6070.6 6302.7 6303.7 6304.4 6306.0 4302.9 4368.2 4379.6 4405.1 4406.6 6512.4 6552.4 6572.8 6586.4 6594.7 4463.3 4490.8 4497.2 4497.3 4502.6 4495.4 4551.6 4557.1 4661.5 4683.5 5315.9 5317.9 5320.8 5322.9 5323.5 6307.6 6309.9 6312.8 6322.2 6326.4 1615.9 1634.7 1635.2 1636.2 1639.1 1118.4 1125.6 1129.7 1131.7 1153.9 6067.9 6076.9 6079.7 6080.0 6082.8 6560.3 6564.6 6565.8 6567.1 6571.8 5913.9 6061.2 6069.3 6073.4 6075.9 3532.6 3562.7 3563.6 3563.9 3564.6 6659.6 6661.0 6668.3 6669.2 6670.4 6622.7 6694.3 6710.6 6716.0 6717.9 6565.4 6724.0 6729.2 6736.7 6740.5 6393.1 6528.4 6622.1 6636.1 6641.5 6430.9 6509.0 6532.0 6532.2 6549.7 6691.3 6695.3 6699.1 6699.5 6711.6 4345.3 4452.2 4487.8 4489.8 4492.7 6570.8 6579.8 6580.2 6586.5 6587.1 6396.9 6404.9 6408.2 6409.9 6411.1 6286.2 6379.5 6384.3 6386.5 6390.7 6271.4 6273.8 6280.4 6281.3 6284.7 6404.2 6406.7 6418.8 6419.4 6421.0 6118.3 6247.2 6247.3 6247.7 6250.8 10:09:04 INFO - PROCESS | 7955 | 10:09:04 INFO - PROCESS | 7955 | [#5] yui.html Cycles:180 Average:13144.33 Median:23758.92 stddev:14522.90 (61.1%) stddev-sans-first:14533.97 10:09:04 INFO - PROCESS | 7955 | Values: 783.2 853.1 874.4 876.2 902.4 13787.6 13864.2 13888.4 13897.2 13901.2 11962.0 12722.6 12779.9 12794.6 12847.3 664.2 817.5 826.7 827.0 827.1 820.3 827.1 827.1 829.6 830.1 847.2 847.6 849.2 851.8 853.3 685.4 850.3 850.3 850.8 852.0 518.0 622.6 623.3 629.1 629.8 12070.8 12114.5 12160.9 12175.1 12195.6 11573.2 12030.2 12206.5 12554.2 12597.8 9985.2 10004.6 10075.3 10478.8 10663.8 3576.4 3629.5 3668.6 3686.3 3694.6 43205.4 43263.8 43332.0 43360.8 43391.0 9685.6 9954.5 9975.5 9998.7 10040.9 17495.4 17641.2 17665.6 17849.7 18168.9 7156.4 7194.7 7277.6 7392.3 7436.3 4183.9 4279.0 4285.7 4312.5 4323.4 2894.9 2929.3 2937.3 2939.3 2954.2 505.4 515.5 518.0 527.8 530.6 520.6 571.4 587.5 644.2 701.6 8241.3 8414.7 8611.2 9439.7 9485.9 577.6 621.9 697.1 707.3 737.4 3929.4 3969.6 3990.8 4093.7 4179.7 51580.0 51602.5 51745.7 52143.0 52368.7 45760.5 46445.8 47022.0 47156.8 47600.8 42183.4 42933.4 42942.6 43294.6 43638.6 8343.5 8360.1 8427.3 8650.5 9197.8 32181.2 32883.0 33746.0 34177.0 34376.5 40425.0 41378.0 41575.0 41741.8 42428.8 10632.2 11111.6 11189.2 11236.9 11284.5 12186.8 12266.8 12490.6 13076.9 13191.3 11375.2 11731.2 11846.9 11921.6 12235.6 11488.5 11691.9 11767.5 12004.5 12156.6 11212.9 11343.8 11413.0 11473.9 11759.6 9899.7 10095.1 10214.3 10250.6 10601.9 8634.7 8984.4 9133.2 9792.6 9795.2 10:09:04 INFO - PROCESS | 7955 | -------- Summary: end -------- 10:09:04 INFO - PROCESS | 7955 | 10:09:05 INFO - TEST-INFO | 7955: exit 0 10:09:05 INFO - TEST-OK | dromaeo_css | took 1113084ms 10:09:05 INFO - TEST-START | kraken 10:09:05 INFO - operating with platform_type : linux_ 10:09:05 INFO - Initialising browser for kraken test... 10:09:05 INFO - TEST-INFO | started process 8144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg3AXXF/profile http://localhost:60752/getInfo.html) 10:09:09 INFO - PROCESS | 8144 | __metrics Screen width/height:1600/1200 10:09:09 INFO - PROCESS | 8144 | colorDepth:24 10:09:09 INFO - PROCESS | 8144 | Browser inner width/height: 1024/697 10:09:09 INFO - PROCESS | 8144 | __metrics 10:09:09 INFO - PROCESS | 8144 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:09:09 INFO - PROCESS | 8144 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:09 ERROR - PROCESS | 8144 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:09:10 INFO - TEST-INFO | 8144: exit 0 10:09:10 INFO - Browser initialized. 10:09:10 INFO - Running cycle 1/1 for kraken test... 10:09:10 INFO - TEST-INFO | started process 8230 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg3AXXF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:22 INFO - PROCESS | 8230 | RSS: Main: 150409216 10:09:22 INFO - PROCESS | 8230 | 10:09:24 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60752/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:25 INFO - PROCESS | 8230 | RSS: Main: 187715584 10:09:25 INFO - PROCESS | 8230 | 10:09:27 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60752/tests/kraken/driver.html?testName=audio-dft) 10:09:28 INFO - PROCESS | 8230 | RSS: Main: 177291264 10:09:28 INFO - PROCESS | 8230 | 10:09:31 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60752/tests/kraken/driver.html?testName=audio-fft) 10:09:31 INFO - PROCESS | 8230 | RSS: Main: 160923648 10:09:31 INFO - PROCESS | 8230 | 10:09:33 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60752/tests/kraken/driver.html?testName=audio-oscillator) 10:09:34 INFO - PROCESS | 8230 | RSS: Main: 163704832 10:09:34 INFO - PROCESS | 8230 | 10:09:36 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60752/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:37 INFO - PROCESS | 8230 | RSS: Main: 165310464 10:09:37 INFO - PROCESS | 8230 | 10:09:40 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60752/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:40 INFO - PROCESS | 8230 | RSS: Main: 164892672 10:09:40 INFO - PROCESS | 8230 | 10:09:43 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60752/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:44 INFO - PROCESS | 8230 | RSS: Main: 166211584 10:09:44 INFO - PROCESS | 8230 | 10:09:47 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60752/tests/kraken/driver.html?testName=json-parse-financial) 10:09:47 INFO - PROCESS | 8230 | RSS: Main: 165146624 10:09:47 INFO - PROCESS | 8230 | 10:09:49 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60752/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:49 INFO - PROCESS | 8230 | RSS: Main: 176107520 10:09:49 INFO - PROCESS | 8230 | 10:09:51 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:52 INFO - PROCESS | 8230 | RSS: Main: 174333952 10:09:52 INFO - PROCESS | 8230 | 10:09:54 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:54 INFO - PROCESS | 8230 | RSS: Main: 181243904 10:09:54 INFO - PROCESS | 8230 | 10:09:57 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:57 INFO - PROCESS | 8230 | RSS: Main: 191844352 10:09:57 INFO - PROCESS | 8230 | 10:10:00 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:10:01 INFO - PROCESS | 8230 | RSS: Main: 186019840 10:10:01 INFO - PROCESS | 8230 | 10:10:02 INFO - PROCESS | 8230 | Cycle 1(1): loaded http://localhost:60752/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60752/tests/kraken/driver.html?testName=ai-astar) 10:10:03 INFO - PROCESS | 8230 | RSS: Main: 245993472 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | __start_tp_report 10:10:03 INFO - PROCESS | 8230 | _x_x_mozilla_page_load 10:10:03 INFO - PROCESS | 8230 | _x_x_mozilla_page_load_details 10:10:03 INFO - PROCESS | 8230 | |i|pagename|runs| 10:10:03 INFO - PROCESS | 8230 | |0;ai-astar;112;112;106;110;110;110;101;110;110;117 10:10:03 INFO - PROCESS | 8230 | |1;audio-beat-detection;150;124;145;156;125;153;154;123;163;131 10:10:03 INFO - PROCESS | 8230 | |2;audio-dft;162;161;159;164;160;161;160;161;161;162 10:10:03 INFO - PROCESS | 8230 | |3;audio-fft;72;72;89;103;71;74;72;101;95;73 10:10:03 INFO - PROCESS | 8230 | |4;audio-oscillator;94;93;138;93;94;92;146;94;93;133 10:10:03 INFO - PROCESS | 8230 | |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;110;108 10:10:03 INFO - PROCESS | 8230 | |6;imaging-darkroom;147;145;145;145;145;145;146;146;144;146 10:10:03 INFO - PROCESS | 8230 | |7;imaging-desaturate;95;98;95;95;96;96;95;95;96;96 10:10:03 INFO - PROCESS | 8230 | |8;json-parse-financial;58;57;57;58;57;57;57;67;59;55 10:10:03 INFO - PROCESS | 8230 | |9;json-stringify-tinderbox;68;68;68;68;68;68;68;68;68;67 10:10:03 INFO - PROCESS | 8230 | |10;stanford-crypto-aes;84;84;84;91;84;84;84;85;85;93 10:10:03 INFO - PROCESS | 8230 | |11;stanford-crypto-ccm;118;120;132;120;116;121;120;124;126;118 10:10:03 INFO - PROCESS | 8230 | |12;stanford-crypto-pbkdf2;139;139;150;152;149;141;150;150;150;138 10:10:03 INFO - PROCESS | 8230 | |13;stanford-crypto-sha256-iterative;67;66;68;69;69;67;67;66;67;66 10:10:03 INFO - PROCESS | 8230 | __end_tp_report 10:10:03 INFO - PROCESS | 8230 | __start_cc_report 10:10:03 INFO - PROCESS | 8230 | _x_x_mozilla_cycle_collect,924 10:10:03 INFO - PROCESS | 8230 | __end_cc_report 10:10:03 INFO - PROCESS | 8230 | __startTimestamp1450635003011__endTimestamp 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | ------- Summary: start ------- 10:10:03 INFO - PROCESS | 8230 | Number of tests: 14 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:4.13 (3.8%) stddev-sans-first:4.30 10:10:03 INFO - PROCESS | 8230 | Values: 112.0 112.0 106.0 110.0 110.0 110.0 101.0 110.0 110.0 117.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:151.50 stddev:15.16 (10.0%) stddev-sans-first:15.83 10:10:03 INFO - PROCESS | 8230 | Values: 150.0 124.0 145.0 156.0 125.0 153.0 154.0 123.0 163.0 131.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.41 10:10:03 INFO - PROCESS | 8230 | Values: 162.0 161.0 159.0 164.0 160.0 161.0 160.0 161.0 161.0 162.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#3] audio-fft Cycles:10 Average:82.20 Median:72.50 stddev:13.27 (18.3%) stddev-sans-first:13.56 10:10:03 INFO - PROCESS | 8230 | Values: 72.0 72.0 89.0 103.0 71.0 74.0 72.0 101.0 95.0 73.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:22.31 (24.0%) stddev-sans-first:23.16 10:10:03 INFO - PROCESS | 8230 | Values: 94.0 93.0 138.0 93.0 94.0 92.0 146.0 94.0 93.0 133.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 10:10:03 INFO - PROCESS | 8230 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 108.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 10:10:03 INFO - PROCESS | 8230 | Values: 147.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 144.0 146.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 10:10:03 INFO - PROCESS | 8230 | Values: 95.0 98.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.50 stddev:3.26 (5.7%) stddev-sans-first:3.46 10:10:03 INFO - PROCESS | 8230 | Values: 58.0 57.0 57.0 58.0 57.0 57.0 57.0 67.0 59.0 55.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:10:03 INFO - PROCESS | 8230 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.50 stddev:3.33 (3.9%) stddev-sans-first:3.46 10:10:03 INFO - PROCESS | 8230 | Values: 84.0 84.0 84.0 91.0 84.0 84.0 84.0 85.0 85.0 93.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:120.50 stddev:4.70 (3.9%) stddev-sans-first:4.81 10:10:03 INFO - PROCESS | 8230 | Values: 118.0 120.0 132.0 120.0 116.0 121.0 120.0 124.0 126.0 118.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:150.00 stddev:5.73 (3.8%) stddev-sans-first:5.53 10:10:03 INFO - PROCESS | 8230 | Values: 139.0 139.0 150.0 152.0 149.0 141.0 150.0 150.0 150.0 138.0 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - PROCESS | 8230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 10:10:03 INFO - PROCESS | 8230 | Values: 67.0 66.0 68.0 69.0 69.0 67.0 67.0 66.0 67.0 66.0 10:10:03 INFO - PROCESS | 8230 | -------- Summary: end -------- 10:10:03 INFO - PROCESS | 8230 | 10:10:03 INFO - TEST-INFO | 8230: exit 0 10:10:03 INFO - TEST-OK | kraken | took 58482ms 10:10:03 INFO - TEST-START | v8_7 10:10:03 INFO - operating with platform_type : linux_ 10:10:03 INFO - Initialising browser for v8_7 test... 10:10:03 INFO - TEST-INFO | started process 8481 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQob2a0/profile http://localhost:60752/getInfo.html) 10:10:07 INFO - PROCESS | 8481 | __metrics Screen width/height:1600/1200 10:10:07 INFO - PROCESS | 8481 | colorDepth:24 10:10:07 INFO - PROCESS | 8481 | Browser inner width/height: 1024/697 10:10:07 INFO - PROCESS | 8481 | __metrics 10:10:08 INFO - PROCESS | 8481 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:10:08 INFO - PROCESS | 8481 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:08 ERROR - PROCESS | 8481 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:10:08 INFO - TEST-INFO | 8481: exit 0 10:10:08 INFO - Browser initialized. 10:10:08 INFO - Running cycle 1/1 for v8_7 test... 10:10:08 INFO - TEST-INFO | started process 8563 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQob2a0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:20 INFO - PROCESS | 8563 | RSS: Main: 150138880 10:10:20 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | Cycle 1(1): loaded http://localhost:60752/tests/v8_7/run.html (next: http://localhost:60752/tests/v8_7/run.html) 10:10:42 INFO - PROCESS | 8563 | RSS: Main: 554553344 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | __start_tp_report 10:10:42 INFO - PROCESS | 8563 | _x_x_mozilla_page_load 10:10:42 INFO - PROCESS | 8563 | _x_x_mozilla_page_load_details 10:10:42 INFO - PROCESS | 8563 | |i|pagename|runs| 10:10:42 INFO - PROCESS | 8563 | |0;Richards;165.94756057085962 10:10:42 INFO - PROCESS | 8563 | |1;DeltaBlue;188.82175226586102 10:10:42 INFO - PROCESS | 8563 | |2;Encrypt;283.04557033682426 10:10:42 INFO - PROCESS | 8563 | |3;Decrypt;5133.333333333333 10:10:42 INFO - PROCESS | 8563 | |4;RayTrace;1936.1702127659576 10:10:42 INFO - PROCESS | 8563 | |5;Earley;793.0214115781126 10:10:42 INFO - PROCESS | 8563 | |6;Boyer;12365.853658536585 10:10:42 INFO - PROCESS | 8563 | |7;RegExp;26256.410256410258 10:10:42 INFO - PROCESS | 8563 | |8;Splay;594.883997620464 10:10:42 INFO - PROCESS | 8563 | |9;NavierStokes;4835.748792270531 10:10:42 INFO - PROCESS | 8563 | __end_tp_report 10:10:42 INFO - PROCESS | 8563 | __startTimestamp1450635042420__endTimestamp 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | ------- Summary: start ------- 10:10:42 INFO - PROCESS | 8563 | Number of tests: 10 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#0] Richards Cycles:1 Average:165.95 Median:165.95 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 165.9 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#1] DeltaBlue Cycles:1 Average:188.82 Median:188.82 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 188.8 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 283.0 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 5133.3 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#4] RayTrace Cycles:1 Average:1936.17 Median:1936.17 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 1936.2 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 793.0 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#6] Boyer Cycles:1 Average:12365.85 Median:12365.85 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 12365.9 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 26256.4 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#8] Splay Cycles:1 Average:594.88 Median:594.88 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 594.9 10:10:42 INFO - PROCESS | 8563 | 10:10:42 INFO - PROCESS | 8563 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:10:42 INFO - PROCESS | 8563 | Values: 4835.7 10:10:42 INFO - PROCESS | 8563 | -------- Summary: end -------- 10:10:42 INFO - PROCESS | 8563 | 10:10:43 INFO - TEST-INFO | 8563: exit 0 10:10:43 INFO - TEST-OK | v8_7 | took 39326ms 10:10:43 INFO - SUITE-END | took 1210s 10:10:43 INFO - Completed test suite (00:20:11) 10:10:43 INFO - Working with test: dromaeo_css 10:10:43 INFO - Generating results file: dromaeo_css 10:10:43 INFO - Working with test: kraken 10:10:43 INFO - Generating results file: kraken 10:10:43 INFO - javascript benchmark 10:10:43 INFO - Working with test: v8_7 10:10:43 INFO - Generating results file: v8_7 10:10:43 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 10:10:43 INFO - process_Request line: dromaeo_css 6804.06 graph.html#tests=[[72,63,35]] 10:10:43 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:43 INFO - process_Request line: kraken 1499.20 graph.html#tests=[[232,63,35]] 10:10:43 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:43 INFO - process_Request line: v8_7 19857.32 graph.html#tests=[[230,63,35]] 10:10:43 INFO - RETURN: dromaeo_css: 6804.06 10:10:43 INFO - RETURN: kraken: 1499.20 10:10:43 INFO - RETURN: v8_7: 19857.32 10:10:43 INFO - javascript benchmark 10:10:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3116.376724655069, 3154.02225310154, 3176.841157942102, 3197.136773071271, 3224.1294850390386, 5039.672421292623, 5190.195519694454, 5198.792048318068, 5272.58740911685, 5285.920711189326, 5176.042432150055, 5183.06704793138, 5197.038547868647, 5243.737813109339, 5263.421023687391, 4568.474625418086, 4693.530646935314, 4725.432948046231, 4775.0, 4838.564529192372, 4680.485146633868, 4785.90428191436, 4841.394825646794, 4850.733209673466, 5022.096022715909, 4612.97693511532, 4695.483496815347, 4716.834910778106, 4729.125111854318, 4742.359781429532, 4822.6624136310475, 4826.734529600871, 4834.806607735686, 4845.224764037773, 4876.926846097312, 4648.465426475931, 4804.4234691836855, 4828.8792780180775, 4839.128956787777, 4863.829765958175, 4997.550220480138, 5049.545540901337, 5081.085404627165, 5081.568066714333, 5115.923261151086, 5654.74553645087, 5677.318721753375, 5688.459596338383, 5688.97155514224, 5691.573132015115, 5457.317835270591, 5574.9163762543185, 5650.406707295716, 5790.855228619276, 5793.246877905887, 5242.18746094356, 5303.867403314909, 5347.465253474621, 5355.946440535545, 5367.409584945653, 5847.795327163529, 5904.881902361929, 5934.050551911673, 5949.196858424058, 5993.940060599425, 5451.672899625956, 5527.751251193626, 5692.971535142297, 5717.628354156966, 5719.056355701346, 5541.6120871539415, 5584.748686309126, 5586.385497595261, 5619.0, 5635.436456354331, 5523.944760552424, 5565.833025009256, 5577.442255774471, 5578.581606379537, 5612.97193514038, 5416.91874621881, 5520.392756796749, 5622.240997465372, 5624.21261023457, 5629.380768115504, 4280.957190428056, 4313.892152696208, 4325.891852703645, 4337.0892112656065, 4355.259605867011, 3950.229705207457, 3955.169414422946, 3968.3849003404516, 4005.6194661507693, 4007.358822588372, 5155.6391052626705, 5415.783368665288, 5426.968875913563, 5431.131019037014, 5434.483724046209, 5591.552675785927, 5605.243292155506, 5688.345840228344, 5741.5119714824705, 5784.652920824764, 5360.0351936650995, 5360.3031605891765, 5393.514583687408, 5396.91904621431, 5400.297961265011, 4765.785539650724, 4956.330895329084, 4963.553280204726, 4967.180415231446, 5015.24771284303, 5595.888082238333, 5622.156676498558, 5755.712214389264, 5832.94167058324, 5876.9118463223085, 5766.279215098113, 5795.739191736467, 5804.1874137619925, 5810.099434587646, 5812.796552120655, 5697.401772813961, 5835.387284335254, 5856.882862342814, 5896.469317761422, 5904.468597826044, 5518.724063796874, 5528.115501519737, 5582.944170558405, 5643.0, 5681.289838770153, 5711.086226203787, 5729.4843464088435, 5730.341010783646, 5735.369109398046, 5736.397678243724, 5281.128613778684, 5580.525655319343, 5593.216949626974, 5603.579731520071, 5614.129809879475, 5451.836444906659, 5452.154915988028, 5478.863028424321, 5547.5007249347755, 5593.916091258553, 5545.972270138785, 5562.582806289463, 5563.554915606823, 5565.554755619622, 5565.693886836263, 5305.283786688902, 5608.046632072639, 5638.436156384329, 5640.520555752807, 5645.237892884408, 5337.466253374787, 5358.22305765654, 5448.863778405572, 5459.863503412287, 5492.697901615449], "unit": "score", "name": "dojo.html", "value": 5217.539890079512}, {"lowerIsBetter": false, "replicates": [556.8400770712909, 571.6798592788039, 596.8388535095525, 601.2274227617512, 608.2002167150197, 28864.422711545783, 29596.408071838578, 29667.0, 34470.31059378811, 34896.476552851665, 40399.19201615966, 41087.58912410875, 41252.58747412525, 41284.63299771033, 41316.38025429621, 8722.520261385636, 8911.019787823367, 8913.732588022338, 8918.420302680337, 8921.286297096249, 7693.846123077535, 7947.364210863146, 10048.497575121251, 10290.536925838318, 10297.588096476133, 10085.49572521371, 10145.49272536374, 10166.339187952759, 10191.949040254789, 10192.980701929822, 7689.577073260968, 7931.365490760725, 10029.899701002969, 10123.139533139729, 10132.54403551842, 7537.0, 10537.157027437863, 10819.188560857967, 10836.945815270874, 10840.295380800222, 38682.61317386818, 38922.22155556901, 39051.8047409764, 39056.0, 39193.60806391928, 3360.663933606644, 3379.053864917827, 3389.2035371687634, 3392.3893699134146, 3688.6495782900583, 29056.564151537743, 29471.557926631118, 29564.70435295641, 29586.556201656993, 29908.700912990807, 3638.5269914911155, 3661.377565813818, 3731.776093434403, 3742.0270729610224, 3743.9438408423894, 272649.0, 272681.6365918178, 273616.0, 273704.0, 274280.0, 49043.75478122586, 51725.48274517282, 56610.0, 57411.0, 57424.42575574274, 57024.14463783047, 57094.7145264271, 57190.7140464295, 57194.42805571891, 57290.71354643283, 13207.40566674502, 13342.599722008355, 13367.799483007762, 13371.0, 13373.197608143542, 10345.689629311133, 10475.790484190273, 10479.738006549896, 10537.683869483928, 10546.103581195532, 18744.625107497774, 18868.245270189313, 18899.0, 18938.526536836413, 18976.62046759085, 7292.781216563511, 7573.46985710995, 7584.734534291273, 7595.278448547379, 7721.073471183494, 832.5545832979327, 859.8409294280578, 912.981740365189, 979.5298256836759, 1093.8960798724268, 24075.879620601783, 24600.876995614908, 24697.0, 24736.628950565755, 24748.133815316378, 942.6088173408097, 976.1751320134475, 991.177322822056, 1062.654637242899, 1066.6426747039673, 14907.92546037263, 14965.326560304813, 15094.924525377302, 15309.234538273042, 15375.231238438033, 362052.0, 365936.0, 367335.0, 368034.0, 368676.0, 53186.734066330195, 53704.0, 53771.73114134404, 53863.730681346344, 53991.0, 1252.8997680185746, 1284.9100562960502, 1322.2331047992334, 1364.3519328318969, 1396.36465408239, 28898.13305600751, 29321.12036638904, 29835.0, 30227.546586801654, 30311.848440757654, 43257.0, 43785.34321985109, 43814.49484041205, 43892.12215755731, 43916.560834391246, 301105.0, 305787.0, 307102.0, 379605.0, 392377.0, 30292.697073028987, 30433.0, 30433.543496847124, 30468.238294042825, 30857.074287771404, 38678.6132138675, 39625.80187099046, 39884.0, 40033.399499006955, 40326.79019629416, 35264.471032934016, 36048.09879752922, 36069.0, 36473.45289820708, 37110.0, 36562.63437365699, 36619.450708238866, 36696.81651591725, 36853.26293474062, 37134.8143259282, 39223.41164882472, 39626.60373396229, 39845.60154398419, 39987.60012399955, 40357.0, 29756.404871902872, 30540.694593053784, 31954.20114497156, 32882.835585821915, 32886.342273153925, 24516.264512064667, 24610.261692149263, 24897.25308240756, 25163.0, 25244.0], "unit": "score", "name": "ext.html", "value": 18328.637928071497}, {"lowerIsBetter": false, "replicates": [349.40252168791363, 350.9052555809931, 354.7286325960639, 355.5271488919737, 362.3477740067877, 14208.147511149313, 14543.563693089225, 16037.839621603795, 16288.0, 16986.999999999985, 13245.0, 13280.33598320085, 13285.269310187936, 15102.697946041073, 16009.119498427612, 5158.3552055993005, 5208.843734687956, 5334.146536554152, 5335.759890804904, 5379.865503362408, 3671.94492082619, 3783.716221283401, 5285.603579731535, 5309.4955979182105, 5421.1326187809955, 5382.138857782756, 5393.164059570773, 5395.676259424427, 5416.4312747161575, 5424.430434804348, 5351.0903146465, 5469.535089517396, 5476.0416927038, 5482.17767334899, 5482.314710661168, 5187.170052791535, 5233.528982391603, 5237.13587258102, 5240.109181439165, 5240.659357141773, 12612.117151799377, 13009.0, 13010.219386836725, 13095.738085238338, 20522.79477205224, 2088.791120887899, 2117.237794394017, 2120.1095539873136, 2131.6482780341225, 2131.90344258136, 10564.947175264151, 12503.49986000559, 12702.237865728086, 12966.351682415936, 13035.217886926815, 1750.431109889291, 1783.4471313892734, 1792.265171279769, 1803.2696757813108, 1803.8917664940145, 59920.96360533697, 63052.36947630511, 63265.36734632687, 63590.0, 63943.68028159876, 10071.647492337734, 10072.74818129538, 10122.696319110439, 10128.291019628556, 10129.797404051878, 13278.867211327957, 13349.199048056953, 13370.39833207508, 13396.320735852674, 13408.463661453628, 7042.119735033121, 7151.642417879189, 7159.427245820322, 7198.208197098315, 7218.855622887513, 6438.130852334969, 6539.574927629689, 6548.937084818363, 6679.365460281266, 6810.421114205249, 4159.854405095807, 4178.268802959531, 4183.414321994923, 4287.849925252601, 4306.117245964632, 1677.2787701288319, 1754.754334393186, 1761.8238176182278, 1798.5773343264323, 1819.4086921750484, 761.9881324824802, 878.6002368922125, 889.9110088991049, 896.9327300452492, 1031.6079889641887, 15900.840991590167, 16138.596535086483, 16542.338306467846, 16590.585235369213, 16812.663746724997, 870.3341943413294, 882.9602667879832, 886.7472770260445, 912.2656261709255, 915.5971372596036, 8949.463032218087, 9409.529523523797, 9605.519724013911, 9780.902190977999, 9813.11681948628, 506568.0, 507158.0, 512573.0, 515321.0, 523854.0, 76534.0, 76895.6931292051, 79732.0, 80691.0, 82416.0, 1097.6706987903597, 1099.8460215569826, 1136.8181091025397, 1147.9253848499989, 1149.2127892393737, 15186.31661575254, 15187.0, 15195.0, 15409.614759631098, 15681.372745090524, 33552.0, 33723.3255334887, 33825.830870846476, 34100.488492672135, 34611.653883460844, 41366.37950430806, 42748.78625606852, 44522.77738611286, 44581.0, 44925.0, 8239.95880020596, 9033.909660903308, 9104.317176211944, 9138.588763505526, 9372.859407109036, 10353.534090966075, 10369.533370998171, 10395.63615273492, 13121.475140994253, 14793.408263669333, 12339.197952133083, 12579.182353147016, 12734.61796146117, 12756.936215318863, 12821.23072615646, 12180.208286461351, 12207.389630518615, 12620.810687839506, 12770.680732981378, 12922.935385323013, 12928.870711292766, 13250.072494925264, 13324.133931294435, 13542.932285338511, 13657.590272291847, 9198.540072996457, 9246.722598322061, 9258.0, 9276.304277179373, 9316.254699623878, 12812.551560695703, 13047.179710546725, 13179.275139867399, 13245.470181192644, 13443.991700622297], "unit": "score", "name": "jquery.html", "value": 8430.717256141237}, {"lowerIsBetter": false, "replicates": [1463.0, 1676.270822192346, 1736.5311365931195, 1759.1907722447672, 1785.8749887507872, 6323.525735569833, 7146.714131434743, 7249.202587715347, 7262.527935684177, 7266.055412796329, 7135.928640713591, 7316.048913641219, 7324.304191101837, 7327.120745510533, 7336.0463139791755, 2187.332863476639, 2204.5150066985316, 2216.6231740604057, 2225.043231410493, 2225.143319821864, 2218.245796429214, 2262.0273282488524, 2274.9545009099807, 2275.180934863448, 2276.521930394611, 2162.5999190149796, 2185.67214917762, 2193.166596693254, 2208.293346129239, 2208.856424332413, 2193.670949357593, 2214.689943407916, 2217.933461996143, 2239.8320125990454, 2242.6075436798496, 2218.1127548980376, 2250.0999600159903, 2252.0, 2257.808086312665, 2258.07418958228, 7218.8917166242545, 7294.197638259787, 7299.817504562376, 7304.780856574312, 7305.305995930378, 4374.212641724488, 4440.1563702896665, 4448.510663826976, 4461.866144015685, 4465.218586747306, 2828.915132546006, 2876.3384421582946, 2879.7408233259107, 2899.869505872241, 2919.5620656901424, 904.5025236120173, 906.7053207707521, 922.3128769067088, 951.5194826612585, 966.6471737815717, 9732.90267097327, 9772.169365603932, 9790.461524616143, 9797.16724078447, 9814.803703925953, 3940.527136743609, 3958.426028225891, 3959.6634286085427, 4010.318245898204, 4012.996750812297, 8363.916360836314, 8375.120612335739, 8390.748277551684, 8393.24460798531, 8409.075001749803, 4387.758673272937, 4405.273129933525, 4409.647228221735, 4418.6023257906945, 4418.734875907456, 3582.749207555446, 3686.963130368662, 3959.4456776051375, 4053.1285773558825, 4057.39139129133, 3470.35798377301, 3470.444728843373, 3484.494748261488, 3508.7894726316504, 3513.3851575974613, 1152.3201311226417, 1155.6648571914218, 1158.2529268621693, 1160.8316794064813, 1171.291368721928, 985.3348989432247, 992.1764935103846, 1000.6547741029333, 1093.6554985179644, 1300.648824817294, 6816.182058152955, 6824.146981627297, 6853.554518956252, 6853.588784672936, 6858.211305699809, 449.8380582990121, 452.14093222876795, 457.1633909944793, 458.86004768545916, 459.8620413875824, 5402.189671549299, 5415.0, 5416.350037995466, 5417.512423881791, 5424.728763561806, 7809.258120478546, 7982.760517184493, 8356.958215208884, 8382.161783821692, 8538.146185381413, 7999.680012799539, 8078.8788168177525, 8087.231712987257, 8127.79680507992, 8151.0, 6799.946008368711, 6817.420519255918, 6868.587884726932, 6932.0, 6934.653267336613, 7017.0, 7069.081019467436, 7074.964625176841, 7075.646217689198, 7082.18554866197, 7752.7674169775, 7773.961130194539, 7873.645685944261, 7901.288884000468, 7924.801879952816, 7875.054993400829, 7929.0, 8221.630026648934, 8265.090840007715, 8334.666613335641, 5778.8266352009505, 6171.321154673072, 6173.043178307369, 6640.402363787282, 6713.731450742111, 6865.691043902936, 6989.440844732308, 7013.859722805413, 7054.753083642048, 7056.223815380406, 6381.968090159519, 6589.604623722592, 6620.073189753342, 6641.800745977628, 6694.665266736741, 6512.153420055362, 6577.901331479936, 6659.766908158192, 6702.994550817221, 6719.865602687821, 6728.899066513908, 6778.4916131289365, 6779.254282029072, 6783.287754785676, 6790.015447759948, 5988.221531200916, 6124.846878827887, 6128.387161284014, 6128.63228206309, 6133.785317513865, 6087.817365479043, 6143.477804386677, 6145.201123853871, 6147.262328520606, 6148.815535533941], "unit": "score", "name": "mootools.html", "value": 4143.859786494294}, {"lowerIsBetter": false, "replicates": [332.4871833159126, 337.0696876620528, 337.6792047554824, 341.0127680365342, 342.6111363602312, 5827.096799995997, 5916.881662366755, 5929.851753706149, 5979.103134529817, 6017.398260173986, 5753.683547404891, 5886.852828679285, 5896.086106653475, 5916.290045194572, 5939.88120237595, 4613.8615841524725, 4618.261078227484, 4621.329907163459, 4628.328892310613, 4628.514006029369, 4415.933760993587, 4496.168208881368, 4524.389207457, 4635.072985402916, 4650.069986002796, 4566.474855391622, 4570.565796249351, 4573.885652858672, 4581.7709114544305, 4600.263957766741, 4570.931436028445, 4571.474280457756, 4587.862364129048, 4590.862274131781, 4611.930821037654, 4071.7760523171214, 4072.0837811492474, 4072.368782838635, 4079.1229885574744, 4080.2451546463703, 5576.107822748381, 5616.943830561683, 5669.319681638189, 5671.914921276184, 5675.943240567624, 5365.7853685852515, 5374.7850085996515, 5374.91937620936, 5377.0052540279785, 5384.326959130109, 6070.6357618543025, 6302.716377763011, 6303.684815759194, 6304.369563043705, 6305.96847015762, 4302.870913872557, 4368.213721530124, 4379.605835474791, 4405.074934263808, 4406.647468202568, 6512.381323774282, 6552.443042341407, 6572.76995305162, 6586.37429444202, 6594.703238354237, 4463.285874260103, 4490.842820501267, 4497.190505709003, 4497.280435130363, 4502.594766471033, 4495.43807024122, 4551.613112885376, 4557.134144512598, 4661.533846615312, 4683.461401938753, 5315.920261196085, 5317.946820531745, 5320.813771518056, 5322.946770532322, 5323.494268044607, 6307.590006649553, 6309.905351419732, 6312.810615681537, 6322.209723784527, 6326.398992095744, 1615.8626516746208, 1634.7384418492984, 1635.2314412226235, 1636.2227941727583, 1639.131260431973, 1118.3904771899333, 1125.5947858770835, 1129.711923459529, 1131.7057565033151, 1153.8846115388562, 6067.908981365283, 6076.878462430726, 6079.696015199311, 6079.969600151971, 6082.817515474543, 6560.278369379364, 6564.638944857983, 6565.835854103686, 6567.080608714784, 6571.769988050491, 5913.881722365529, 6061.181740464981, 6069.332373438918, 6073.362296958844, 6075.908861367083, 3532.6290739471983, 3562.7327950403824, 3563.625819288989, 3563.893083207508, 3564.572251329805, 6659.567128136656, 6661.034150048215, 6668.266490686021, 6669.166354205724, 6670.366315200048, 6622.735090596419, 6694.297098804653, 6710.563813352116, 6716.0, 6717.932820671828, 6565.409113179837, 6724.0, 6729.158855143107, 6736.696848641823, 6740.494462915203, 6393.1369265148605, 6528.445082168069, 6622.106015688013, 6636.104125942936, 6641.501887358564, 6430.871382572229, 6509.0, 6531.967340163269, 6532.248791389051, 6549.7380104795275, 6691.297413771484, 6695.263521012587, 6699.129113215251, 6699.464042876461, 6711.63086030273, 4345.261305577996, 4452.2431186697695, 4487.775611219491, 4489.77551122436, 4492.707973981681, 6570.8028759137305, 6579.769708060195, 6580.243272023587, 6586.50601204902, 6587.110740050032, 6396.872062558816, 6404.903926441014, 6408.166938297992, 6409.9038514423255, 6411.070394792636, 6286.151369565233, 6379.52153588492, 6384.329645387167, 6386.489080873612, 6390.680465976589, 6271.43557079865, 6273.811785646438, 6280.434760871543, 6281.277653069956, 6284.74861005573, 6404.231492220963, 6406.711697973696, 6418.839529011812, 6419.358064193543, 6421.0, 6118.2658081028785, 6247.187865577446, 6247.3440288769025, 6247.656378899204, 6250.812475625738], "unit": "score", "name": "prototype.html", "value": 4796.279473638128}, {"lowerIsBetter": false, "replicates": [783.2089589514592, 853.0531110467384, 874.4141425245085, 876.1632640828008, 902.4179404284241, 13787.58637240883, 13864.23746693934, 13888.444462221525, 13897.166170029805, 13901.165930044192, 11962.0, 12722.618321450349, 12779.872201277984, 12794.552190673328, 12847.29339886306, 664.2095905872021, 817.5094943034162, 826.6569373709904, 827.0241115483727, 827.0571548434789, 820.2822530285999, 827.1108558299821, 827.1315119124924, 829.6266679993996, 830.0951962361025, 847.1782371100023, 847.6016272351985, 849.2484151525913, 851.7529916324289, 853.3088198559155, 685.4105469296401, 850.2602735619988, 850.3282406898543, 850.8085680721819, 851.9787005324855, 518.0183552168656, 622.5642050564622, 623.2801114712514, 629.062696582094, 629.7701339011228, 12070.758584828342, 12114.454849531705, 12160.939195304056, 12175.147739658227, 12195.573154939624, 11573.24773889703, 12030.218035827731, 12206.511739530408, 12554.246745195227, 12597.811032834516, 9985.151262142726, 10004.649837255662, 10075.294729368947, 10478.79042419155, 10663.84004239937, 3576.3807781957867, 3629.5100161478126, 3668.614795446493, 3686.299603075407, 3694.612065733086, 43205.35191972123, 43263.78368108171, 43331.96676232665, 43360.783196083816, 43391.0, 9685.564149613285, 9954.45250511229, 9975.451350175665, 9998.650047248457, 10040.899591004143, 17495.38766143179, 17641.206145723216, 17665.55836104082, 17849.7322540162, 18168.909155454137, 7156.427485801123, 7194.748183813646, 7277.636118194069, 7392.297731715478, 7436.330730234305, 4183.937240941388, 4278.994436307466, 4285.657147428198, 4312.482502099705, 4323.351497275434, 2894.8552572371295, 2929.3262549613282, 2937.2950491881793, 2939.3092623233524, 2954.2023653613405, 505.36071869085634, 515.4819406496447, 518.0209404226016, 527.8416475057468, 530.6444682063027, 520.6043407010624, 571.3543695623919, 587.5064945445846, 644.2301449767483, 701.6248153618964, 8241.25828675422, 8414.747557573282, 8611.224989750952, 9439.669611563562, 9485.857712134324, 577.5856918082372, 621.8725161341914, 697.1390332938817, 707.2856415020866, 737.3695490355668, 3929.3713005918917, 3969.622885825842, 3990.840366385312, 4093.6520395766693, 4179.749215047107, 51580.0, 51602.48397516052, 51745.74127129416, 52143.0, 52368.73815630974, 45760.542394576296, 46445.76777116093, 47022.0, 47156.764216179385, 47600.761996189794, 42183.36724949128, 42933.35599966003, 42942.57057429386, 43294.56705432968, 43638.56361436345, 8343.45767525109, 8360.08039115709, 8427.279053583905, 8650.480971141751, 9197.816043679222, 32181.195470113435, 32883.0, 33746.0, 34177.0, 34376.48435273523, 40425.0, 41378.0, 41574.96062598459, 41741.79129104335, 42428.787856060524, 10632.202584806017, 11111.611093611686, 11189.216754827085, 11236.887631123584, 11284.548618055185, 12186.756264874475, 12266.815997759863, 12490.56283030126, 13076.869231307946, 13191.274479903697, 11375.20373573875, 11731.23746956445, 11846.940765296118, 11921.642350729491, 12235.571754988532, 11488.54045838157, 11691.941540292244, 11767.529298828293, 12004.459799308877, 12156.62361549859, 11212.943935280271, 11343.829842552203, 11413.0, 11473.942630286796, 11759.647210583697, 9899.65351212704, 10095.091441769982, 10214.285000049926, 10250.641227557, 10601.893981060091, 8634.697785577475, 8984.416012959136, 9133.178013978773, 9792.559334829808, 9795.216382689225], "unit": "score", "name": "yui.html", "value": 6191.533640699866}], "name": "dromaeo_css", "value": 6804.061081869278}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 106.0, 110.0, 110.0, 110.0, 101.0, 110.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 145.0, 156.0, 125.0, 153.0, 154.0, 123.0, 163.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 159.0, 164.0, 160.0, 161.0, 160.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 89.0, 103.0, 71.0, 74.0, 72.0, 101.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 138.0, 93.0, 94.0, 92.0, 146.0, 94.0, 93.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 144.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 58.0, 57.0, 57.0, 57.0, 67.0, 59.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 91.0, 84.0, 84.0, 84.0, 85.0, 85.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 132.0, 120.0, 116.0, 121.0, 120.0, 124.0, 126.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 150.0, 152.0, 149.0, 141.0, 150.0, 150.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 69.0, 69.0, 67.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1499.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.94756057085962], "unit": "score", "name": "Richards", "value": 212.72985200000008}, {"lowerIsBetter": false, "replicates": [188.82175226586102], "unit": "score", "name": "DeltaBlue", "value": 350.16092799999996}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [1936.1702127659576], "unit": "score", "name": "RayTrace", "value": 382.19212087912075}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12365.853658536585], "unit": "score", "name": "Boyer", "value": 53.89542998027611}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [594.883997620464], "unit": "score", "name": "Splay", "value": 136.98637100000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19857.321876137386}]} 10:10:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19857.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1499.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6804.06"}}} 10:10:43 INFO - Return code: 0 10:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:10:43 ERROR - # TBPL SUCCESS # 10:10:43 INFO - Running post-action listener: _resource_record_post_action 10:10:43 INFO - Running post-run listener: _resource_record_post_run 10:10:44 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 262144; Write bytes: 314220544; Read time: 212; Write time: 158608 10:10:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1572864; Read time: 0; Write time: 56 10:10:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 262144; Write bytes: 312647680; Read time: 212; Write time: 158552 10:10:44 INFO - Running post-run listener: _upload_blobber_files 10:10:44 INFO - Blob upload gear active. 10:10:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:10:44 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:10:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:10:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:10:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:46 INFO - (blobuploader) - INFO - Done attempting. 10:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:47 INFO - (blobuploader) - INFO - Done attempting. 10:10:47 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:47 INFO - Return code: 0 10:10:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:10:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba418423df041d529b67661fcf82c97d78c574dc29f6bff2293026e9e0b3d41033798bbf09c752a163c1ac69a22385f5732aee9ee4159a247933e95d90890c8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6b8006fcf8360daf2b792e5f7d821002f7f155f6a03d28cef53e0070ba74d79ada0661481803eb5859f781d37f0dd31e1fc9ef9f33969b681bb548a0fe59802"} 10:10:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:10:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:10:47 INFO - Contents: 10:10:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba418423df041d529b67661fcf82c97d78c574dc29f6bff2293026e9e0b3d41033798bbf09c752a163c1ac69a22385f5732aee9ee4159a247933e95d90890c8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6b8006fcf8360daf2b792e5f7d821002f7f155f6a03d28cef53e0070ba74d79ada0661481803eb5859f781d37f0dd31e1fc9ef9f33969b681bb548a0fe59802"} 10:10:47 INFO - Copying logs to upload dir... 10:10:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.694127 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-20 10:10:47.221800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-20 10:10:47.225733) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba418423df041d529b67661fcf82c97d78c574dc29f6bff2293026e9e0b3d41033798bbf09c752a163c1ac69a22385f5732aee9ee4159a247933e95d90890c8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6b8006fcf8360daf2b792e5f7d821002f7f155f6a03d28cef53e0070ba74d79ada0661481803eb5859f781d37f0dd31e1fc9ef9f33969b681bb548a0fe59802"} build_url:https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/UbrpnydvS2-HBXz-Ujo1OQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ba418423df041d529b67661fcf82c97d78c574dc29f6bff2293026e9e0b3d41033798bbf09c752a163c1ac69a22385f5732aee9ee4159a247933e95d90890c8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a6b8006fcf8360daf2b792e5f7d821002f7f155f6a03d28cef53e0070ba74d79ada0661481803eb5859f781d37f0dd31e1fc9ef9f33969b681bb548a0fe59802"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-20 10:10:47.250517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 10:10:47.250848) ========= 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=21869f6c619b95355032545b000001da-1450625372.56614-57961688 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-20 10:10:47.335391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 10:10:47.336109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-20 10:10:47.336738) ========= ========= Total master_lag: 0.31 =========