builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1448372538.41 results: success (0) buildid: 20151124030553 builduid: 02d4a55c39f24d7aa7b615644e0e2224 revision: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.408639) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.409214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.409601) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.431510) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.431857) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.442447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.442964) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.495027) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.495557) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.496066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.496483) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 05:42:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-11-24 05:42:18 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.707548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.707925) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019171 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:18.759231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 05:42:18.759630) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45273bbed8efaface6f5ec56d984cb9faf4fbb6a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45273bbed8efaface6f5ec56d984cb9faf4fbb6a --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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 05:42:19,099 truncating revision to first 12 chars 2015-11-24 05:42:19,099 Setting DEBUG logging. 2015-11-24 05:42:19,099 attempt 1/10 2015-11-24 05:42:19,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45273bbed8ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 05:42:20,192 unpacking tar archive at: mozilla-central-45273bbed8ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 05:42:20.146711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:20.147141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:20.157060) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:20.157447) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 05:42:20.157920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-24 05:42:20.158260) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:20 INFO - MultiFileLogger online at 20151124 05:42:20 in /builds/slave/test-pgo 05:42:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:42:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:42:20 INFO - {'append_to_log': False, 05:42:20 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:42:20 INFO - 'blob_upload_branch': 'Firefox', 05:42:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:42:20 INFO - 'branch': 'Firefox', 05:42:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:20 INFO - 'config_files': ('talos/linux_config.py',), 05:42:20 INFO - 'default_actions': ('clobber', 05:42:20 INFO - 'read-buildbot-config', 05:42:20 INFO - 'download-and-extract', 05:42:20 INFO - 'populate-webroot', 05:42:20 INFO - 'create-virtualenv', 05:42:20 INFO - 'install', 05:42:20 INFO - 'run-tests'), 05:42:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:20 INFO - 'download_minidump_stackwalk': True, 05:42:20 INFO - 'download_symbols': 'ondemand', 05:42:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:42:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:42:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:42:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:42:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:20 INFO - 'installer_path': 'installer.exe', 05:42:20 INFO - 'log_level': 'info', 05:42:20 INFO - 'log_name': 'talos', 05:42:20 INFO - 'log_to_console': True, 05:42:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:20 INFO - 'opt_config_files': (), 05:42:20 INFO - 'pip_index': False, 05:42:20 INFO - 'sps_profile': False, 05:42:20 INFO - 'sps_profile_interval': 0, 05:42:20 INFO - 'suite': 'dromaeojs-e10s', 05:42:20 INFO - 'system_bits': '64', 05:42:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:20 INFO - 'title': 'talos-linux64-ix-016', 05:42:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:20 INFO - 'use_talos_json': True, 05:42:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:42:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:20 INFO - 'work_dir': 'build'} 05:42:20 INFO - ##### 05:42:20 INFO - ##### Running clobber step. 05:42:20 INFO - ##### 05:42:20 INFO - Running pre-action listener: _resource_record_pre_action 05:42:20 INFO - Running main action method: clobber 05:42:20 INFO - rmtree: /builds/slave/test-pgo/build 05:42:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:42:21 INFO - Running post-action listener: _resource_record_post_action 05:42:21 INFO - ##### 05:42:21 INFO - ##### Running read-buildbot-config step. 05:42:21 INFO - ##### 05:42:21 INFO - Running pre-action listener: _resource_record_pre_action 05:42:21 INFO - Running main action method: read_buildbot_config 05:42:21 INFO - Using buildbot properties: 05:42:21 INFO - { 05:42:21 INFO - "properties": { 05:42:21 INFO - "buildnumber": 560, 05:42:21 INFO - "product": "firefox", 05:42:21 INFO - "script_repo_revision": "production", 05:42:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:42:21 INFO - "repository": "", 05:42:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:42:21 INFO - "buildid": "20151124030553", 05:42:21 INFO - "slavename": "talos-linux64-ix-016", 05:42:21 INFO - "stage_platform": "linux64-pgo", 05:42:21 INFO - "basedir": "/builds/slave/test-pgo", 05:42:21 INFO - "nightly_build": "True", 05:42:21 INFO - "project": "", 05:42:21 INFO - "platform": "ubuntu64_hw", 05:42:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:42:21 INFO - "slavebuilddir": "test", 05:42:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:42:21 INFO - "branch": "mozilla-central", 05:42:21 INFO - "repo_path": "mozilla-central", 05:42:21 INFO - "pgo_build": "True", 05:42:21 INFO - "builduid": "02d4a55c39f24d7aa7b615644e0e2224", 05:42:21 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:42:21 INFO - }, 05:42:21 INFO - "sourcestamp": { 05:42:21 INFO - "repository": "", 05:42:21 INFO - "hasPatch": false, 05:42:21 INFO - "project": "", 05:42:21 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:42:21 INFO - "changes": [ 05:42:21 INFO - { 05:42:21 INFO - "category": null, 05:42:21 INFO - "files": [ 05:42:21 INFO - { 05:42:21 INFO - "url": null, 05:42:21 INFO - "name": "https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:42:21 INFO - } 05:42:21 INFO - ], 05:42:21 INFO - "repository": "", 05:42:21 INFO - "rev": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a", 05:42:21 INFO - "who": "sendchange", 05:42:21 INFO - "when": 1448372490, 05:42:21 INFO - "number": 6700149, 05:42:21 INFO - "comments": "", 05:42:21 INFO - "project": "", 05:42:21 INFO - "at": "Tue 24 Nov 2015 05:41:30", 05:42:21 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:42:21 INFO - "revlink": "", 05:42:21 INFO - "properties": [ 05:42:21 INFO - [ 05:42:21 INFO - "buildid", 05:42:21 INFO - "20151124030553", 05:42:21 INFO - "Change" 05:42:21 INFO - ], 05:42:21 INFO - [ 05:42:21 INFO - "builduid", 05:42:21 INFO - "02d4a55c39f24d7aa7b615644e0e2224", 05:42:21 INFO - "Change" 05:42:21 INFO - ], 05:42:21 INFO - [ 05:42:21 INFO - "nightly_build", 05:42:21 INFO - "True", 05:42:21 INFO - "Change" 05:42:21 INFO - ], 05:42:21 INFO - [ 05:42:21 INFO - "pgo_build", 05:42:21 INFO - "True", 05:42:21 INFO - "Change" 05:42:21 INFO - ] 05:42:21 INFO - ], 05:42:21 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:42:21 INFO - } 05:42:21 INFO - ], 05:42:21 INFO - "revision": "45273bbed8efaface6f5ec56d984cb9faf4fbb6a" 05:42:21 INFO - } 05:42:21 INFO - } 05:42:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:42:21 INFO - Running post-action listener: _resource_record_post_action 05:42:21 INFO - ##### 05:42:21 INFO - ##### Running download-and-extract step. 05:42:21 INFO - ##### 05:42:21 INFO - Running pre-action listener: _resource_record_pre_action 05:42:21 INFO - Running main action method: download_and_extract 05:42:21 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:42:21 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')]} 05:42:21 INFO - https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/test_packages.json 05:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/test_packages.json 05:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:42:21 INFO - Downloaded 1302 bytes. 05:42:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:42:21 INFO - Using the following test package requirements: 05:42:21 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:21 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:42:21 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'jsshell-linux-x86_64.zip'], 05:42:21 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:42:21 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:21 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:42:21 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:42:21 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:42:21 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:42:21 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:42:21 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:42:21 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:42:21 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')]} 05:42:21 INFO - https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:42:22 INFO - Downloaded 22526311 bytes. 05:42:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:42:23 INFO - Return code: 0 05:42:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:42:23 INFO - https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:42:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:42:24 INFO - retry: attempt #1 caught exception: '' 05:42:24 INFO - retry: Failed, sleeping 30 seconds before retrying 05:42:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 05:42:55 INFO - Downloaded 22526311 bytes. 05:42:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:42:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:42:56 INFO - Return code: 0 05:42: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')]} 05:42:56 INFO - https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:42:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:42:57 INFO - Downloaded 11130997 bytes. 05:42:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:42:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:42:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:42:57 INFO - Return code: 0 05:42:57 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')]} 05:42:57 INFO - https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:42:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:42:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:42:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:42:59 INFO - Downloaded 57566580 bytes. 05:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:42:59 INFO - mkdir: /builds/slave/test-pgo/properties 05:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:42:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:42:59 INFO - Contents: 05:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:42:59 INFO - Running post-action listener: _resource_record_post_action 05:42:59 INFO - Running post-action listener: set_extra_try_arguments 05:42:59 INFO - ##### 05:42:59 INFO - ##### Running populate-webroot step. 05:42:59 INFO - ##### 05:42:59 INFO - Running pre-action listener: _resource_record_pre_action 05:42:59 INFO - Running main action method: populate_webroot 05:42:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:42:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:42:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:42:59 INFO - '../fennec_ids.txt'], 05:42:59 INFO - 'tests': ['tcheck2']}, 05:42:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:42:59 INFO - '--tppagecycles', 05:42:59 INFO - '7'], 05:42:59 INFO - 'tests': ['tsvgm']}}, 05:42:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:42:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:42:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:42:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:42:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:42:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'tests': ['damp', 'tps']}, 05:42:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['damp', 'tps']}, 05:42:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:42:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:42:59 INFO - 'other': {'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'other_l64': {'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:42:59 INFO - 'ts_paint', 05:42:59 INFO - 'tpaint', 05:42:59 INFO - 'sessionrestore', 05:42:59 INFO - 'sessionrestore_no_auto_restore']}, 05:42:59 INFO - 'svgr': {'tests': ['tsvgx', 05:42:59 INFO - 'tsvgr_opacity', 05:42:59 INFO - 'tart', 05:42:59 INFO - 'tscrollx', 05:42:59 INFO - 'cart']}, 05:42:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['tsvgx', 05:42:59 INFO - 'tsvgr_opacity', 05:42:59 INFO - 'tart', 05:42:59 INFO - 'tscrollx', 05:42:59 INFO - 'cart']}, 05:42:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'tests': ['tp5o']}, 05:42:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'talos_options': ['--e10s'], 05:42:59 INFO - 'tests': ['tp5o']}, 05:42:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'talos_options': ['--xperf_path', 05:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:59 INFO - 'tests': ['tp5n']}, 05:42:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:42:59 INFO - 'talos_options': ['--e10s', 05:42:59 INFO - '--xperf_path', 05:42:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:42:59 INFO - 'tests': ['tp5n']}}, 05:42:59 INFO - 'talos.zip': {'path': '', 05:42:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:42:59 INFO - Running post-action listener: _resource_record_post_action 05:42:59 INFO - ##### 05:42:59 INFO - ##### Running create-virtualenv step. 05:42:59 INFO - ##### 05:42:59 INFO - Running pre-action listener: _resource_record_pre_action 05:42:59 INFO - Running main action method: create_virtualenv 05:42:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:42:59 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 05:42:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:42:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:42:59 INFO - Using real prefix '/usr' 05:42:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:42:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:01 INFO - Installing pip.................done. 05:43:01 INFO - Return code: 0 05:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:43:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:01 INFO - Using env: {'DISPLAY': ':0', 05:43:01 INFO - 'HOME': '/home/cltbld', 05:43:01 INFO - 'LANG': 'en_US.UTF-8', 05:43:01 INFO - 'LANGUAGE': 'en_US:en', 05:43:01 INFO - 'LOGNAME': 'cltbld', 05:43:01 INFO - 'MAIL': '/var/mail/cltbld', 05:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:01 INFO - 'MOZ_NO_REMOTE': '1', 05:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:01 INFO - 'NO_EM_RESTART': '1', 05:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:01 INFO - 'SHELL': '/bin/bash', 05:43:01 INFO - 'SHLVL': '1', 05:43:01 INFO - 'TERM': 'linux', 05:43:01 INFO - 'TMOUT': '86400', 05:43:01 INFO - 'USER': 'cltbld', 05:43:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:01 INFO - '_': '/tools/buildbot/bin/python'} 05:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:01 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 05:43:01 INFO - Cleaning up... 05:43:01 INFO - Return code: 0 05:43:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:43:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:43:01 INFO - Using env: {'DISPLAY': ':0', 05:43:01 INFO - 'HOME': '/home/cltbld', 05:43:01 INFO - 'LANG': 'en_US.UTF-8', 05:43:01 INFO - 'LANGUAGE': 'en_US:en', 05:43:01 INFO - 'LOGNAME': 'cltbld', 05:43:01 INFO - 'MAIL': '/var/mail/cltbld', 05:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:01 INFO - 'MOZ_NO_REMOTE': '1', 05:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:01 INFO - 'NO_EM_RESTART': '1', 05:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:01 INFO - 'SHELL': '/bin/bash', 05:43:01 INFO - 'SHLVL': '1', 05:43:01 INFO - 'TERM': 'linux', 05:43:01 INFO - 'TMOUT': '86400', 05:43:01 INFO - 'USER': 'cltbld', 05:43:01 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:01 INFO - '_': '/tools/buildbot/bin/python'} 05:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:02 INFO - Downloading/unpacking psutil>=0.7.1 05:43:02 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 05:43:02 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 05:43:02 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 05:43:02 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 05:43:02 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 05:43:02 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 05:43:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:43:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:43:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:04 INFO - Installing collected packages: psutil 05:43:04 INFO - Running setup.py install for psutil 05:43:04 INFO - building 'psutil._psutil_linux' extension 05:43:04 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 05:43:04 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 05:43:04 INFO - building 'psutil._psutil_posix' extension 05:43:04 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 05:43:04 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 05:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:04 INFO - Successfully installed psutil 05:43:04 INFO - Cleaning up... 05:43:04 INFO - Return code: 0 05:43:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:43:04 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')]} 05:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:04 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')]} 05:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:04 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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:04 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 05:43:04 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 05:43:04 INFO - Using env: {'DISPLAY': ':0', 05:43:04 INFO - 'HOME': '/home/cltbld', 05:43:04 INFO - 'LANG': 'en_US.UTF-8', 05:43:04 INFO - 'LANGUAGE': 'en_US:en', 05:43:04 INFO - 'LOGNAME': 'cltbld', 05:43:04 INFO - 'MAIL': '/var/mail/cltbld', 05:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:04 INFO - 'MOZ_NO_REMOTE': '1', 05:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:04 INFO - 'NO_EM_RESTART': '1', 05:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:04 INFO - 'SHELL': '/bin/bash', 05:43:04 INFO - 'SHLVL': '1', 05:43:04 INFO - 'TERM': 'linux', 05:43:04 INFO - 'TMOUT': '86400', 05:43:04 INFO - 'USER': 'cltbld', 05:43:04 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:04 INFO - '_': '/tools/buildbot/bin/python'} 05:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:43:04 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 05:43:04 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 05:43:04 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 05:43:04 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 05:43:04 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 05:43:04 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 05:43:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:43:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:43:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:43:06 INFO - Installing collected packages: mozsystemmonitor 05:43:06 INFO - Running setup.py install for mozsystemmonitor 05:43:06 INFO - Successfully installed mozsystemmonitor 05:43:06 INFO - Cleaning up... 05:43:06 INFO - Return code: 0 05:43:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:06 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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:06 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 05:43:06 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 05:43:06 INFO - Using env: {'DISPLAY': ':0', 05:43:06 INFO - 'HOME': '/home/cltbld', 05:43:06 INFO - 'LANG': 'en_US.UTF-8', 05:43:06 INFO - 'LANGUAGE': 'en_US:en', 05:43:06 INFO - 'LOGNAME': 'cltbld', 05:43:06 INFO - 'MAIL': '/var/mail/cltbld', 05:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:06 INFO - 'MOZ_NO_REMOTE': '1', 05:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:06 INFO - 'NO_EM_RESTART': '1', 05:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:06 INFO - 'SHELL': '/bin/bash', 05:43:06 INFO - 'SHLVL': '1', 05:43:06 INFO - 'TERM': 'linux', 05:43:06 INFO - 'TMOUT': '86400', 05:43:06 INFO - 'USER': 'cltbld', 05:43:06 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:06 INFO - '_': '/tools/buildbot/bin/python'} 05:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:06 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 05:43:06 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 05:43:06 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 05:43:06 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 05:43:06 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 05:43:06 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 05:43:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:43:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:08 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 05:43:08 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 05:43:08 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 05:43:08 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 05:43:08 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 05:43:08 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 05:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:43:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:43:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:09 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 05:43:09 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 05:43:09 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 05:43:09 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 05:43:09 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 05:43:09 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 05:43:09 INFO - Downloading docopt-0.6.1.tar.gz 05:43:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:43:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:09 INFO - Running setup.py install for blobuploader 05:43:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:43:09 INFO - Running setup.py install for requests 05:43:09 INFO - Running setup.py install for docopt 05:43:09 INFO - Successfully installed blobuploader requests docopt 05:43:09 INFO - Cleaning up... 05:43:10 INFO - Return code: 0 05:43:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:10 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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:10 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 05:43:10 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 05:43:10 INFO - Using env: {'DISPLAY': ':0', 05:43:10 INFO - 'HOME': '/home/cltbld', 05:43:10 INFO - 'LANG': 'en_US.UTF-8', 05:43:10 INFO - 'LANGUAGE': 'en_US:en', 05:43:10 INFO - 'LOGNAME': 'cltbld', 05:43:10 INFO - 'MAIL': '/var/mail/cltbld', 05:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:10 INFO - 'MOZ_NO_REMOTE': '1', 05:43:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:10 INFO - 'NO_EM_RESTART': '1', 05:43:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:10 INFO - 'SHELL': '/bin/bash', 05:43:10 INFO - 'SHLVL': '1', 05:43:10 INFO - 'TERM': 'linux', 05:43:10 INFO - 'TMOUT': '86400', 05:43:10 INFO - 'USER': 'cltbld', 05:43:10 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:10 INFO - '_': '/tools/buildbot/bin/python'} 05:43:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:10 INFO - Running setup.py (path:/tmp/pip-9NdGa6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:10 INFO - Running setup.py (path:/tmp/pip-kTjROd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:10 INFO - Running setup.py (path:/tmp/pip-Lbm38T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:10 INFO - Running setup.py (path:/tmp/pip-tOHQ6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:10 INFO - Running setup.py (path:/tmp/pip-e0TW30-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:10 INFO - Running setup.py (path:/tmp/pip-afAYk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:10 INFO - Running setup.py (path:/tmp/pip-gpEXt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:10 INFO - Running setup.py (path:/tmp/pip-qPjwWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:10 INFO - Running setup.py (path:/tmp/pip-YTELJA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:10 INFO - Running setup.py (path:/tmp/pip-NyQmV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:10 INFO - Running setup.py (path:/tmp/pip-NRWJWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:11 INFO - Running setup.py (path:/tmp/pip-O7rGOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:11 INFO - Running setup.py (path:/tmp/pip-io5udA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:11 INFO - Running setup.py (path:/tmp/pip-CEOEPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:11 INFO - Running setup.py (path:/tmp/pip-HdZydr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:11 INFO - Running setup.py (path:/tmp/pip-Dq16PQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:11 INFO - Running setup.py (path:/tmp/pip-MFZq_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:11 INFO - Running setup.py install for manifestparser 05:43:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:43:11 INFO - Running setup.py install for mozcrash 05:43:11 INFO - Running setup.py install for mozdebug 05:43:11 INFO - Running setup.py install for mozdevice 05:43:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:43:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:43:11 INFO - Running setup.py install for mozfile 05:43:11 INFO - Running setup.py install for mozhttpd 05:43:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozinfo 05:43:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozInstall 05:43:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozleak 05:43:12 INFO - Running setup.py install for mozlog 05:43:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for moznetwork 05:43:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozprocess 05:43:12 INFO - Running setup.py install for mozprofile 05:43:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozrunner 05:43:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:43:12 INFO - Running setup.py install for mozscreenshot 05:43:13 INFO - Running setup.py install for moztest 05:43:13 INFO - Running setup.py install for mozversion 05:43:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:43:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:13 INFO - Cleaning up... 05:43:13 INFO - Return code: 0 05:43:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 05:43:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 05:43:13 INFO - Using env: {'DISPLAY': ':0', 05:43:13 INFO - 'HOME': '/home/cltbld', 05:43:13 INFO - 'LANG': 'en_US.UTF-8', 05:43:13 INFO - 'LANGUAGE': 'en_US:en', 05:43:13 INFO - 'LOGNAME': 'cltbld', 05:43:13 INFO - 'MAIL': '/var/mail/cltbld', 05:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:13 INFO - 'MOZ_NO_REMOTE': '1', 05:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:13 INFO - 'NO_EM_RESTART': '1', 05:43:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:13 INFO - 'SHELL': '/bin/bash', 05:43:13 INFO - 'SHLVL': '1', 05:43:13 INFO - 'TERM': 'linux', 05:43:13 INFO - 'TMOUT': '86400', 05:43:13 INFO - 'USER': 'cltbld', 05:43:13 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:13 INFO - '_': '/tools/buildbot/bin/python'} 05:43:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:13 INFO - Running setup.py (path:/tmp/pip-mhL4GT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:13 INFO - Running setup.py (path:/tmp/pip-QIPD9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:13 INFO - Running setup.py (path:/tmp/pip-fawX0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:13 INFO - Running setup.py (path:/tmp/pip-v1PAiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:13 INFO - Running setup.py (path:/tmp/pip-_OrFi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:13 INFO - Running setup.py (path:/tmp/pip-tKQsng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:13 INFO - Running setup.py (path:/tmp/pip-dGks7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:43:13 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)) 05:43:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:13 INFO - Running setup.py (path:/tmp/pip-zcy26A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:14 INFO - Running setup.py (path:/tmp/pip-bYPsny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:14 INFO - Running setup.py (path:/tmp/pip-YsRQSp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:14 INFO - Running setup.py (path:/tmp/pip-IocoBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:14 INFO - Running setup.py (path:/tmp/pip-WWRI_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:14 INFO - Running setup.py (path:/tmp/pip-0UCtz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:14 INFO - Running setup.py (path:/tmp/pip-MMADvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:14 INFO - Running setup.py (path:/tmp/pip-rOKtO4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:14 INFO - Running setup.py (path:/tmp/pip-mflTH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:43:14 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)) 05:43:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:14 INFO - Running setup.py (path:/tmp/pip-TPGxSN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 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)) 05:43:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43: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 05:43:16 INFO - Downloading blessings-1.5.1.tar.gz 05:43:16 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 05:43:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:16 INFO - Installing collected packages: blessings 05:43:16 INFO - Running setup.py install for blessings 05:43:16 INFO - Successfully installed blessings 05:43:16 INFO - Cleaning up... 05:43:16 INFO - Return code: 0 05:43:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:43:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:16 INFO - Reading from file tmpfile_stdout 05:43:16 INFO - Current package versions: 05:43:16 INFO - argparse == 1.2.1 05:43:16 INFO - blessings == 1.5.1 05:43:16 INFO - blobuploader == 1.2.4 05:43:16 INFO - docopt == 0.6.1 05:43:16 INFO - manifestparser == 1.1 05:43:16 INFO - mozInstall == 1.12 05:43:16 INFO - mozcrash == 0.16 05:43:16 INFO - mozdebug == 0.1 05:43:16 INFO - mozdevice == 0.47 05:43:16 INFO - mozfile == 1.2 05:43:16 INFO - mozhttpd == 0.7 05:43:16 INFO - mozinfo == 0.9 05:43:16 INFO - mozleak == 0.1 05:43:16 INFO - mozlog == 3.1 05:43:16 INFO - moznetwork == 0.27 05:43:16 INFO - mozprocess == 0.22 05:43:16 INFO - mozprofile == 0.27 05:43:16 INFO - mozrunner == 6.11 05:43:16 INFO - mozscreenshot == 0.1 05:43:16 INFO - mozsystemmonitor == 0.0 05:43:16 INFO - moztest == 0.7 05:43:16 INFO - mozversion == 1.4 05:43:16 INFO - psutil == 3.1.1 05:43:16 INFO - requests == 1.2.3 05:43:16 INFO - wsgiref == 0.1.2 05:43:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:43:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:43:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f10fceedc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ed6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x159f7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, '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': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', '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 05:43:16 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 05:43:16 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 05:43:16 INFO - Using env: {'DISPLAY': ':0', 05:43:16 INFO - 'HOME': '/home/cltbld', 05:43:16 INFO - 'LANG': 'en_US.UTF-8', 05:43:16 INFO - 'LANGUAGE': 'en_US:en', 05:43:16 INFO - 'LOGNAME': 'cltbld', 05:43:16 INFO - 'MAIL': '/var/mail/cltbld', 05:43:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:16 INFO - 'MOZ_NO_REMOTE': '1', 05:43:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:16 INFO - 'NO_EM_RESTART': '1', 05:43:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:16 INFO - 'SHELL': '/bin/bash', 05:43:16 INFO - 'SHLVL': '1', 05:43:16 INFO - 'TERM': 'linux', 05:43:16 INFO - 'TMOUT': '86400', 05:43:16 INFO - 'USER': 'cltbld', 05:43:16 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:16 INFO - '_': '/tools/buildbot/bin/python'} 05:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:43:17 INFO - Cleaning up... 05:43:17 INFO - Return code: 0 05:43:17 INFO - Running post-action listener: _resource_record_post_action 05:43:17 INFO - Running post-action listener: _start_resource_monitoring 05:43:17 INFO - Starting resource monitoring. 05:43:17 INFO - ##### 05:43:17 INFO - ##### Running install step. 05:43:17 INFO - ##### 05:43:17 INFO - Running pre-action listener: _resource_record_pre_action 05:43:17 INFO - Running main action method: install 05:43:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:43:17 INFO - Reading from file tmpfile_stdout 05:43:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:43:17 INFO - Reading from file tmpfile_stdout 05:43:17 INFO - Output received: 05:43:17 INFO - Usage: mozinstall [options] installer 05:43:17 INFO - Options: 05:43:17 INFO - -h, --help show this help message and exit 05:43:17 INFO - -d DEST, --destination=DEST 05:43:17 INFO - Directory to install application into. [default: 05:43:17 INFO - "/builds/slave/test-pgo"] 05:43:17 INFO - --app=APP Application being installed. [default: firefox] 05:43:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:43:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:43:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:43:31 INFO - Reading from file tmpfile_stdout 05:43:31 INFO - Output received: 05:43:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:43:31 INFO - Running post-action listener: _resource_record_post_action 05:43:31 INFO - ##### 05:43:31 INFO - ##### Running run-tests step. 05:43:31 INFO - ##### 05:43:31 INFO - Running pre-action listener: _resource_record_pre_action 05:43:31 INFO - Running main action method: run_tests 05:43:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:43:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:43:31 INFO - Python 2.7.3 05:43:31 INFO - Return code: 0 05:43:31 INFO - grabbing minidump binary from tooltool 05:43: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')]} 05:43: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 0x15e3d70>, '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 0x15e4b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e4fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:43: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 05:43: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 05:43:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:31 INFO - Return code: 0 05:43:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:43:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:43:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:43:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:43:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:43:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:43:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 05:43:31 INFO - Using env: {'DISPLAY': ':0', 05:43:31 INFO - 'HOME': '/home/cltbld', 05:43:31 INFO - 'LANG': 'en_US.UTF-8', 05:43:31 INFO - 'LANGUAGE': 'en_US:en', 05:43:31 INFO - 'LOGNAME': 'cltbld', 05:43:31 INFO - 'MAIL': '/var/mail/cltbld', 05:43:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:43:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:31 INFO - 'MOZ_NO_REMOTE': '1', 05:43:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:31 INFO - 'NO_EM_RESTART': '1', 05:43:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:43:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:43:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:43:31 INFO - 'SHELL': '/bin/bash', 05:43:31 INFO - 'SHLVL': '1', 05:43:31 INFO - 'TERM': 'linux', 05:43:31 INFO - 'TMOUT': '86400', 05:43:31 INFO - 'USER': 'cltbld', 05:43:31 INFO - 'XDG_SESSION_COOKIE': 'd6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795', 05:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:31 INFO - '_': '/tools/buildbot/bin/python'} 05:43:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 05:43:32 INFO - mozversion INFO | application_buildid: 20151124030553 05:43:32 INFO - mozversion INFO | application_changeset: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a 05:43:32 INFO - mozversion INFO | application_display_name: Nightly 05:43:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:32 INFO - mozversion INFO | application_name: Firefox 05:43:32 INFO - mozversion INFO | application_remotingname: firefox 05:43:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:43:32 INFO - mozversion INFO | application_vendor: Mozilla 05:43:32 INFO - mozversion INFO | application_version: 45.0a1 05:43:32 INFO - mozversion INFO | platform_buildid: 20151124030553 05:43:32 INFO - mozversion INFO | platform_changeset: 45273bbed8efaface6f5ec56d984cb9faf4fbb6a 05:43:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:43:32 INFO - mozversion INFO | platform_version: 45.0a1 05:43:32 INFO - 2015-11-24 05:43:32,083 DEBUG : using testdate: 1448372612 05:43:32 INFO - 2015-11-24 05:43:32,083 DEBUG : actual date: 1448372612 05:43:32 INFO - 2015-11-24 05:43:32,092 INFO : starting webserver on 'localhost:56245' 05:43:32 INFO - 2015-11-24 05:43:32,093 INFO : Starting test suite talos-linux64-ix-016.e 05:43:32 INFO - 2015-11-24 05:43:32,093 INFO : Starting test dromaeo_css 05:43:32 INFO - 2015-11-24 05:43:32,093 DEBUG : operating with platform_type : linux_ 05:43:32 INFO - 2015-11-24 05:43:32,094 INFO : Initialising browser for dromaeo_css test... 05:43:32 INFO - 2015-11-24 05:43:32,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhLiFm/profile http://localhost:56245/getInfo.html 05:43:37 INFO - 2015-11-24 05:43:37,318 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:43:37 INFO - 2015-11-24 05:43:37,319 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:43:37 INFO - 2015-11-24 05:43:37,319 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:43:37 INFO - 2015-11-24 05:43:37,319 DEBUG : BROWSER_OUTPUT: __metrics 05:43:38 INFO - 2015-11-24 05:43:38,411 INFO : Browser initialized. 05:43:38 INFO - 2015-11-24 05:43:38,412 INFO : Running cycle 1/1 for dromaeo_css test... 05:43:38 INFO - 2015-11-24 05:43:38,412 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKhLiFm/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:43:50 INFO - 2015-11-24 05:43:50,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 05:43:50 INFO - 2015-11-24 05:43:50,236 DEBUG : BROWSER_OUTPUT: 05:44:39 INFO - 2015-11-24 05:44:39,912 DEBUG : BROWSER_OUTPUT: 1448372679911 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] 05:46:48 INFO - 2015-11-24 05:46:48,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56245/tests/dromaeo/cssquery-ext.html) 05:46:50 INFO - 2015-11-24 05:46:50,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 148254720 05:46:50 INFO - 2015-11-24 05:46:50,017 DEBUG : BROWSER_OUTPUT: 05:49:52 INFO - 2015-11-24 05:49:52,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-ext.html (next: http://localhost:56245/tests/dromaeo/cssquery-jquery.html) 05:49:52 INFO - 2015-11-24 05:49:52,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 141029376 05:49:52 INFO - 2015-11-24 05:49:52,643 DEBUG : BROWSER_OUTPUT: 05:52:54 INFO - 2015-11-24 05:52:54,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56245/tests/dromaeo/cssquery-mootools.html) 05:52:54 INFO - 2015-11-24 05:52:54,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 142127104 05:52:54 INFO - 2015-11-24 05:52:54,855 DEBUG : BROWSER_OUTPUT: 05:55:56 INFO - 2015-11-24 05:55:56,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56245/tests/dromaeo/cssquery-prototype.html) 05:55:57 INFO - 2015-11-24 05:55:57,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 05:55:57 INFO - 2015-11-24 05:55:57,106 DEBUG : BROWSER_OUTPUT: 05:58:59 INFO - 2015-11-24 05:58:59,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56245/tests/dromaeo/cssquery-yui.html) 05:59:00 INFO - 2015-11-24 05:59:00,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 141623296 05:59:00 INFO - 2015-11-24 05:59:00,025 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/dromaeo/cssquery-yui.html (next: http://localhost:56245/tests/dromaeo/cssquery-dojo.html) 06:02:02 INFO - 2015-11-24 06:02:02,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 144240640 06:02:02 INFO - 2015-11-24 06:02:02,721 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,721 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:02:02 INFO - 2015-11-24 06:02:02,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:02:02 INFO - 2015-11-24 06:02:02,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:02:02 INFO - 2015-11-24 06:02:02,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:02:02 INFO - 2015-11-24 06:02:02,725 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3211.486162214046;3259.201495633569;3269.280758233188;3291.999999999999;3301.2572171261468;5251;5336.813211537592;5348.572114230862;5384.057789886764;5386.569074474042;5346.839594812152;5355.0628639988045;5374.113271310229;5465.9180112298345;5488.259085023521;4886.731229782369;4972.378452693413;5025.522575355354;5043.24351347299;5054.797808087672;5031.044101620699;5031.11955407804;5083.517065878736;5099.923501147486;5151.562117220022;4819;4928.43323017854;5035.999999999982;5059;5141.742912854361;4860.659753817235;4960.776765045582;4961.131801934647;4986.62600304975;4994.250862370637;4962.1812400953795;4970.776315065831;4977.576905962997;5001.149804533238;5024.748762561857;5101.107306221396;5196.553581044702;5241.79032838686;5311.203319502067;5312;5810.622309549865;5828.883422331572;5851.444112809277;5931.703414829284;5962.986292330271;5901.17383566301;5946.791862284843;5953;5970.791022314198;5978.671173085479;5318;5493.395726470085;5545.279113715191;5552.7223638817895;5559.805406810783;5864.706764661835;5917.171595976567;5952.553558483131;5976.970115149484;6030.18592490017;5837.678927658934;5840.153177789197;5849.88300233993;5862.70686465675;5879.382664820132;5669.971650141805;5737.110747834093;5824.621399609012;5932.584719069624;5953.464188222994;5772.509336706343;5850.297964244318;5870;5873.148393483007;5910;5906.202662640574;5925.585209035412;5928.170056192136;5928.288605367384;5950.107483877453;4352.129574085196;4413.536578659258;4440;4537.750423726727;4544.2501987171745;4032.5967403260024;4050.10897602527;4055.858044968412;4060.92385517838;4068.3287257602756;5678.68767217807;5688.914666280009;5692.089265717465;5697.7151142443545;5741.827745167651;5699.059655156935;5824.126381042877;5891.646501209942;5965.73154208053;6078.422549857756;5674.432556744293;5690.2887139107615;5692.231548740867;5694.487496125285;5702.916445875353;5154.948450515447;5164.509371609691;5177.948220517822;5182.067227899014;5227.320448341691;5853.765849366063;5954.493868021266;5969.044952807617;5990.161377407254;6073.271207455134;5852.7658893643775;5914.58597898143;5941.881162376641;5942.762289508371;5959.67221802805;5831;6045.78839740607;6067.029275315928;6112.052631842072;6113.786017489367;5675.858103547444;5687.800926967537;5783.190353350618;5785.392533783892;5822.155787410887;5970.880582388415;5975.55183361241;5981.491573216325;6026.096085587197;6034.758609655564;5518.392976772471;5614.522765564972;5868.823935281948;5873.089671100986;5898.793542226002;5694.430556944272;5696.344920334214;5733.541316694571;5779.8266052016825;5793;5729.226554415267;5737.770489180386;5744.109663002241;5744.195812586325;5776.624519406225;5510.3938566758425;5530.640508366943;5797.275340582427;5818.563607729353;5864.648121112747;5682.3465301489205;5767.250257466502;5773.971130144322;5781.653100813965;5812.883742325045 06:02:02 INFO - 2015-11-24 06:02:02,726 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.3353042818193;592.5792687192094;596.7076132694981;601.2364297342375;608.9177960975269;38970.805145974264;39126.21747565047;39207.21585568287;39656.405153922715;39684.80157599212;42361.788191059;42962.355564666475;43152;43236.783816080955;43318;8684.652613895436;8834.602442890053;8852.5573721314;8854.601542930552;8871.556422178897;8563.700270490534;8636.697715579956;8645.95677021614;8649.351298652595;8665.740027799176;8665.263452606536;8777.73666789994;8783.516906570136;8792.428492148021;8793.648254069829;8689.26141277992;8708.825823483496;8748.825023499558;8781.077986811388;8792.34057445694;8577.871331930026;8682.175193356621;8698.434601750929;8719.651213951434;8746.212840844291;39642.40536391956;40035.799821001;40242.39636405456;40257;40337.79831100826;3232.8221947792863;3314.2045908981913;3357.462805951036;3553.573571171476;3897.2205558888336;29322.266943326373;29543.556846647316;29962;30192.396152076835;30287.242818929484;3972.245273398045;4024.8993775155855;4082.5305089914445;4096.078382363974;4168.7707176105305;253041;258776;258788;259297;259645;60127;61644.69177654083;62034.68982655058;62532.749345012846;63889.36110638834;57017;58106;58307;58382;58442.41557584455;16406.753898691528;16595.41916032933;16626.168691565614;16627.83372166287;16678.49964501067;11244.044256238149;11253.774924501628;11298.54805807775;11329.09367250618;11347.205695601393;21326.573468530543;21533.78466215318;21712.457188570414;21713.13147474115;21758.673619895715;8541.95729021351;8677.956610216908;8783.165599268059;8792.516411597424;8853.73438796837;977.2816979520047;1041.906228439429;1050.721558786922;1062.4262898035129;1139.1342579639368;27122.32194195161;27435.588466173023;27502.312442189104;27656.58515122275;27823;1066.802641511323;1078.638656050232;1117.7317443813588;1121.2151493954264;1163.4124766992616;14607.488737894122;15951.361945522049;16521.91739041321;16617.335306587844;16876.578085547713;632174;645137;647648;654094;658545;54130;54262;54664.726676366365;54757.72621136948;54858.72570637201;1271.7965125580047;1309.4696647857634;1314.493919840868;1329.667583104224;1331.068252223428;28796.42407151887;29534.261643459085;29657.40685186241;29726.702732972393;29750;44346.334804977305;44818.551814482744;45041.774791125834;45234.77382613066;45238.77380613076;282503;284986;286002;286448;287416;32243.516347255278;45621;45925.54074459346;46321.305180423;46478.302825456965;43117.784411077744;43480.565194347655;43713.78143109264;43900.341494878245;43989;36842.263154737295;36859;40505.59494405018;41428.79285603553;41987.580124198365;36970.07574810544;37155.25689486249;37329.81335093307;37352;37423.43864841975;39576.80211598924;39625.603743962194;40414.79792601018;40657.39013914735;40857.79571102125;30317.848410757804;30938.226544336572;32960.340793184485;33512.49731254082;36628;25778.226653200432;25912.352191194615;25918.61122083208;26109.08618198354;26177.73822261753 06:02:02 INFO - 2015-11-24 06:02:02,727 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.30147561517236;357.5459166858089;359.88663570975143;363.17196791315797;365.1091337137384;17003.82996170038;17261.82738172618;17412.216450259737;18032.639347213066;18853.151608177614;14084;16114.838851611481;16355.754663680025;16803.66392672146;16903.83096169038;4764.833230836913;4868.829590964317;4898.632602554822;4899.51004899509;4917.582005529534;4839.588634966032;4878.829240976566;4897.240927656219;4917.72952487613;4924;4431.822727090913;5325.4940780625775;5329.706866122362;5509.201165830952;5712.057510510761;5342.5993050521365;5651;5688.175214593882;5702.116171993348;5703.600747947646;5016.473270306638;5047.873803154914;5051.646384753069;5055.443901170868;5060.873478163038;11117.666470005914;11183.66449006523;11327.037201837853;11428.94285528567;11525.76948461026;2034.094827801629;2055.321743824534;2064.783197764243;2084.4997200671883;2140.8388938999024;8428.578571071423;8828.779280518038;8873.778155546099;9004.41471304363;9028.819423611556;1734.5923707928628;1810.3754204799322;1832.761740973665;1837.0998210876708;1879.0322983663289;58769.7061514694;60507.999999999556;61716.38283617151;62222.377776222114;62269.37730622681;9915.504224788732;10017.749556261006;10044.598216071421;10047.296689231829;10072.194224462026;12672.429740661692;12768.425420855898;12833.101682882108;12841;12854.164479308814;7301.561906285639;7352.77941661751;7499.250074992567;7597.772066838003;7637.618119094134;7272.63636818157;7295.854082918312;7403.2226616204525;7538.623068846536;7541.622918854036;4237.406763053175;4288.89277768052;4317.611414972667;4321.719088259253;4330.826766929287;1681.6048228666255;1708.7009773289624;1766.152246921485;1788.4455818696247;1800.7659004329353;373.48272642390486;378.3530163420527;381.04738154613466;383.3062157494943;398.7288643722297;9271.119243671841;9595.42427454355;9857.605695772232;9923.503824808875;10170.338927969658;394.6704501741021;405.81535401392296;411.91555731075056;414.52122798168165;425.3874420833989;5412;5419.214213938957;5495.422980586981;5507.0637991541535;9465.716028519155;462684;477731;489330;493809;496943;75960;76247.61876190583;76856;77954.61022694963;78456.60771696105;1161.071143085528;1177.3465726521863;1187.0622208455395;1189.1141099880645;1190.2323001663879;14837.554873353816;15202.847971520143;15271.160086195367;15315.310811013309;15468.381264749283;31015.68984310128;31341;32861.01416957495;33811.66188338085;34265.65734342625;39894.40158397568;40304.59695403009;40584.59415405808;40968.38547421851;43239;9099.59051842682;9211.815763684555;9374.578143983674;9406.670766523139;9435.150836424755;13250.906201897047;17523.211455484277;17570.297188112334;17861.821381786536;18000.81999180044;13615.795763063365;13864.861351386357;14164;14213.289335533389;14577.85422145765;13928.860711392756;13937.860621394062;14033.649158771112;14088.01383903117;14486.637834053812;13808.861911380758;13961.371738271599;14580.562583122522;14610.707785844435;15155.772663409836;8575.485470871768;8755;8842.204201621886;9024.68413605547;9078.910530736353;2750.2436829871945;11489.840293918905;13600;14164.220967846868;14603.561893143222 06:02:02 INFO - 2015-11-24 06:02:02,729 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1530.4949366708988;1644.1532610705485;1669.8413650703178;1715.253864568912;1737.1314342828587;7314.780556583311;7409.073865766779;7458.254174582539;7646.923530764698;7647.197044310351;7799.298063174313;7820.843583128349;7837.4513784035;7857.096433910102;7910.327622152109;2261.9208327708575;2299.574578702937;2304.066852924568;2304.366299267698;2307.7461479237354;2260.163739416418;2287.3824067501764;2290.702208712865;2293.334932869466;2301.746807851135;2221.833362497811;2236.452069243038;2241.1035585765744;2247.292102987562;2268.5803126421583;2187.912483500666;2236.0943817753837;2256.4697296135396;2264.445210923326;2265.728112626487;2233.4639686475293;2265.818734501236;2277.4078739527677;2291.1293708390704;2299.241250387368;7429.777106686808;7459.589722565257;7488.962555187244;7501.099868015818;7506.66220020095;4568.177728008957;4663.253879379283;4675.555822196886;4676.3453116563705;4679.88300292492;3146.2606287522412;3169.635491918436;3211.42194405007;3222.3716375306826;3238.6923242291946;976.2824324121765;987.195435719886;995.85560093786;1010.2726037253166;1033.5142483032962;10448.373097614092;10531.73670658232;10536.894631053668;10543.472826358728;10546.947265263701;4013.7391069580385;4064.7967601619803;4103.261412945639;4112;4130.070734084867;8539.573021348908;8540.53027083504;8561.44350617208;8585.914140858637;8604.440711353742;4637.744924029211;4661.184292748755;4680.438347398334;4686.414198225222;4687.95312046882;4206.915861682749;4236.597523235288;4242.7242229255;4312.5903039211225;4321.286987647066;3335.9666403335655;3337.199072222649;3351.8826841060445;3352.7762366735965;3375.780574262665;991.6281394477071;991.8462638291077;1000.8899021107673;1001.9749506262402;1004.7337455574278;1077.1598153440173;1092.0226397374306;1097.846301517788;1138.2885696439726;1260.8108783682521;7243.89134162988;7258.201597824235;7275.599842008741;7280.96359518199;7306.342429181293;1012.1346248957183;1095.0153986540417;1164.4352489042808;1168.2114572663588;1171.3499008050615;5471.124620060851;5479.287692600016;5706;5761.769529218785;5794.362620111784;9100.499472529074;9226.723198303927;9267.212286955684;9268.397554158959;9329.953350233205;9041.547922603844;9193.402428842104;9255.90744092564;9309.208717258973;9330.720078397659;7097.183823860219;7143.785686429415;7178.892316615255;7180.210176880539;7191.856162876713;6834.692438840363;6913.239543650295;6936.653167341512;6945.2707465715375;6952.200496942916;8040.798980025546;8101.10887802353;8284.875726863982;8291.33669306442;8307.252347288773;8237.670493180205;8360.45657032291;8396.748097557083;8407.579621019047;8450.112738162405;6446.806595802133;6458.321876202931;6501.642409667514;6501.837454063686;6504.349565043458;7156.141263048259;7254.492185547172;7468.178500365064;7489.775306740807;7499.850003000019;6911.447084233349;7029.472789540702;7041.894371584328;7077.5753454792875;7140.8214794628475;6523.3150519194805;6630.867382652416;6791.830204244736;6884.345987131214;6970.093887794555;6907.654617269217;6927.653617319013;6995.4753393494675;7028.226895041644;7032.261612530815;6301.527385446018;6374.776882809079;6379;6393.808185754248;6401.455876250571;6588.472922166311;6624.701888415129;6648.501362397743;6655.700493477708;6662.267150613332 06:02:02 INFO - 2015-11-24 06:02:02,732 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.9604851369322;308.41709169669326;309.43836935961224;314.34145465250293;315.4259248168333;6195.070739389088;6367.840803979902;6381.521385896059;6420.069089981961;6422.16511853459;6274.372562743734;6276.466500347465;6281.560290779647;6282.183316168892;6290.622562646245;4574.085182963404;4693.859184224461;4744.193487107183;4750.453697824742;4757.0723708876785;4659.998100408411;4684.695494792828;4691.085238378518;4704.717716936994;4711.670183087185;4632.8146874125;4635.652326075541;4638.698484598491;4642.558956899089;4645.372874661928;4620.376249206364;4632.97683511582;4642.234031384817;4647.837325693618;4659.7204167749705;3893.2213557288374;3940.428637847525;3951.4863067801;3951.920961580752;3959.247742928834;5875.500582450497;5965.373635768268;5991.460768530853;5996.730147143389;6022.126791615235;5416.945830541684;5417.674939503642;5432.320959880015;5434.619576629638;5446.101393270105;6668.233153187397;6686.297938716462;6702.865942681119;6705.094812200388;6708.563943343667;4360.454943132108;4403.339499075132;4443.333499974998;4445.8221671133115;4450.977745111286;6817.284185160536;6922.965385173042;6924.065251191126;6968.094147760809;6970.581765094111;4466.129104824593;4499.34759459883;4502.549745025537;4504.009117994036;4504.954950450454;4488.798004089758;4559.270516717309;4561.042181141997;4563.612092972068;4564.2240819060835;5363.624546281723;5405.864853378697;5415.647982881179;5422.349318081855;5423.294971653739;6702.597844129368;6730.7307707692125;6742.5280230383405;6772.52592318533;6781.152355955505;1602.5512856400226;1615.9757603635956;1621.570283874774;1621.7648440975993;1627.9430219942244;1016.8830584482731;1040.6409788622914;1042.5673345561659;1043.4834756795435;1062.95216715248;6488.059231411419;6495.6752162391695;6526.412622863965;6531.836704082436;6544.411003009752;6911.308869113149;6931.064306318583;6961.617111058839;6971;6978.5812851228075;6431.807045788541;6456.741730330734;6508.284088750233;6520.217573891164;6531.1509503765155;3814.752041117374;3838.9040273992814;3842.269968705937;3842.884713458601;3850.383938569815;7199.496035277585;7226;7228.783136505913;7319.451041171827;7320.267973202637;7119.644017799089;7150.785476435715;7168.53404528704;7202.0637317149485;7208.675609597476;7019.929800701928;7102.218755936843;7106.92893071073;7145.749898753623;7153.785386438311;6994.790156295116;7025.192102908231;7026.086608740831;7026.508144429841;7031.753888613874;6920.826979325557;6973.651317434006;6978.581285122909;6981.860362792817;6988.79033628992;7115.466340024415;7258.0927384076995;7276.563406195645;7304.890426643498;7357.926420735724;4586.325991013323;4614.561616646548;4618.422697162855;4621.491635919979;4625.814967401401;6892.862142757217;6942.2363540011565;6957;6964.164300283998;6964.721411143498;6610.570312929644;6727.260001399744;6728.428083612947;6746.831329216809;6764.5603035802515;6700.631465269457;6729.7644582441335;6734.8653026940165;6748.055272261985;6751.324867513209;6582.3746744059235;6594.604323740591;6603.273639899703;6628.469722422291;6631.801045968628;6615.470762339098;6706.195256569243;6721.932780672326;6736.898946515904;6737.59574425536;6551.901721474277;6556.737730490727;6566.212054553484;6578.539502234989;6586 06:02:02 INFO - 2015-11-24 06:02:02,732 DEBUG : BROWSER_OUTPUT: |5;yui.html;814.2427542385581;824.5570252058897;859.6905114158901;878.8242351529692;893.9942564614809;13032.869671303284;14330.92834535826;14342.569722908316;14358.784618230735;14379.137251764876;13412.396442160101;13464.259465729381;13481.123726957741;13516.662083447918;13539.323033848317;799.8920145780332;821.363443331417;821.4906757810166;823.8805373220879;836.6820608168917;819.0662644585148;824.8226631274275;826.9214424629681;827.2430725885807;827.3050637464529;848.1179573243819;848.7920459487434;850.2517784349764;853.1127627267634;855.9186877246651;844.1684940333766;851.5061264466594;853.6542700206427;853.8633818589027;854.6624083487019;623.5354660777705;623.834683808791;624.5752888036134;624.5815303746501;625.4933503861887;13994.720105597933;14132.434702611883;14149.29253537319;14164.291785410689;14216.644583885382;11710.648680539598;11750;11988.880111198863;12032.51869925202;12114.454849531705;9972.551235194362;10249.487525623688;10436.739081523023;10508.947455262674;11492.885071149349;3610.6930910872607;3611.205534782344;3660.6156353583024;3660.9816950915074;3734.159814041846;48591.75704121492;48718;48917;49057.50942490565;49108.99999999964;9634.807303853884;9963.750906227402;10002.099811017044;10273.9486302568;10344.844827327595;17970.101494925464;18100.27598896056;18128.818711812713;18257.995810230565;18345.08274586265;7094.467914906402;7124.501284910007;7246.49274550787;7264.34620884123;7335.303146201102;4084.346504559256;4148.23257697327;4180.435641188462;4186.246475634415;4223.049813791934;2857.8428186449946;2964.5997790298034;2969.732724054845;2989.7309242167876;2993.536001919706;546.7976848566057;548.3693752184939;555.3918459287074;558.3885645218479;574.3423779772138;529.8869143780291;571.2431028886741;640.7693230437039;650.8730797494443;653.3499168327545;7423.369013633794;7686.423518236154;7733.883991740128;7846.686132554748;7878.921210787933;568.4486048532999;626.264139635926;644.1432894250729;678.772611175252;689.9862002760017;3654.616265292106;3680.263947210515;3721.2743515014854;3799.2781371539318;3842.5773164951834;51801.7409912948;55149.72425137849;57048;57186.42813571811;57256.42743572594;48880.26679599809;49881.75059124681;50228;50722.74638626857;51060.23409648858;46090;46351.5364846354;46372.536274637496;46552;46650.76674616673;8237.546934918637;8247.876281855897;8256.917430825855;8420.789480263042;8474.618642160995;34938.47592286067;35552.444755524244;35564.28871422609;35670.108247294025;36151;40797.38803918003;43967.340489893315;45603.31595026011;45640.31539526976;46147.53852461433;10361.74095647615;10486.528106235086;10786.784264314512;11157.55369785232;11230.55077796879;10311.896881031094;10733.463326833784;11662.76674466489;11720.765584688088;12067.215630983957;11134.888651113386;11271.718207044889;11276.9436152822;11525.827112593486;11682.24065435744;11010.284331518425;11402.429878506207;11481.827772583585;11577.305361678325;11711.76576468483;11007.284526505751;11293.774124517628;11475.426228688699;11498.08015358786;11743.588974385855;9298.767530811783;9429.245660347293;9612.615495380107;9699.41400205628;9736.610535578497;8765.894833122751;8766.956165219133;9173.816523669355;9418.717438476857;9697.175740062174 06:02:02 INFO - 2015-11-24 06:02:02,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,319 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373722720__endTimestamp 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:02:02 INFO - 2015-11-24 06:02:02,733 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5465.02 Median:5697.72 stddev:613.43 (10.8%) stddev-sans-first:589.28 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: Values: 3211.5 3259.2 3269.3 3292.0 3301.3 5251.0 5336.8 5348.6 5384.1 5386.6 5346.8 5355.1 5374.1 5465.9 5488.3 4886.7 4972.4 5025.5 5043.2 5054.8 5031.0 5031.1 5083.5 5099.9 5151.6 4819.0 4928.4 5036.0 5059.0 5141.7 4860.7 4960.8 4961.1 4986.6 4994.3 4962.2 4970.8 4977.6 5001.1 5024.7 5101.1 5196.6 5241.8 5311.2 5312.0 5810.6 5828.9 5851.4 5931.7 5963.0 5901.2 5946.8 5953.0 5970.8 5978.7 5318.0 5493.4 5545.3 5552.7 5559.8 5864.7 5917.2 5952.6 5977.0 6030.2 5837.7 5840.2 5849.9 5862.7 5879.4 5670.0 5737.1 5824.6 5932.6 5953.5 5772.5 5850.3 5870.0 5873.1 5910.0 5906.2 5925.6 5928.2 5928.3 5950.1 4352.1 4413.5 4440.0 4537.8 4544.3 4032.6 4050.1 4055.9 4060.9 4068.3 5678.7 5688.9 5692.1 5697.7 5741.8 5699.1 5824.1 5891.6 5965.7 6078.4 5674.4 5690.3 5692.2 5694.5 5702.9 5154.9 5164.5 5177.9 5182.1 5227.3 5853.8 5954.5 5969.0 5990.2 6073.3 5852.8 5914.6 5941.9 5942.8 5959.7 5831.0 6045.8 6067.0 6112.1 6113.8 5675.9 5687.8 5783.2 5785.4 5822.2 5970.9 5975.6 5981.5 6026.1 6034.8 5518.4 5614.5 5868.8 5873.1 5898.8 5694.4 5696.3 5733.5 5779.8 5793.0 5729.2 5737.8 5744.1 5744.2 5776.6 5510.4 5530.6 5797.3 5818.6 5864.6 5682.3 5767.3 5774.0 5781.7 5812.9 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55893.26 Median:22004.02 stddev:116563.96 (529.7%) stddev-sans-first:116816.89 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: Values: 549.3 592.6 596.7 601.2 608.9 38970.8 39126.2 39207.2 39656.4 39684.8 42361.8 42962.4 43152.0 43236.8 43318.0 8684.7 8834.6 8852.6 8854.6 8871.6 8563.7 8636.7 8646.0 8649.4 8665.7 8665.3 8777.7 8783.5 8792.4 8793.6 8689.3 8708.8 8748.8 8781.1 8792.3 8577.9 8682.2 8698.4 8719.7 8746.2 39642.4 40035.8 40242.4 40257.0 40337.8 3232.8 3314.2 3357.5 3553.6 3897.2 29322.3 29543.6 29962.0 30192.4 30287.2 3972.2 4024.9 4082.5 4096.1 4168.8 253041.0 258776.0 258788.0 259297.0 259645.0 60127.0 61644.7 62034.7 62532.7 63889.4 57017.0 58106.0 58307.0 58382.0 58442.4 16406.8 16595.4 16626.2 16627.8 16678.5 11244.0 11253.8 11298.5 11329.1 11347.2 21326.6 21533.8 21712.5 21713.1 21758.7 8542.0 8678.0 8783.2 8792.5 8853.7 977.3 1041.9 1050.7 1062.4 1139.1 27122.3 27435.6 27502.3 27656.6 27823.0 1066.8 1078.6 1117.7 1121.2 1163.4 14607.5 15951.4 16521.9 16617.3 16876.6 632174.0 645137.0 647648.0 654094.0 658545.0 54130.0 54262.0 54664.7 54757.7 54858.7 1271.8 1309.5 1314.5 1329.7 1331.1 28796.4 29534.3 29657.4 29726.7 29750.0 44346.3 44818.6 45041.8 45234.8 45238.8 282503.0 284986.0 286002.0 286448.0 287416.0 32243.5 45621.0 45925.5 46321.3 46478.3 43117.8 43480.6 43713.8 43900.3 43989.0 36842.3 36859.0 40505.6 41428.8 41987.6 36970.1 37155.3 37329.8 37352.0 37423.4 39576.8 39625.6 40414.8 40657.4 40857.8 30317.8 30938.2 32960.3 33512.5 36628.0 25778.2 25912.4 25918.6 26109.1 26177.7 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,734 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26269.50 Median:20146.57 stddev:79275.27 (393.5%) stddev-sans-first:79473.78 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: Values: 357.3 357.5 359.9 363.2 365.1 17003.8 17261.8 17412.2 18032.6 18853.2 14084.0 16114.8 16355.8 16803.7 16903.8 4764.8 4868.8 4898.6 4899.5 4917.6 4839.6 4878.8 4897.2 4917.7 4924.0 4431.8 5325.5 5329.7 5509.2 5712.1 5342.6 5651.0 5688.2 5702.1 5703.6 5016.5 5047.9 5051.6 5055.4 5060.9 11117.7 11183.7 11327.0 11428.9 11525.8 2034.1 2055.3 2064.8 2084.5 2140.8 8428.6 8828.8 8873.8 9004.4 9028.8 1734.6 1810.4 1832.8 1837.1 1879.0 58769.7 60508.0 61716.4 62222.4 62269.4 9915.5 10017.7 10044.6 10047.3 10072.2 12672.4 12768.4 12833.1 12841.0 12854.2 7301.6 7352.8 7499.3 7597.8 7637.6 7272.6 7295.9 7403.2 7538.6 7541.6 4237.4 4288.9 4317.6 4321.7 4330.8 1681.6 1708.7 1766.2 1788.4 1800.8 373.5 378.4 381.0 383.3 398.7 9271.1 9595.4 9857.6 9923.5 10170.3 394.7 405.8 411.9 414.5 425.4 5412.0 5419.2 5495.4 5507.1 9465.7 462684.0 477731.0 489330.0 493809.0 496943.0 75960.0 76247.6 76856.0 77954.6 78456.6 1161.1 1177.3 1187.1 1189.1 1190.2 14837.6 15202.8 15271.2 15315.3 15468.4 31015.7 31341.0 32861.0 33811.7 34265.7 39894.4 40304.6 40584.6 40968.4 43239.0 9099.6 9211.8 9374.6 9406.7 9435.2 13250.9 17523.2 17570.3 17861.8 18000.8 13615.8 13864.9 14164.0 14213.3 14577.9 13928.9 13937.9 14033.6 14088.0 14486.6 13808.9 13961.4 14580.6 14610.7 15155.8 8575.5 8755.0 8842.2 9024.7 9078.9 2750.2 11489.8 13600.0 14164.2 14603.6 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5362.55 Median:6452.56 stddev:2756.77 (42.7%) stddev-sans-first:2749.46 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: Values: 1530.5 1644.2 1669.8 1715.3 1737.1 7314.8 7409.1 7458.3 7646.9 7647.2 7799.3 7820.8 7837.5 7857.1 7910.3 2261.9 2299.6 2304.1 2304.4 2307.7 2260.2 2287.4 2290.7 2293.3 2301.7 2221.8 2236.5 2241.1 2247.3 2268.6 2187.9 2236.1 2256.5 2264.4 2265.7 2233.5 2265.8 2277.4 2291.1 2299.2 7429.8 7459.6 7489.0 7501.1 7506.7 4568.2 4663.3 4675.6 4676.3 4679.9 3146.3 3169.6 3211.4 3222.4 3238.7 976.3 987.2 995.9 1010.3 1033.5 10448.4 10531.7 10536.9 10543.5 10546.9 4013.7 4064.8 4103.3 4112.0 4130.1 8539.6 8540.5 8561.4 8585.9 8604.4 4637.7 4661.2 4680.4 4686.4 4688.0 4206.9 4236.6 4242.7 4312.6 4321.3 3336.0 3337.2 3351.9 3352.8 3375.8 991.6 991.8 1000.9 1002.0 1004.7 1077.2 1092.0 1097.8 1138.3 1260.8 7243.9 7258.2 7275.6 7281.0 7306.3 1012.1 1095.0 1164.4 1168.2 1171.3 5471.1 5479.3 5706.0 5761.8 5794.4 9100.5 9226.7 9267.2 9268.4 9330.0 9041.5 9193.4 9255.9 9309.2 9330.7 7097.2 7143.8 7178.9 7180.2 7191.9 6834.7 6913.2 6936.7 6945.3 6952.2 8040.8 8101.1 8284.9 8291.3 8307.3 8237.7 8360.5 8396.7 8407.6 8450.1 6446.8 6458.3 6501.6 6501.8 6504.3 7156.1 7254.5 7468.2 7489.8 7499.9 6911.4 7029.5 7041.9 7077.6 7140.8 6523.3 6630.9 6791.8 6884.3 6970.1 6907.7 6927.7 6995.5 7028.2 7032.3 6301.5 6374.8 6379.0 6393.8 6401.5 6588.5 6624.7 6648.5 6655.7 6662.3 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5564.42 Median:6444.27 stddev:1746.88 (27.1%) stddev-sans-first:1706.58 06:02:02 INFO - 2015-11-24 06:02:02,736 DEBUG : BROWSER_OUTPUT: Values: 304.0 308.4 309.4 314.3 315.4 6195.1 6367.8 6381.5 6420.1 6422.2 6274.4 6276.5 6281.6 6282.2 6290.6 4574.1 4693.9 4744.2 4750.5 4757.1 4660.0 4684.7 4691.1 4704.7 4711.7 4632.8 4635.7 4638.7 4642.6 4645.4 4620.4 4633.0 4642.2 4647.8 4659.7 3893.2 3940.4 3951.5 3951.9 3959.2 5875.5 5965.4 5991.5 5996.7 6022.1 5416.9 5417.7 5432.3 5434.6 5446.1 6668.2 6686.3 6702.9 6705.1 6708.6 4360.5 4403.3 4443.3 4445.8 4451.0 6817.3 6923.0 6924.1 6968.1 6970.6 4466.1 4499.3 4502.5 4504.0 4505.0 4488.8 4559.3 4561.0 4563.6 4564.2 5363.6 5405.9 5415.6 5422.3 5423.3 6702.6 6730.7 6742.5 6772.5 6781.2 1602.6 1616.0 1621.6 1621.8 1627.9 1016.9 1040.6 1042.6 1043.5 1063.0 6488.1 6495.7 6526.4 6531.8 6544.4 6911.3 6931.1 6961.6 6971.0 6978.6 6431.8 6456.7 6508.3 6520.2 6531.2 3814.8 3838.9 3842.3 3842.9 3850.4 7199.5 7226.0 7228.8 7319.5 7320.3 7119.6 7150.8 7168.5 7202.1 7208.7 7019.9 7102.2 7106.9 7145.7 7153.8 6994.8 7025.2 7026.1 7026.5 7031.8 6920.8 6973.7 6978.6 6981.9 6988.8 7115.5 7258.1 7276.6 7304.9 7357.9 4586.3 4614.6 4618.4 4621.5 4625.8 6892.9 6942.2 6957.0 6964.2 6964.7 6610.6 6727.3 6728.4 6746.8 6764.6 6700.6 6729.8 6734.9 6748.1 6751.3 6582.4 6594.6 6603.3 6628.5 6631.8 6615.5 6706.2 6721.9 6736.9 6737.6 6551.9 6556.7 6566.2 6578.5 6586.0 06:02:02 INFO - 2015-11-24 06:02:02,737 DEBUG : BROWSER_OUTPUT: 06:02:02 INFO - 2015-11-24 06:02:02,737 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13692.68 Median:46601.38 stddev:15831.51 (34.0%) stddev-sans-first:15846.39 06:02:02 INFO - 2015-11-24 06:02:02,738 DEBUG : BROWSER_OUTPUT: Values: 814.2 824.6 859.7 878.8 894.0 13032.9 14330.9 14342.6 14358.8 14379.1 13412.4 13464.3 13481.1 13516.7 13539.3 799.9 821.4 821.5 823.9 836.7 819.1 824.8 826.9 827.2 827.3 848.1 848.8 850.3 853.1 855.9 844.2 851.5 853.7 853.9 854.7 623.5 623.8 624.6 624.6 625.5 13994.7 14132.4 14149.3 14164.3 14216.6 11710.6 11750.0 11988.9 12032.5 12114.5 9972.6 10249.5 10436.7 10508.9 11492.9 3610.7 3611.2 3660.6 3661.0 3734.2 48591.8 48718.0 48917.0 49057.5 49109.0 9634.8 9963.8 10002.1 10273.9 10344.8 17970.1 18100.3 18128.8 18258.0 18345.1 7094.5 7124.5 7246.5 7264.3 7335.3 4084.3 4148.2 4180.4 4186.2 4223.0 2857.8 2964.6 2969.7 2989.7 2993.5 546.8 548.4 555.4 558.4 574.3 529.9 571.2 640.8 650.9 653.3 7423.4 7686.4 7733.9 7846.7 7878.9 568.4 626.3 644.1 678.8 690.0 3654.6 3680.3 3721.3 3799.3 3842.6 51801.7 55149.7 57048.0 57186.4 57256.4 48880.3 49881.8 50228.0 50722.7 51060.2 46090.0 46351.5 46372.5 46552.0 46650.8 8237.5 8247.9 8256.9 8420.8 8474.6 34938.5 35552.4 35564.3 35670.1 36151.0 40797.4 43967.3 45603.3 45640.3 46147.5 10361.7 10486.5 10786.8 11157.6 11230.6 10311.9 10733.5 11662.8 11720.8 12067.2 11134.9 11271.7 11276.9 11525.8 11682.2 11010.3 11402.4 11481.8 11577.3 11711.8 11007.3 11293.8 11475.4 11498.1 11743.6 9298.8 9429.2 9612.6 9699.4 9736.6 8765.9 8767.0 9173.8 9418.7 9697.2 06:02:02 INFO - 2015-11-24 06:02:02,738 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:02:02 INFO - 2015-11-24 06:02:02,738 DEBUG : BROWSER_OUTPUT: 06:02:03 INFO - 2015-11-24 06:02:03,456 INFO : Browser exited with error code: 0 06:02:03 INFO - 2015-11-24 06:02:03,472 INFO : Completed test dromaeo_css (00:18:31) 06:02:03 INFO - 2015-11-24 06:02:03,472 INFO : Starting test kraken 06:02:03 INFO - 2015-11-24 06:02:03,472 DEBUG : operating with platform_type : linux_ 06:02:03 INFO - 2015-11-24 06:02:03,472 INFO : Initialising browser for kraken test... 06:02:03 INFO - 2015-11-24 06:02:03,478 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppHepbf/profile http://localhost:56245/getInfo.html 06:02:07 INFO - 2015-11-24 06:02:07,753 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:02:07 INFO - 2015-11-24 06:02:07,753 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:02:07 INFO - 2015-11-24 06:02:07,753 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 06:02:07 INFO - 2015-11-24 06:02:07,753 DEBUG : BROWSER_OUTPUT: __metrics 06:02:08 INFO - 2015-11-24 06:02:08,731 INFO : Browser initialized. 06:02:08 INFO - 2015-11-24 06:02:08,732 INFO : Running cycle 1/1 for kraken test... 06:02:08 INFO - 2015-11-24 06:02:08,732 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppHepbf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:02:20 INFO - 2015-11-24 06:02:20,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 06:02:20 INFO - 2015-11-24 06:02:20,472 DEBUG : BROWSER_OUTPUT: 06:02:22 INFO - 2015-11-24 06:02:22,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56245/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:23 INFO - 2015-11-24 06:02:23,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 142073856 06:02:23 INFO - 2015-11-24 06:02:23,550 DEBUG : BROWSER_OUTPUT: 06:02:26 INFO - 2015-11-24 06:02:26,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56245/tests/kraken/driver.html?testName=audio-dft) 06:02:26 INFO - 2015-11-24 06:02:26,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 142471168 06:02:26 INFO - 2015-11-24 06:02:26,747 DEBUG : BROWSER_OUTPUT: 06:02:29 INFO - 2015-11-24 06:02:29,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56245/tests/kraken/driver.html?testName=audio-fft) 06:02:30 INFO - 2015-11-24 06:02:30,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 137924608 06:02:30 INFO - 2015-11-24 06:02:30,145 DEBUG : BROWSER_OUTPUT: 06:02:32 INFO - 2015-11-24 06:02:32,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56245/tests/kraken/driver.html?testName=audio-oscillator) 06:02:32 INFO - 2015-11-24 06:02:32,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 136859648 06:02:32 INFO - 2015-11-24 06:02:32,771 DEBUG : BROWSER_OUTPUT: 06:02:34 INFO - 2015-11-24 06:02:34,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:35 INFO - 2015-11-24 06:02:35,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 139501568 06:02:35 INFO - 2015-11-24 06:02:35,564 DEBUG : BROWSER_OUTPUT: 06:02:38 INFO - 2015-11-24 06:02:38,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56245/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:39 INFO - 2015-11-24 06:02:39,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 140218368 06:02:39 INFO - 2015-11-24 06:02:39,130 DEBUG : BROWSER_OUTPUT: 06:02:42 INFO - 2015-11-24 06:02:42,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56245/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:43 INFO - 2015-11-24 06:02:43,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 140296192 06:02:43 INFO - 2015-11-24 06:02:43,114 DEBUG : BROWSER_OUTPUT: 06:02:45 INFO - 2015-11-24 06:02:45,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56245/tests/kraken/driver.html?testName=json-parse-financial) 06:02:46 INFO - 2015-11-24 06:02:46,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 06:02:46 INFO - 2015-11-24 06:02:46,529 DEBUG : BROWSER_OUTPUT: 06:02:48 INFO - 2015-11-24 06:02:48,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:48 INFO - 2015-11-24 06:02:48,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 139902976 06:02:48 INFO - 2015-11-24 06:02:48,723 DEBUG : BROWSER_OUTPUT: 06:02:50 INFO - 2015-11-24 06:02:50,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:51 INFO - 2015-11-24 06:02:51,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 139464704 06:02:51 INFO - 2015-11-24 06:02:51,162 DEBUG : BROWSER_OUTPUT: 06:02:53 INFO - 2015-11-24 06:02:53,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:53 INFO - 2015-11-24 06:02:53,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 139620352 06:02:53 INFO - 2015-11-24 06:02:53,840 DEBUG : BROWSER_OUTPUT: 06:02:56 INFO - 2015-11-24 06:02:56,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:56 INFO - 2015-11-24 06:02:56,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 139751424 06:02:56 INFO - 2015-11-24 06:02:56,916 DEBUG : BROWSER_OUTPUT: 06:02:59 INFO - 2015-11-24 06:02:59,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:00 INFO - 2015-11-24 06:03:00,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 140484608 06:03:00 INFO - 2015-11-24 06:03:00,111 DEBUG : BROWSER_OUTPUT: 06:03:01 INFO - 2015-11-24 06:03:01,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56245/tests/kraken/driver.html?testName=ai-astar) 06:03:02 INFO - 2015-11-24 06:03:02,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 140652544 06:03:02 INFO - 2015-11-24 06:03:02,034 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,036 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:03:02 INFO - 2015-11-24 06:03:02,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:03:02 INFO - 2015-11-24 06:03:02,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:03:02 INFO - 2015-11-24 06:03:02,036 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:03:02 INFO - 2015-11-24 06:03:02,036 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;113;113;110;124;110;110;111;111 06:03:02 INFO - 2015-11-24 06:03:02,037 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;127;150;160;126;151;146;132;161;125 06:03:02 INFO - 2015-11-24 06:03:02,037 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;164;161;163;162;161;162;169;164 06:03:02 INFO - 2015-11-24 06:03:02,037 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;71;71;72;72;73;170;71;73 06:03:02 INFO - 2015-11-24 06:03:02,037 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;149;93;94;93;133;93;94;138 06:03:02 INFO - 2015-11-24 06:03:02,037 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;110;110;110;109;110 06:03:02 INFO - 2015-11-24 06:03:02,038 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;146;146;146;147;147;146;147 06:03:02 INFO - 2015-11-24 06:03:02,038 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;97;96;97;96;96 06:03:02 INFO - 2015-11-24 06:03:02,038 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;67;65;64;65;66;64;64;62;64 06:03:02 INFO - 2015-11-24 06:03:02,038 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;70;69;69;69;68;68;68 06:03:02 INFO - 2015-11-24 06:03:02,038 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;87;86;85;84;87;86;85;86;85 06:03:02 INFO - 2015-11-24 06:03:02,039 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;121;116;132;126;126;121;123;129;118 06:03:02 INFO - 2015-11-24 06:03:02,039 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;168;151;150;152;145;150;151;153;143 06:03:02 INFO - 2015-11-24 06:03:02,039 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;66;68;68;66;68;67;65;68 06:03:02 INFO - 2015-11-24 06:03:02,039 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:03:02 INFO - 2015-11-24 06:03:02,039 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:03:02 INFO - 2015-11-24 06:03:02,040 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 06:03:02 INFO - 2015-11-24 06:03:02,040 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:03:02 INFO - 2015-11-24 06:03:02,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373782034__endTimestamp 06:03:02 INFO - 2015-11-24 06:03:02,040 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,044 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:03:02 INFO - 2015-11-24 06:03:02,044 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:03:02 INFO - 2015-11-24 06:03:02,044 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,044 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.68 (4.2%) stddev-sans-first:4.95 06:03:02 INFO - 2015-11-24 06:03:02,045 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 113.0 113.0 110.0 124.0 110.0 110.0 111.0 111.0 06:03:02 INFO - 2015-11-24 06:03:02,045 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,045 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.80 Median:150.00 stddev:14.04 (9.4%) stddev-sans-first:14.65 06:03:02 INFO - 2015-11-24 06:03:02,045 DEBUG : BROWSER_OUTPUT: Values: 150.0 127.0 150.0 160.0 126.0 151.0 146.0 132.0 161.0 125.0 06:03:02 INFO - 2015-11-24 06:03:02,046 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,046 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:2.42 (1.5%) stddev-sans-first:2.47 06:03:02 INFO - 2015-11-24 06:03:02,046 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 164.0 161.0 163.0 162.0 161.0 162.0 169.0 164.0 06:03:02 INFO - 2015-11-24 06:03:02,047 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,047 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.90 Median:72.50 stddev:30.97 (42.7%) stddev-sans-first:32.68 06:03:02 INFO - 2015-11-24 06:03:02,047 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 71.0 71.0 72.0 72.0 73.0 170.0 71.0 73.0 06:03:02 INFO - 2015-11-24 06:03:02,047 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,048 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:22.83 (24.5%) stddev-sans-first:23.61 06:03:02 INFO - 2015-11-24 06:03:02,048 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 149.0 93.0 94.0 93.0 133.0 93.0 94.0 138.0 06:03:02 INFO - 2015-11-24 06:03:02,048 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,048 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,049 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 65.0 64.0 65.0 66.0 64.0 64.0 62.0 64.0 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 06:03:02 INFO - 2015-11-24 06:03:02,050 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 70.0 69.0 69.0 69.0 68.0 68.0 68.0 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.08 (1.3%) stddev-sans-first:1.00 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: Values: 84.0 87.0 86.0 85.0 84.0 87.0 86.0 85.0 86.0 85.0 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:5.29 (4.2%) stddev-sans-first:5.17 06:03:02 INFO - 2015-11-24 06:03:02,051 DEBUG : BROWSER_OUTPUT: Values: 130.0 121.0 116.0 132.0 126.0 126.0 121.0 123.0 129.0 118.0 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:151.00 stddev:6.66 (4.4%) stddev-sans-first:7.02 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: Values: 149.0 168.0 151.0 150.0 152.0 145.0 150.0 151.0 153.0 143.0 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.05 (1.6%) stddev-sans-first:1.12 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 66.0 68.0 68.0 66.0 68.0 67.0 65.0 68.0 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:03:02 INFO - 2015-11-24 06:03:02,052 DEBUG : BROWSER_OUTPUT: 06:03:02 INFO - 2015-11-24 06:03:02,924 INFO : Browser exited with error code: 0 06:03:02 INFO - 2015-11-24 06:03:02,974 INFO : Completed test kraken (00:00:59) 06:03:02 INFO - 2015-11-24 06:03:02,975 INFO : Starting test v8_7 06:03:02 INFO - 2015-11-24 06:03:02,975 DEBUG : operating with platform_type : linux_ 06:03:02 INFO - 2015-11-24 06:03:02,975 INFO : Initialising browser for v8_7 test... 06:03:02 INFO - 2015-11-24 06:03:02,981 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpndYOF9/profile http://localhost:56245/getInfo.html 06:03:07 INFO - 2015-11-24 06:03:07,326 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:03:07 INFO - 2015-11-24 06:03:07,326 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:03:07 INFO - 2015-11-24 06:03:07,326 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 06:03:07 INFO - 2015-11-24 06:03:07,326 DEBUG : BROWSER_OUTPUT: __metrics 06:03:08 INFO - 2015-11-24 06:03:08,287 INFO : Browser initialized. 06:03:08 INFO - 2015-11-24 06:03:08,288 INFO : Running cycle 1/1 for v8_7 test... 06:03:08 INFO - 2015-11-24 06:03:08,288 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpndYOF9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:03:20 INFO - 2015-11-24 06:03:20,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 141684736 06:03:20 INFO - 2015-11-24 06:03:20,100 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56245/tests/v8_7/run.html (next: http://localhost:56245/tests/v8_7/run.html) 06:03:41 INFO - 2015-11-24 06:03:41,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 138305536 06:03:41 INFO - 2015-11-24 06:03:41,690 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,690 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:03:41 INFO - 2015-11-24 06:03:41,690 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: |0;Richards;189.8614011771407 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.98642095053347 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 06:03:41 INFO - 2015-11-24 06:03:41,691 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5010 06:03:41 INFO - 2015-11-24 06:03:41,692 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1046.0251046025105 06:03:41 INFO - 2015-11-24 06:03:41,692 DEBUG : BROWSER_OUTPUT: |5;Earley;706.2146892655368 06:03:41 INFO - 2015-11-24 06:03:41,692 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 06:03:41 INFO - 2015-11-24 06:03:41,692 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 06:03:41 INFO - 2015-11-24 06:03:41,692 DEBUG : BROWSER_OUTPUT: |8;Splay;999.0019960079841 06:03:41 INFO - 2015-11-24 06:03:41,693 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 06:03:41 INFO - 2015-11-24 06:03:41,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:03:41 INFO - 2015-11-24 06:03:41,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1448373821687__endTimestamp 06:03:41 INFO - 2015-11-24 06:03:41,693 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,693 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.86 Median:189.86 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: Values: 189.9 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,694 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.99 Median:193.99 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: Values: 194.0 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: Values: 285.1 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5010.00 Median:5010.00 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: Values: 5010.0 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,695 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1046.03 Median:1046.03 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: Values: 1046.0 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: Values: 706.2 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: Values: 12207.3 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,696 DEBUG : BROWSER_OUTPUT: Values: 25225.0 06:03:41 INFO - 2015-11-24 06:03:41,697 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,697 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:999.00 Median:999.00 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,697 DEBUG : BROWSER_OUTPUT: Values: 999.0 06:03:41 INFO - 2015-11-24 06:03:41,698 DEBUG : BROWSER_OUTPUT: 06:03:41 INFO - 2015-11-24 06:03:41,698 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 06:03:41 INFO - 2015-11-24 06:03:41,698 DEBUG : BROWSER_OUTPUT: Values: 4830.9 06:03:41 INFO - 2015-11-24 06:03:41,698 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:03:41 INFO - 2015-11-24 06:03:41,698 DEBUG : BROWSER_OUTPUT: 06:03:42 INFO - 2015-11-24 06:03:42,520 INFO : Browser exited with error code: 0 06:03:42 INFO - 2015-11-24 06:03:42,536 INFO : Completed test v8_7 (00:00:39) 06:03:42 INFO - 2015-11-24 06:03:42,781 INFO : Completed test suite (00:20:10) 06:03:42 INFO - 2015-11-24 06:03:42,781 DEBUG : Working with test: dromaeo_css 06:03:42 INFO - 2015-11-24 06:03:42,781 DEBUG : Generating results file: dromaeo_css 06:03:42 INFO - 2015-11-24 06:03:42,782 DEBUG : Working with test: kraken 06:03:42 INFO - 2015-11-24 06:03:42,782 DEBUG : Generating results file: kraken 06:03:42 INFO - 2015-11-24 06:03:42,783 INFO : javascript benchmark 06:03:42 INFO - 2015-11-24 06:03:42,783 DEBUG : Working with test: v8_7 06:03:42 INFO - 2015-11-24 06:03:42,783 DEBUG : Generating results file: v8_7 06:03:42 INFO - 2015-11-24 06:03:42,783 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:42 INFO - 2015-11-24 06:03:42,855 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 06:03:42 INFO - 2015-11-24 06:03:42,855 DEBUG : process_Request line: dromaeo_css 6960.41 graph.html#tests=[[72,1,43]] 06:03:42 INFO - 2015-11-24 06:03:42,855 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:42 INFO - 2015-11-24 06:03:42,886 DEBUG : process_Request line: kraken 1521.00 graph.html#tests=[[232,1,43]] 06:03:42 INFO - 2015-11-24 06:03:42,887 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:03:42 INFO - 2015-11-24 06:03:42,920 DEBUG : process_Request line: v8_7 20108.57 graph.html#tests=[[230,1,43]] 06:03:42 INFO - 2015-11-24 06:03:42,921 INFO : javascript benchmark 06:03:42 INFO - 2015-11-24 06:03:42,924 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3211.486162214046, 3259.201495633569, 3269.280758233188, 3291.999999999999, 3301.2572171261468, 5251.0, 5336.813211537592, 5348.572114230862, 5384.057789886764, 5386.569074474042, 5346.839594812152, 5355.0628639988045, 5374.113271310229, 5465.9180112298345, 5488.259085023521, 4886.731229782369, 4972.378452693413, 5025.522575355354, 5043.24351347299, 5054.797808087672, 5031.044101620699, 5031.11955407804, 5083.517065878736, 5099.923501147486, 5151.562117220022, 4819.0, 4928.43323017854, 5035.999999999982, 5059.0, 5141.742912854361, 4860.659753817235, 4960.776765045582, 4961.131801934647, 4986.62600304975, 4994.250862370637, 4962.1812400953795, 4970.776315065831, 4977.576905962997, 5001.149804533238, 5024.748762561857, 5101.107306221396, 5196.553581044702, 5241.79032838686, 5311.203319502067, 5312.0, 5810.622309549865, 5828.883422331572, 5851.444112809277, 5931.703414829284, 5962.986292330271, 5901.17383566301, 5946.791862284843, 5953.0, 5970.791022314198, 5978.671173085479, 5318.0, 5493.395726470085, 5545.279113715191, 5552.7223638817895, 5559.805406810783, 5864.706764661835, 5917.171595976567, 5952.553558483131, 5976.970115149484, 6030.18592490017, 5837.678927658934, 5840.153177789197, 5849.88300233993, 5862.70686465675, 5879.382664820132, 5669.971650141805, 5737.110747834093, 5824.621399609012, 5932.584719069624, 5953.464188222994, 5772.509336706343, 5850.297964244318, 5870.0, 5873.148393483007, 5910.0, 5906.202662640574, 5925.585209035412, 5928.170056192136, 5928.288605367384, 5950.107483877453, 4352.129574085196, 4413.536578659258, 4440.0, 4537.750423726727, 4544.2501987171745, 4032.5967403260024, 4050.10897602527, 4055.858044968412, 4060.92385517838, 4068.3287257602756, 5678.68767217807, 5688.914666280009, 5692.089265717465, 5697.7151142443545, 5741.827745167651, 5699.059655156935, 5824.126381042877, 5891.646501209942, 5965.73154208053, 6078.422549857756, 5674.432556744293, 5690.2887139107615, 5692.231548740867, 5694.487496125285, 5702.916445875353, 5154.948450515447, 5164.509371609691, 5177.948220517822, 5182.067227899014, 5227.320448341691, 5853.765849366063, 5954.493868021266, 5969.044952807617, 5990.161377407254, 6073.271207455134, 5852.7658893643775, 5914.58597898143, 5941.881162376641, 5942.762289508371, 5959.67221802805, 5831.0, 6045.78839740607, 6067.029275315928, 6112.052631842072, 6113.786017489367, 5675.858103547444, 5687.800926967537, 5783.190353350618, 5785.392533783892, 5822.155787410887, 5970.880582388415, 5975.55183361241, 5981.491573216325, 6026.096085587197, 6034.758609655564, 5518.392976772471, 5614.522765564972, 5868.823935281948, 5873.089671100986, 5898.793542226002, 5694.430556944272, 5696.344920334214, 5733.541316694571, 5779.8266052016825, 5793.0, 5729.226554415267, 5737.770489180386, 5744.109663002241, 5744.195812586325, 5776.624519406225, 5510.3938566758425, 5530.640508366943, 5797.275340582427, 5818.563607729353, 5864.648121112747, 5682.3465301489205, 5767.250257466502, 5773.971130144322, 5781.653100813965, 5812.883742325045], "unit": "ms", "name": "dojo.html", "value": 5424.846041445525}, {"lowerIsBetter": false, "replicates": [549.3353042818193, 592.5792687192094, 596.7076132694981, 601.2364297342375, 608.9177960975269, 38970.805145974264, 39126.21747565047, 39207.21585568287, 39656.405153922715, 39684.80157599212, 42361.788191059, 42962.355564666475, 43152.0, 43236.783816080955, 43318.0, 8684.652613895436, 8834.602442890053, 8852.5573721314, 8854.601542930552, 8871.556422178897, 8563.700270490534, 8636.697715579956, 8645.95677021614, 8649.351298652595, 8665.740027799176, 8665.263452606536, 8777.73666789994, 8783.516906570136, 8792.428492148021, 8793.648254069829, 8689.26141277992, 8708.825823483496, 8748.825023499558, 8781.077986811388, 8792.34057445694, 8577.871331930026, 8682.175193356621, 8698.434601750929, 8719.651213951434, 8746.212840844291, 39642.40536391956, 40035.799821001, 40242.39636405456, 40257.0, 40337.79831100826, 3232.8221947792863, 3314.2045908981913, 3357.462805951036, 3553.573571171476, 3897.2205558888336, 29322.266943326373, 29543.556846647316, 29962.0, 30192.396152076835, 30287.242818929484, 3972.245273398045, 4024.8993775155855, 4082.5305089914445, 4096.078382363974, 4168.7707176105305, 253041.0, 258776.0, 258788.0, 259297.0, 259645.0, 60127.0, 61644.69177654083, 62034.68982655058, 62532.749345012846, 63889.36110638834, 57017.0, 58106.0, 58307.0, 58382.0, 58442.41557584455, 16406.753898691528, 16595.41916032933, 16626.168691565614, 16627.83372166287, 16678.49964501067, 11244.044256238149, 11253.774924501628, 11298.54805807775, 11329.09367250618, 11347.205695601393, 21326.573468530543, 21533.78466215318, 21712.457188570414, 21713.13147474115, 21758.673619895715, 8541.95729021351, 8677.956610216908, 8783.165599268059, 8792.516411597424, 8853.73438796837, 977.2816979520047, 1041.906228439429, 1050.721558786922, 1062.4262898035129, 1139.1342579639368, 27122.32194195161, 27435.588466173023, 27502.312442189104, 27656.58515122275, 27823.0, 1066.802641511323, 1078.638656050232, 1117.7317443813588, 1121.2151493954264, 1163.4124766992616, 14607.488737894122, 15951.361945522049, 16521.91739041321, 16617.335306587844, 16876.578085547713, 632174.0, 645137.0, 647648.0, 654094.0, 658545.0, 54130.0, 54262.0, 54664.726676366365, 54757.72621136948, 54858.72570637201, 1271.7965125580047, 1309.4696647857634, 1314.493919840868, 1329.667583104224, 1331.068252223428, 28796.42407151887, 29534.261643459085, 29657.40685186241, 29726.702732972393, 29750.0, 44346.334804977305, 44818.551814482744, 45041.774791125834, 45234.77382613066, 45238.77380613076, 282503.0, 284986.0, 286002.0, 286448.0, 287416.0, 32243.516347255278, 45621.0, 45925.54074459346, 46321.305180423, 46478.302825456965, 43117.784411077744, 43480.565194347655, 43713.78143109264, 43900.341494878245, 43989.0, 36842.263154737295, 36859.0, 40505.59494405018, 41428.79285603553, 41987.580124198365, 36970.07574810544, 37155.25689486249, 37329.81335093307, 37352.0, 37423.43864841975, 39576.80211598924, 39625.603743962194, 40414.79792601018, 40657.39013914735, 40857.79571102125, 30317.848410757804, 30938.226544336572, 32960.340793184485, 33512.49731254082, 36628.0, 25778.226653200432, 25912.352191194615, 25918.61122083208, 26109.08618198354, 26177.73822261753], "unit": "ms", "name": "ext.html", "value": 19434.640025073793}, {"lowerIsBetter": false, "replicates": [357.30147561517236, 357.5459166858089, 359.88663570975143, 363.17196791315797, 365.1091337137384, 17003.82996170038, 17261.82738172618, 17412.216450259737, 18032.639347213066, 18853.151608177614, 14084.0, 16114.838851611481, 16355.754663680025, 16803.66392672146, 16903.83096169038, 4764.833230836913, 4868.829590964317, 4898.632602554822, 4899.51004899509, 4917.582005529534, 4839.588634966032, 4878.829240976566, 4897.240927656219, 4917.72952487613, 4924.0, 4431.822727090913, 5325.4940780625775, 5329.706866122362, 5509.201165830952, 5712.057510510761, 5342.5993050521365, 5651.0, 5688.175214593882, 5702.116171993348, 5703.600747947646, 5016.473270306638, 5047.873803154914, 5051.646384753069, 5055.443901170868, 5060.873478163038, 11117.666470005914, 11183.66449006523, 11327.037201837853, 11428.94285528567, 11525.76948461026, 2034.094827801629, 2055.321743824534, 2064.783197764243, 2084.4997200671883, 2140.8388938999024, 8428.578571071423, 8828.779280518038, 8873.778155546099, 9004.41471304363, 9028.819423611556, 1734.5923707928628, 1810.3754204799322, 1832.761740973665, 1837.0998210876708, 1879.0322983663289, 58769.7061514694, 60507.999999999556, 61716.38283617151, 62222.377776222114, 62269.37730622681, 9915.504224788732, 10017.749556261006, 10044.598216071421, 10047.296689231829, 10072.194224462026, 12672.429740661692, 12768.425420855898, 12833.101682882108, 12841.0, 12854.164479308814, 7301.561906285639, 7352.77941661751, 7499.250074992567, 7597.772066838003, 7637.618119094134, 7272.63636818157, 7295.854082918312, 7403.2226616204525, 7538.623068846536, 7541.622918854036, 4237.406763053175, 4288.89277768052, 4317.611414972667, 4321.719088259253, 4330.826766929287, 1681.6048228666255, 1708.7009773289624, 1766.152246921485, 1788.4455818696247, 1800.7659004329353, 373.48272642390486, 378.3530163420527, 381.04738154613466, 383.3062157494943, 398.7288643722297, 9271.119243671841, 9595.42427454355, 9857.605695772232, 9923.503824808875, 10170.338927969658, 394.6704501741021, 405.81535401392296, 411.91555731075056, 414.52122798168165, 425.3874420833989, 5412.0, 5419.214213938957, 5495.422980586981, 5507.0637991541535, 9465.716028519155, 462684.0, 477731.0, 489330.0, 493809.0, 496943.0, 75960.0, 76247.61876190583, 76856.0, 77954.61022694963, 78456.60771696105, 1161.071143085528, 1177.3465726521863, 1187.0622208455395, 1189.1141099880645, 1190.2323001663879, 14837.554873353816, 15202.847971520143, 15271.160086195367, 15315.310811013309, 15468.381264749283, 31015.68984310128, 31341.0, 32861.01416957495, 33811.66188338085, 34265.65734342625, 39894.40158397568, 40304.59695403009, 40584.59415405808, 40968.38547421851, 43239.0, 9099.59051842682, 9211.815763684555, 9374.578143983674, 9406.670766523139, 9435.150836424755, 13250.906201897047, 17523.211455484277, 17570.297188112334, 17861.821381786536, 18000.81999180044, 13615.795763063365, 13864.861351386357, 14164.0, 14213.289335533389, 14577.85422145765, 13928.860711392756, 13937.860621394062, 14033.649158771112, 14088.01383903117, 14486.637834053812, 13808.861911380758, 13961.371738271599, 14580.562583122522, 14610.707785844435, 15155.772663409836, 8575.485470871768, 8755.0, 8842.204201621886, 9024.68413605547, 9078.910530736353, 2750.2436829871945, 11489.840293918905, 13600.0, 14164.220967846868, 14603.561893143222], "unit": "ms", "name": "jquery.html", "value": 7864.871352960803}, {"lowerIsBetter": false, "replicates": [1530.4949366708988, 1644.1532610705485, 1669.8413650703178, 1715.253864568912, 1737.1314342828587, 7314.780556583311, 7409.073865766779, 7458.254174582539, 7646.923530764698, 7647.197044310351, 7799.298063174313, 7820.843583128349, 7837.4513784035, 7857.096433910102, 7910.327622152109, 2261.9208327708575, 2299.574578702937, 2304.066852924568, 2304.366299267698, 2307.7461479237354, 2260.163739416418, 2287.3824067501764, 2290.702208712865, 2293.334932869466, 2301.746807851135, 2221.833362497811, 2236.452069243038, 2241.1035585765744, 2247.292102987562, 2268.5803126421583, 2187.912483500666, 2236.0943817753837, 2256.4697296135396, 2264.445210923326, 2265.728112626487, 2233.4639686475293, 2265.818734501236, 2277.4078739527677, 2291.1293708390704, 2299.241250387368, 7429.777106686808, 7459.589722565257, 7488.962555187244, 7501.099868015818, 7506.66220020095, 4568.177728008957, 4663.253879379283, 4675.555822196886, 4676.3453116563705, 4679.88300292492, 3146.2606287522412, 3169.635491918436, 3211.42194405007, 3222.3716375306826, 3238.6923242291946, 976.2824324121765, 987.195435719886, 995.85560093786, 1010.2726037253166, 1033.5142483032962, 10448.373097614092, 10531.73670658232, 10536.894631053668, 10543.472826358728, 10546.947265263701, 4013.7391069580385, 4064.7967601619803, 4103.261412945639, 4112.0, 4130.070734084867, 8539.573021348908, 8540.53027083504, 8561.44350617208, 8585.914140858637, 8604.440711353742, 4637.744924029211, 4661.184292748755, 4680.438347398334, 4686.414198225222, 4687.95312046882, 4206.915861682749, 4236.597523235288, 4242.7242229255, 4312.5903039211225, 4321.286987647066, 3335.9666403335655, 3337.199072222649, 3351.8826841060445, 3352.7762366735965, 3375.780574262665, 991.6281394477071, 991.8462638291077, 1000.8899021107673, 1001.9749506262402, 1004.7337455574278, 1077.1598153440173, 1092.0226397374306, 1097.846301517788, 1138.2885696439726, 1260.8108783682521, 7243.89134162988, 7258.201597824235, 7275.599842008741, 7280.96359518199, 7306.342429181293, 1012.1346248957183, 1095.0153986540417, 1164.4352489042808, 1168.2114572663588, 1171.3499008050615, 5471.124620060851, 5479.287692600016, 5706.0, 5761.769529218785, 5794.362620111784, 9100.499472529074, 9226.723198303927, 9267.212286955684, 9268.397554158959, 9329.953350233205, 9041.547922603844, 9193.402428842104, 9255.90744092564, 9309.208717258973, 9330.720078397659, 7097.183823860219, 7143.785686429415, 7178.892316615255, 7180.210176880539, 7191.856162876713, 6834.692438840363, 6913.239543650295, 6936.653167341512, 6945.2707465715375, 6952.200496942916, 8040.798980025546, 8101.10887802353, 8284.875726863982, 8291.33669306442, 8307.252347288773, 8237.670493180205, 8360.45657032291, 8396.748097557083, 8407.579621019047, 8450.112738162405, 6446.806595802133, 6458.321876202931, 6501.642409667514, 6501.837454063686, 6504.349565043458, 7156.141263048259, 7254.492185547172, 7468.178500365064, 7489.775306740807, 7499.850003000019, 6911.447084233349, 7029.472789540702, 7041.894371584328, 7077.5753454792875, 7140.8214794628475, 6523.3150519194805, 6630.867382652416, 6791.830204244736, 6884.345987131214, 6970.093887794555, 6907.654617269217, 6927.653617319013, 6995.4753393494675, 7028.226895041644, 7032.261612530815, 6301.527385446018, 6374.776882809079, 6379.0, 6393.808185754248, 6401.455876250571, 6588.472922166311, 6624.701888415129, 6648.501362397743, 6655.700493477708, 6662.267150613332], "unit": "ms", "name": "mootools.html", "value": 4413.275637366905}, {"lowerIsBetter": false, "replicates": [303.9604851369322, 308.41709169669326, 309.43836935961224, 314.34145465250293, 315.4259248168333, 6195.070739389088, 6367.840803979902, 6381.521385896059, 6420.069089981961, 6422.16511853459, 6274.372562743734, 6276.466500347465, 6281.560290779647, 6282.183316168892, 6290.622562646245, 4574.085182963404, 4693.859184224461, 4744.193487107183, 4750.453697824742, 4757.0723708876785, 4659.998100408411, 4684.695494792828, 4691.085238378518, 4704.717716936994, 4711.670183087185, 4632.8146874125, 4635.652326075541, 4638.698484598491, 4642.558956899089, 4645.372874661928, 4620.376249206364, 4632.97683511582, 4642.234031384817, 4647.837325693618, 4659.7204167749705, 3893.2213557288374, 3940.428637847525, 3951.4863067801, 3951.920961580752, 3959.247742928834, 5875.500582450497, 5965.373635768268, 5991.460768530853, 5996.730147143389, 6022.126791615235, 5416.945830541684, 5417.674939503642, 5432.320959880015, 5434.619576629638, 5446.101393270105, 6668.233153187397, 6686.297938716462, 6702.865942681119, 6705.094812200388, 6708.563943343667, 4360.454943132108, 4403.339499075132, 4443.333499974998, 4445.8221671133115, 4450.977745111286, 6817.284185160536, 6922.965385173042, 6924.065251191126, 6968.094147760809, 6970.581765094111, 4466.129104824593, 4499.34759459883, 4502.549745025537, 4504.009117994036, 4504.954950450454, 4488.798004089758, 4559.270516717309, 4561.042181141997, 4563.612092972068, 4564.2240819060835, 5363.624546281723, 5405.864853378697, 5415.647982881179, 5422.349318081855, 5423.294971653739, 6702.597844129368, 6730.7307707692125, 6742.5280230383405, 6772.52592318533, 6781.152355955505, 1602.5512856400226, 1615.9757603635956, 1621.570283874774, 1621.7648440975993, 1627.9430219942244, 1016.8830584482731, 1040.6409788622914, 1042.5673345561659, 1043.4834756795435, 1062.95216715248, 6488.059231411419, 6495.6752162391695, 6526.412622863965, 6531.836704082436, 6544.411003009752, 6911.308869113149, 6931.064306318583, 6961.617111058839, 6971.0, 6978.5812851228075, 6431.807045788541, 6456.741730330734, 6508.284088750233, 6520.217573891164, 6531.1509503765155, 3814.752041117374, 3838.9040273992814, 3842.269968705937, 3842.884713458601, 3850.383938569815, 7199.496035277585, 7226.0, 7228.783136505913, 7319.451041171827, 7320.267973202637, 7119.644017799089, 7150.785476435715, 7168.53404528704, 7202.0637317149485, 7208.675609597476, 7019.929800701928, 7102.218755936843, 7106.92893071073, 7145.749898753623, 7153.785386438311, 6994.790156295116, 7025.192102908231, 7026.086608740831, 7026.508144429841, 7031.753888613874, 6920.826979325557, 6973.651317434006, 6978.581285122909, 6981.860362792817, 6988.79033628992, 7115.466340024415, 7258.0927384076995, 7276.563406195645, 7304.890426643498, 7357.926420735724, 4586.325991013323, 4614.561616646548, 4618.422697162855, 4621.491635919979, 4625.814967401401, 6892.862142757217, 6942.2363540011565, 6957.0, 6964.164300283998, 6964.721411143498, 6610.570312929644, 6727.260001399744, 6728.428083612947, 6746.831329216809, 6764.5603035802515, 6700.631465269457, 6729.7644582441335, 6734.8653026940165, 6748.055272261985, 6751.324867513209, 6582.3746744059235, 6594.604323740591, 6603.273639899703, 6628.469722422291, 6631.801045968628, 6615.470762339098, 6706.195256569243, 6721.932780672326, 6736.898946515904, 6737.59574425536, 6551.901721474277, 6556.737730490727, 6566.212054553484, 6578.539502234989, 6586.0], "unit": "ms", "name": "prototype.html", "value": 4974.664765283219}, {"lowerIsBetter": false, "replicates": [814.2427542385581, 824.5570252058897, 859.6905114158901, 878.8242351529692, 893.9942564614809, 13032.869671303284, 14330.92834535826, 14342.569722908316, 14358.784618230735, 14379.137251764876, 13412.396442160101, 13464.259465729381, 13481.123726957741, 13516.662083447918, 13539.323033848317, 799.8920145780332, 821.363443331417, 821.4906757810166, 823.8805373220879, 836.6820608168917, 819.0662644585148, 824.8226631274275, 826.9214424629681, 827.2430725885807, 827.3050637464529, 848.1179573243819, 848.7920459487434, 850.2517784349764, 853.1127627267634, 855.9186877246651, 844.1684940333766, 851.5061264466594, 853.6542700206427, 853.8633818589027, 854.6624083487019, 623.5354660777705, 623.834683808791, 624.5752888036134, 624.5815303746501, 625.4933503861887, 13994.720105597933, 14132.434702611883, 14149.29253537319, 14164.291785410689, 14216.644583885382, 11710.648680539598, 11750.0, 11988.880111198863, 12032.51869925202, 12114.454849531705, 9972.551235194362, 10249.487525623688, 10436.739081523023, 10508.947455262674, 11492.885071149349, 3610.6930910872607, 3611.205534782344, 3660.6156353583024, 3660.9816950915074, 3734.159814041846, 48591.75704121492, 48718.0, 48917.0, 49057.50942490565, 49108.99999999964, 9634.807303853884, 9963.750906227402, 10002.099811017044, 10273.9486302568, 10344.844827327595, 17970.101494925464, 18100.27598896056, 18128.818711812713, 18257.995810230565, 18345.08274586265, 7094.467914906402, 7124.501284910007, 7246.49274550787, 7264.34620884123, 7335.303146201102, 4084.346504559256, 4148.23257697327, 4180.435641188462, 4186.246475634415, 4223.049813791934, 2857.8428186449946, 2964.5997790298034, 2969.732724054845, 2989.7309242167876, 2993.536001919706, 546.7976848566057, 548.3693752184939, 555.3918459287074, 558.3885645218479, 574.3423779772138, 529.8869143780291, 571.2431028886741, 640.7693230437039, 650.8730797494443, 653.3499168327545, 7423.369013633794, 7686.423518236154, 7733.883991740128, 7846.686132554748, 7878.921210787933, 568.4486048532999, 626.264139635926, 644.1432894250729, 678.772611175252, 689.9862002760017, 3654.616265292106, 3680.263947210515, 3721.2743515014854, 3799.2781371539318, 3842.5773164951834, 51801.7409912948, 55149.72425137849, 57048.0, 57186.42813571811, 57256.42743572594, 48880.26679599809, 49881.75059124681, 50228.0, 50722.74638626857, 51060.23409648858, 46090.0, 46351.5364846354, 46372.536274637496, 46552.0, 46650.76674616673, 8237.546934918637, 8247.876281855897, 8256.917430825855, 8420.789480263042, 8474.618642160995, 34938.47592286067, 35552.444755524244, 35564.28871422609, 35670.108247294025, 36151.0, 40797.38803918003, 43967.340489893315, 45603.31595026011, 45640.31539526976, 46147.53852461433, 10361.74095647615, 10486.528106235086, 10786.784264314512, 11157.55369785232, 11230.55077796879, 10311.896881031094, 10733.463326833784, 11662.76674466489, 11720.765584688088, 12067.215630983957, 11134.888651113386, 11271.718207044889, 11276.9436152822, 11525.827112593486, 11682.24065435744, 11010.284331518425, 11402.429878506207, 11481.827772583585, 11577.305361678325, 11711.76576468483, 11007.284526505751, 11293.774124517628, 11475.426228688699, 11498.08015358786, 11743.588974385855, 9298.767530811783, 9429.245660347293, 9612.615495380107, 9699.41400205628, 9736.610535578497, 8765.894833122751, 8766.956165219133, 9173.816523669355, 9418.717438476857, 9697.175740062174], "unit": "ms", "name": "yui.html", "value": 6245.814571011847}], "name": "dromaeo_css", "value": 6960.407463564651}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 113.0, 113.0, 110.0, 124.0, 110.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 150.0, 160.0, 126.0, 151.0, 146.0, 132.0, 161.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 164.0, 161.0, 163.0, 162.0, 161.0, 162.0, 169.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 71.0, 71.0, 72.0, 72.0, 73.0, 170.0, 71.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 149.0, 93.0, 94.0, 93.0, 133.0, 93.0, 94.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0, 62.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 64.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 86.0, 85.0, 84.0, 87.0, 86.0, 85.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [130.0, 121.0, 116.0, 132.0, 126.0, 126.0, 121.0, 123.0, 129.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [149.0, 168.0, 151.0, 150.0, 152.0, 145.0, 150.0, 151.0, 153.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 68.0, 66.0, 68.0, 67.0, 65.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1520.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.8614011771407], "unit": "score", "name": "Richards", "value": 185.935634}, {"lowerIsBetter": false, "replicates": [193.98642095053347], "unit": "score", "name": "DeltaBlue", "value": 340.8382899999999}, {"lowerIsBetter": false, "replicates": [285.143997718848], "unit": "score", "name": "Encrypt", "value": 933.4967669999996}, {"lowerIsBetter": false, "replicates": [5010.0], "unit": "score", "name": "Decrypt", "value": 53.12994011976049}, {"lowerIsBetter": false, "replicates": [1046.0251046025105], "unit": "score", "name": "RayTrace", "value": 707.4294840000001}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [999.0019960079841], "unit": "score", "name": "Splay", "value": 81.57240959040956}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20108.568207561315}]} 06:03:42 INFO - RETURN: dromaeo_css: 6960.41 06:03:42 INFO - RETURN: kraken: 1521.00 06:03:42 INFO - RETURN: v8_7: 20108.57 06:03:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20108.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1521.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6960.41"}}} 06:03:42 INFO - Return code: 0 06:03:42 INFO - # TBPL SUCCESS # 06:03:42 INFO - Running post-action listener: _resource_record_post_action 06:03:42 INFO - Running post-run listener: _resource_record_post_run 06:03:44 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 24576; Write bytes: 516325376; Read time: 44; Write time: 379724 06:03:44 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 133705728; Read time: 0; Write time: 162600 06:03:44 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 24576; Write bytes: 382619648; Read time: 44; Write time: 217124 06:03:44 INFO - Running post-run listener: _upload_blobber_files 06:03:44 INFO - Blob upload gear active. 06:03:44 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:03:44 INFO - Copying logs to upload dir... 06:03:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.636489 ========= master_lag: 6.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-24 06:03:49.841645) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:03:49.845449) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010067 build_url: 'https://queue.taskcluster.net/v1/task/FajElp5mRzKNNWydzxgQpQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.61 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 06:03:50.464037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:03:50.464459) ========= 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=d6a7e047ef025f707024e163000001c3-1448372537.998425-1428129795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 06:03:50.484922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:03:50.485255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 06:03:50.485555) ========= ========= Total master_lag: 6.79 =========