builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-004 starttime: 1448290011.43 results: success (0) buildid: 20151123043004 builduid: 72cd1c31b1d6414ca7a21bcbfac58212 revision: b9b6a1567ef6b27735e19b661e895753db58e902 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.425671) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.426265) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.426552) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006676 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.447271) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.447584) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.474585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.475197) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020696 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.525325) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.525626) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.525975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.526260) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 06:46:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-23 06:46:52 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181976 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.720202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.720641) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070781 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.802156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:51.802535) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b9b6a1567ef6b27735e19b661e895753db58e902 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b9b6a1567ef6b27735e19b661e895753db58e902 --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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 06:46:52,603 truncating revision to first 12 chars 2015-11-23 06:46:52,603 Setting DEBUG logging. 2015-11-23 06:46:52,603 attempt 1/10 2015-11-23 06:46:52,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b9b6a1567ef6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 06:46:53,105 unpacking tar archive at: mozilla-inbound-b9b6a1567ef6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.790852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:52.606095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:52.606445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:52.616642) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:52.617002) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 06:46:52.617446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 06:46:52.617728) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:46:53 INFO - MultiFileLogger online at 20151123 06:46:53 in /builds/slave/test-pgo 06:46:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:46:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:46:53 INFO - {'append_to_log': False, 06:46:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:46:53 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:46:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:46:53 INFO - 'branch': 'Mozilla-Inbound', 06:46:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:53 INFO - 'config_files': ('talos/linux_config.py',), 06:46:53 INFO - 'default_actions': ('clobber', 06:46:53 INFO - 'read-buildbot-config', 06:46:53 INFO - 'download-and-extract', 06:46:53 INFO - 'populate-webroot', 06:46:53 INFO - 'create-virtualenv', 06:46:53 INFO - 'install', 06:46:53 INFO - 'run-tests'), 06:46:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:53 INFO - 'download_minidump_stackwalk': True, 06:46:53 INFO - 'download_symbols': 'ondemand', 06:46:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:53 INFO - 'installer_path': 'installer.exe', 06:46:53 INFO - 'log_level': 'info', 06:46:53 INFO - 'log_name': 'talos', 06:46:53 INFO - 'log_to_console': True, 06:46:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:46:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:46:53 INFO - 'opt_config_files': (), 06:46:53 INFO - 'pip_index': False, 06:46:53 INFO - 'sps_profile': False, 06:46:53 INFO - 'sps_profile_interval': 0, 06:46:53 INFO - 'suite': 'dromaeojs', 06:46:53 INFO - 'system_bits': '64', 06:46:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:53 INFO - 'title': 'talos-linux64-ix-004', 06:46:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:53 INFO - 'use_talos_json': True, 06:46:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:46:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:53 INFO - 'work_dir': 'build'} 06:46:53 INFO - ##### 06:46:53 INFO - ##### Running clobber step. 06:46:53 INFO - ##### 06:46:53 INFO - Running pre-action listener: _resource_record_pre_action 06:46:53 INFO - Running main action method: clobber 06:46:53 INFO - rmtree: /builds/slave/test-pgo/build 06:46:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:46:54 INFO - Running post-action listener: _resource_record_post_action 06:46:54 INFO - ##### 06:46:54 INFO - ##### Running read-buildbot-config step. 06:46:54 INFO - ##### 06:46:54 INFO - Running pre-action listener: _resource_record_pre_action 06:46:54 INFO - Running main action method: read_buildbot_config 06:46:54 INFO - Using buildbot properties: 06:46:54 INFO - { 06:46:54 INFO - "properties": { 06:46:54 INFO - "buildnumber": 559, 06:46:54 INFO - "product": "firefox", 06:46:54 INFO - "script_repo_revision": "production", 06:46:54 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:46:54 INFO - "repository": "", 06:46:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:46:54 INFO - "buildid": "20151123043004", 06:46:54 INFO - "slavename": "talos-linux64-ix-004", 06:46:54 INFO - "pgo_build": "True", 06:46:54 INFO - "basedir": "/builds/slave/test-pgo", 06:46:54 INFO - "project": "", 06:46:54 INFO - "platform": "ubuntu64_hw", 06:46:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:46:54 INFO - "slavebuilddir": "test", 06:46:54 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:46:54 INFO - "branch": "mozilla-inbound", 06:46:54 INFO - "repo_path": "integration/mozilla-inbound", 06:46:54 INFO - "stage_platform": "linux64-pgo", 06:46:54 INFO - "builduid": "72cd1c31b1d6414ca7a21bcbfac58212", 06:46:54 INFO - "revision": "b9b6a1567ef6b27735e19b661e895753db58e902" 06:46:54 INFO - }, 06:46:54 INFO - "sourcestamp": { 06:46:54 INFO - "repository": "", 06:46:54 INFO - "hasPatch": false, 06:46:54 INFO - "project": "", 06:46:54 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 06:46:54 INFO - "changes": [ 06:46:54 INFO - { 06:46:54 INFO - "category": null, 06:46:54 INFO - "files": [ 06:46:54 INFO - { 06:46:54 INFO - "url": null, 06:46:54 INFO - "name": "https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:46:54 INFO - } 06:46:54 INFO - ], 06:46:54 INFO - "repository": "", 06:46:54 INFO - "rev": "b9b6a1567ef6b27735e19b661e895753db58e902", 06:46:54 INFO - "who": "sendchange", 06:46:54 INFO - "when": 1448289918, 06:46:54 INFO - "number": 6695037, 06:46:54 INFO - "comments": "", 06:46:54 INFO - "project": "", 06:46:54 INFO - "at": "Mon 23 Nov 2015 06:45:18", 06:46:54 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 06:46:54 INFO - "revlink": "", 06:46:54 INFO - "properties": [ 06:46:54 INFO - [ 06:46:54 INFO - "buildid", 06:46:54 INFO - "20151123043004", 06:46:54 INFO - "Change" 06:46:54 INFO - ], 06:46:54 INFO - [ 06:46:54 INFO - "builduid", 06:46:54 INFO - "72cd1c31b1d6414ca7a21bcbfac58212", 06:46:54 INFO - "Change" 06:46:54 INFO - ], 06:46:54 INFO - [ 06:46:54 INFO - "pgo_build", 06:46:54 INFO - "True", 06:46:54 INFO - "Change" 06:46:54 INFO - ] 06:46:54 INFO - ], 06:46:54 INFO - "revision": "b9b6a1567ef6b27735e19b661e895753db58e902" 06:46:54 INFO - } 06:46:54 INFO - ], 06:46:54 INFO - "revision": "b9b6a1567ef6b27735e19b661e895753db58e902" 06:46:54 INFO - } 06:46:54 INFO - } 06:46:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:46:54 INFO - Running post-action listener: _resource_record_post_action 06:46:54 INFO - ##### 06:46:54 INFO - ##### Running download-and-extract step. 06:46:54 INFO - ##### 06:46:54 INFO - Running pre-action listener: _resource_record_pre_action 06:46:54 INFO - Running main action method: download_and_extract 06:46:54 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:46:54 INFO - https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/test_packages.json 06:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/test_packages.json 06:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:46:57 INFO - Downloaded 1302 bytes. 06:46:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:46:57 INFO - Using the following test package requirements: 06:46:57 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:46:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'jsshell-linux-x86_64.zip'], 06:46:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:46:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:46:57 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:46:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:46:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:46:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:46: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')]} 06:46:57 INFO - https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:00 INFO - Downloaded 22525614 bytes. 06:47:00 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 06:47:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:00 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 06:47:01 INFO - Return code: 0 06:47:01 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 06:47: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')]} 06:47:01 INFO - https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:07 INFO - Downloaded 22525614 bytes. 06:47:07 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 06:47:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:07 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 06:47:08 INFO - Return code: 0 06:47:08 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')]} 06:47:08 INFO - https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:10 INFO - Downloaded 11130997 bytes. 06:47:10 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 06:47:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:10 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 06:47:10 INFO - Return code: 0 06:47: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')]} 06:47:10 INFO - https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:47:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WdWDprL5QV2RJs1ZFIdh4A/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 06:47:12 INFO - Downloaded 57548813 bytes. 06:47:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:12 INFO - mkdir: /builds/slave/test-pgo/properties 06:47:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:47:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:47:12 INFO - Contents: 06:47:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:12 INFO - Running post-action listener: _resource_record_post_action 06:47:12 INFO - Running post-action listener: set_extra_try_arguments 06:47:12 INFO - ##### 06:47:12 INFO - ##### Running populate-webroot step. 06:47:12 INFO - ##### 06:47:12 INFO - Running pre-action listener: _resource_record_pre_action 06:47:12 INFO - Running main action method: populate_webroot 06:47:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:47:12 INFO - '../fennec_ids.txt'], 06:47:12 INFO - 'tests': ['tcheck2']}, 06:47:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:12 INFO - '--tppagecycles', 06:47:12 INFO - '7'], 06:47:12 INFO - 'tests': ['tsvgm']}}, 06:47:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:47:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:47:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:47:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'tests': ['damp', 'tps']}, 06:47:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['damp', 'tps']}, 06:47:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:47:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:12 INFO - 'other': {'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'other_l64': {'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'other_nol64': {'tests': ['a11yr', 06:47:12 INFO - 'ts_paint', 06:47:12 INFO - 'tpaint', 06:47:12 INFO - 'sessionrestore', 06:47:12 INFO - 'sessionrestore_no_auto_restore']}, 06:47:12 INFO - 'svgr': {'tests': ['tsvgx', 06:47:12 INFO - 'tsvgr_opacity', 06:47:12 INFO - 'tart', 06:47:12 INFO - 'tscrollx', 06:47:12 INFO - 'cart']}, 06:47:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['tsvgx', 06:47:12 INFO - 'tsvgr_opacity', 06:47:12 INFO - 'tart', 06:47:12 INFO - 'tscrollx', 06:47:12 INFO - 'cart']}, 06:47:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'tests': ['tp5o']}, 06:47:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'talos_options': ['--e10s'], 06:47:12 INFO - 'tests': ['tp5o']}, 06:47:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'talos_options': ['--xperf_path', 06:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:12 INFO - 'tests': ['tp5n']}, 06:47:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:12 INFO - 'talos_options': ['--e10s', 06:47:12 INFO - '--xperf_path', 06:47:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:12 INFO - 'tests': ['tp5n']}}, 06:47:12 INFO - 'talos.zip': {'path': '', 06:47:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:12 INFO - Running post-action listener: _resource_record_post_action 06:47:12 INFO - ##### 06:47:12 INFO - ##### Running create-virtualenv step. 06:47:12 INFO - ##### 06:47:12 INFO - Running pre-action listener: _resource_record_pre_action 06:47:12 INFO - Running main action method: create_virtualenv 06:47:12 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:47:12 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 06:47:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:47:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:12 INFO - Using real prefix '/usr' 06:47:12 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:47:13 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:15 INFO - Installing pip.................done. 06:47:15 INFO - Return code: 0 06:47:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:47:15 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')]} 06:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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')]} 06:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:15 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 06:47:15 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 06:47:15 INFO - Using env: {'DISPLAY': ':0', 06:47:15 INFO - 'HOME': '/home/cltbld', 06:47:15 INFO - 'LANG': 'en_US.UTF-8', 06:47:15 INFO - 'LANGUAGE': 'en_US:en', 06:47:15 INFO - 'LOGNAME': 'cltbld', 06:47:15 INFO - 'MAIL': '/var/mail/cltbld', 06:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:15 INFO - 'MOZ_NO_REMOTE': '1', 06:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:15 INFO - 'NO_EM_RESTART': '1', 06:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:15 INFO - 'SHELL': '/bin/bash', 06:47:15 INFO - 'SHLVL': '1', 06:47:15 INFO - 'TERM': 'linux', 06:47:15 INFO - 'TMOUT': '86400', 06:47:15 INFO - 'USER': 'cltbld', 06:47:15 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:15 INFO - '_': '/tools/buildbot/bin/python'} 06:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:15 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 06:47:15 INFO - Cleaning up... 06:47:15 INFO - Return code: 0 06:47:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:47:15 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')]} 06:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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')]} 06:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:15 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:15 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 06:47:15 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 06:47:15 INFO - Using env: {'DISPLAY': ':0', 06:47:15 INFO - 'HOME': '/home/cltbld', 06:47:15 INFO - 'LANG': 'en_US.UTF-8', 06:47:15 INFO - 'LANGUAGE': 'en_US:en', 06:47:15 INFO - 'LOGNAME': 'cltbld', 06:47:15 INFO - 'MAIL': '/var/mail/cltbld', 06:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:15 INFO - 'MOZ_NO_REMOTE': '1', 06:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:15 INFO - 'NO_EM_RESTART': '1', 06:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:15 INFO - 'SHELL': '/bin/bash', 06:47:15 INFO - 'SHLVL': '1', 06:47:15 INFO - 'TERM': 'linux', 06:47:15 INFO - 'TMOUT': '86400', 06:47:15 INFO - 'USER': 'cltbld', 06:47:15 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:15 INFO - '_': '/tools/buildbot/bin/python'} 06:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:15 INFO - Downloading/unpacking psutil>=0.7.1 06:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:17 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:47:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:47:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:17 INFO - Installing collected packages: psutil 06:47:17 INFO - Running setup.py install for psutil 06:47:17 INFO - building 'psutil._psutil_linux' extension 06:47:17 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 06:47:17 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 06:47:17 INFO - building 'psutil._psutil_posix' extension 06:47:17 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 06:47:17 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 06:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:17 INFO - Successfully installed psutil 06:47:17 INFO - Cleaning up... 06:47:17 INFO - Return code: 0 06:47:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:17 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:17 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 06:47:17 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 06:47:17 INFO - Using env: {'DISPLAY': ':0', 06:47:17 INFO - 'HOME': '/home/cltbld', 06:47:17 INFO - 'LANG': 'en_US.UTF-8', 06:47:17 INFO - 'LANGUAGE': 'en_US:en', 06:47:17 INFO - 'LOGNAME': 'cltbld', 06:47:17 INFO - 'MAIL': '/var/mail/cltbld', 06:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:17 INFO - 'MOZ_NO_REMOTE': '1', 06:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:17 INFO - 'NO_EM_RESTART': '1', 06:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:17 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:17 INFO - 'SHELL': '/bin/bash', 06:47:17 INFO - 'SHLVL': '1', 06:47:17 INFO - 'TERM': 'linux', 06:47:17 INFO - 'TMOUT': '86400', 06:47:17 INFO - 'USER': 'cltbld', 06:47:17 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:17 INFO - '_': '/tools/buildbot/bin/python'} 06:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:47:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:47:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:47:19 INFO - Installing collected packages: mozsystemmonitor 06:47:19 INFO - Running setup.py install for mozsystemmonitor 06:47:19 INFO - Successfully installed mozsystemmonitor 06:47:19 INFO - Cleaning up... 06:47:20 INFO - Return code: 0 06:47:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:20 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:20 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 06:47:20 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 06:47:20 INFO - Using env: {'DISPLAY': ':0', 06:47:20 INFO - 'HOME': '/home/cltbld', 06:47:20 INFO - 'LANG': 'en_US.UTF-8', 06:47:20 INFO - 'LANGUAGE': 'en_US:en', 06:47:20 INFO - 'LOGNAME': 'cltbld', 06:47:20 INFO - 'MAIL': '/var/mail/cltbld', 06:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:20 INFO - 'MOZ_NO_REMOTE': '1', 06:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:20 INFO - 'NO_EM_RESTART': '1', 06:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:20 INFO - 'SHELL': '/bin/bash', 06:47:20 INFO - 'SHLVL': '1', 06:47:20 INFO - 'TERM': 'linux', 06:47:20 INFO - 'TMOUT': '86400', 06:47:20 INFO - 'USER': 'cltbld', 06:47:20 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:20 INFO - '_': '/tools/buildbot/bin/python'} 06:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:20 INFO - Downloading/unpacking blobuploader==1.2.4 06:47:20 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 06:47:20 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 06:47:20 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 06:47:20 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 06:47:20 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 06:47:20 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 06:47:21 INFO - Downloading blobuploader-1.2.4.tar.gz 06:47:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:47:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:47:21 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 06:47:21 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 06:47:21 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 06:47:21 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 06:47:21 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 06:47:21 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 06:47:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:47:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:47:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 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 06:47:22 INFO - Downloading docopt-0.6.1.tar.gz 06:47:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:47:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:47:22 INFO - Installing collected packages: blobuploader, requests, docopt 06:47:22 INFO - Running setup.py install for blobuploader 06:47:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:47:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:47:22 INFO - Running setup.py install for requests 06:47:23 INFO - Running setup.py install for docopt 06:47:23 INFO - Successfully installed blobuploader requests docopt 06:47:23 INFO - Cleaning up... 06:47:23 INFO - Return code: 0 06:47:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:47: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')]} 06:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47: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')]} 06:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:23 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:23 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 06:47:23 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 06:47:23 INFO - Using env: {'DISPLAY': ':0', 06:47:23 INFO - 'HOME': '/home/cltbld', 06:47:23 INFO - 'LANG': 'en_US.UTF-8', 06:47:23 INFO - 'LANGUAGE': 'en_US:en', 06:47:23 INFO - 'LOGNAME': 'cltbld', 06:47:23 INFO - 'MAIL': '/var/mail/cltbld', 06:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:23 INFO - 'MOZ_NO_REMOTE': '1', 06:47:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:23 INFO - 'NO_EM_RESTART': '1', 06:47:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:23 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:23 INFO - 'SHELL': '/bin/bash', 06:47:23 INFO - 'SHLVL': '1', 06:47:23 INFO - 'TERM': 'linux', 06:47:23 INFO - 'TMOUT': '86400', 06:47:23 INFO - 'USER': 'cltbld', 06:47:23 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:23 INFO - '_': '/tools/buildbot/bin/python'} 06:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:47:23 INFO - Running setup.py (path:/tmp/pip-za3QPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:47:23 INFO - Running setup.py (path:/tmp/pip-Fkcwhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:47:23 INFO - Running setup.py (path:/tmp/pip-sVzi5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:47:23 INFO - Running setup.py (path:/tmp/pip-WVHVOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:47:23 INFO - Running setup.py (path:/tmp/pip-hbuVQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:47:23 INFO - Running setup.py (path:/tmp/pip-XPFfrj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:47:23 INFO - Running setup.py (path:/tmp/pip-e63LIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:47:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:47:23 INFO - Running setup.py (path:/tmp/pip-w1ryzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:47:24 INFO - Running setup.py (path:/tmp/pip-q5SkMp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:47:24 INFO - Running setup.py (path:/tmp/pip-sZCMUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:47:24 INFO - Running setup.py (path:/tmp/pip-2iDbqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:47:24 INFO - Running setup.py (path:/tmp/pip-fgd9tR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:47:24 INFO - Running setup.py (path:/tmp/pip-vVIVs5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:47:24 INFO - Running setup.py (path:/tmp/pip-Wapxg0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:47:24 INFO - Running setup.py (path:/tmp/pip-wnrrom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:47:24 INFO - Running setup.py (path:/tmp/pip-OBcfrQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:47:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:47:24 INFO - Running setup.py (path:/tmp/pip-h_6XWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:47:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:47:24 INFO - Running setup.py install for manifestparser 06:47:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:47:24 INFO - Running setup.py install for mozcrash 06:47:24 INFO - Running setup.py install for mozdebug 06:47:24 INFO - Running setup.py install for mozdevice 06:47:25 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for mozfile 06:47:25 INFO - Running setup.py install for mozhttpd 06:47:25 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for mozinfo 06:47:25 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for mozInstall 06:47:25 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for mozleak 06:47:25 INFO - Running setup.py install for mozlog 06:47:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for moznetwork 06:47:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:47:25 INFO - Running setup.py install for mozprocess 06:47:25 INFO - Running setup.py install for mozprofile 06:47:26 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:47:26 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:47:26 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:47:26 INFO - Running setup.py install for mozrunner 06:47:26 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:47:26 INFO - Running setup.py install for mozscreenshot 06:47:26 INFO - Running setup.py install for moztest 06:47:26 INFO - Running setup.py install for mozversion 06:47:26 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:47:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:47:26 INFO - Cleaning up... 06:47:26 INFO - Return code: 0 06:47:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:47:26 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')]} 06:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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')]} 06:47:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:26 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:26 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 06:47:26 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 06:47:26 INFO - Using env: {'DISPLAY': ':0', 06:47:26 INFO - 'HOME': '/home/cltbld', 06:47:26 INFO - 'LANG': 'en_US.UTF-8', 06:47:26 INFO - 'LANGUAGE': 'en_US:en', 06:47:26 INFO - 'LOGNAME': 'cltbld', 06:47:26 INFO - 'MAIL': '/var/mail/cltbld', 06:47:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:26 INFO - 'MOZ_NO_REMOTE': '1', 06:47:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:26 INFO - 'NO_EM_RESTART': '1', 06:47:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:26 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:26 INFO - 'SHELL': '/bin/bash', 06:47:26 INFO - 'SHLVL': '1', 06:47:26 INFO - 'TERM': 'linux', 06:47:26 INFO - 'TMOUT': '86400', 06:47:26 INFO - 'USER': 'cltbld', 06:47:26 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:26 INFO - '_': '/tools/buildbot/bin/python'} 06:47:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:47:26 INFO - Running setup.py (path:/tmp/pip-cvobVN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:47:26 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)) 06:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:47:26 INFO - Running setup.py (path:/tmp/pip-7PKJnp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:47:26 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)) 06:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:47:26 INFO - Running setup.py (path:/tmp/pip-cRDc48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:47:26 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)) 06:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:47:26 INFO - Running setup.py (path:/tmp/pip-fnM_Ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:47:26 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)) 06:47:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:47:26 INFO - Running setup.py (path:/tmp/pip-3bzQ2X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:47:27 INFO - Running setup.py (path:/tmp/pip-lnMzCZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:47:27 INFO - Running setup.py (path:/tmp/pip-GwUi_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:47:27 INFO - Running setup.py (path:/tmp/pip-tFJKnd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:47:27 INFO - Running setup.py (path:/tmp/pip-k5V_Bk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:47:27 INFO - Running setup.py (path:/tmp/pip-61JSmM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:47:27 INFO - Running setup.py (path:/tmp/pip-RAD2bb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:47:27 INFO - Running setup.py (path:/tmp/pip-ZbFxSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:47:27 INFO - Running setup.py (path:/tmp/pip-JrtN0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:47:27 INFO - Running setup.py (path:/tmp/pip-bJSQJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:47:27 INFO - Running setup.py (path:/tmp/pip-GOBvVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:47:27 INFO - Running setup.py (path:/tmp/pip-4nwqKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:47:27 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)) 06:47:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:47:27 INFO - Running setup.py (path:/tmp/pip-9mAzMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:47:27 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)) 06:47:27 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)) 06:47:27 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)) 06:47:27 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)) 06:47:27 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)) 06:47:27 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)) 06:47:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:47:27 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 06:47:27 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 06:47:27 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 06:47:27 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 06:47:27 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 06:47:27 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 06:47:29 INFO - Downloading blessings-1.5.1.tar.gz 06:47:29 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 06:47:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:47:29 INFO - Installing collected packages: blessings 06:47:29 INFO - Running setup.py install for blessings 06:47:29 INFO - Successfully installed blessings 06:47:29 INFO - Cleaning up... 06:47:29 INFO - Return code: 0 06:47:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:47:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:47:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:47:30 INFO - Reading from file tmpfile_stdout 06:47:30 INFO - Current package versions: 06:47:30 INFO - argparse == 1.2.1 06:47:30 INFO - blessings == 1.5.1 06:47:30 INFO - blobuploader == 1.2.4 06:47:30 INFO - docopt == 0.6.1 06:47:30 INFO - manifestparser == 1.1 06:47:30 INFO - mozInstall == 1.12 06:47:30 INFO - mozcrash == 0.16 06:47:30 INFO - mozdebug == 0.1 06:47:30 INFO - mozdevice == 0.47 06:47:30 INFO - mozfile == 1.2 06:47:30 INFO - mozhttpd == 0.7 06:47:30 INFO - mozinfo == 0.9 06:47:30 INFO - mozleak == 0.1 06:47:30 INFO - mozlog == 3.1 06:47:30 INFO - moznetwork == 0.27 06:47:30 INFO - mozprocess == 0.22 06:47:30 INFO - mozprofile == 0.27 06:47:30 INFO - mozrunner == 6.11 06:47:30 INFO - mozscreenshot == 0.1 06:47:30 INFO - mozsystemmonitor == 0.0 06:47:30 INFO - moztest == 0.7 06:47:30 INFO - mozversion == 1.4 06:47:30 INFO - psutil == 3.1.1 06:47:30 INFO - requests == 1.2.3 06:47:30 INFO - wsgiref == 0.1.2 06:47:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:30 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 0x7f26986dec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bb6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166d7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', '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 06:47:30 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 06:47:30 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 06:47:30 INFO - Using env: {'DISPLAY': ':0', 06:47:30 INFO - 'HOME': '/home/cltbld', 06:47:30 INFO - 'LANG': 'en_US.UTF-8', 06:47:30 INFO - 'LANGUAGE': 'en_US:en', 06:47:30 INFO - 'LOGNAME': 'cltbld', 06:47:30 INFO - 'MAIL': '/var/mail/cltbld', 06:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:30 INFO - 'MOZ_NO_REMOTE': '1', 06:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:30 INFO - 'NO_EM_RESTART': '1', 06:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:30 INFO - 'SHELL': '/bin/bash', 06:47:30 INFO - 'SHLVL': '1', 06:47:30 INFO - 'TERM': 'linux', 06:47:30 INFO - 'TMOUT': '86400', 06:47:30 INFO - 'USER': 'cltbld', 06:47:30 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:30 INFO - '_': '/tools/buildbot/bin/python'} 06:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 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)) 06:47:30 INFO - Cleaning up... 06:47:30 INFO - Return code: 0 06:47:30 INFO - Running post-action listener: _resource_record_post_action 06:47:30 INFO - Running post-action listener: _start_resource_monitoring 06:47:30 INFO - Starting resource monitoring. 06:47:30 INFO - ##### 06:47:30 INFO - ##### Running install step. 06:47:30 INFO - ##### 06:47:30 INFO - Running pre-action listener: _resource_record_pre_action 06:47:30 INFO - Running main action method: install 06:47:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:47:30 INFO - Reading from file tmpfile_stdout 06:47:30 INFO - Detecting whether we're running mozinstall >=1.0... 06:47:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:47:30 INFO - Reading from file tmpfile_stdout 06:47:30 INFO - Output received: 06:47:30 INFO - Usage: mozinstall [options] installer 06:47:30 INFO - Options: 06:47:30 INFO - -h, --help show this help message and exit 06:47:30 INFO - -d DEST, --destination=DEST 06:47:30 INFO - Directory to install application into. [default: 06:47:30 INFO - "/builds/slave/test-pgo"] 06:47:30 INFO - --app=APP Application being installed. [default: firefox] 06:47:30 INFO - mkdir: /builds/slave/test-pgo/build/application 06:47:30 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'] 06:47:30 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 06:47:45 INFO - Reading from file tmpfile_stdout 06:47:45 INFO - Output received: 06:47:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:47:45 INFO - Running post-action listener: _resource_record_post_action 06:47:45 INFO - ##### 06:47:45 INFO - ##### Running run-tests step. 06:47:45 INFO - ##### 06:47:45 INFO - Running pre-action listener: _resource_record_pre_action 06:47:45 INFO - Running main action method: run_tests 06:47:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:47:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:47:45 INFO - Python 2.7.3 06:47:45 INFO - Return code: 0 06:47:45 INFO - grabbing minidump binary from tooltool 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 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 0x16b1d70>, '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 0x16b2b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b2fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:47:45 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 06:47:45 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 06:47:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:47:45 INFO - Return code: 0 06:47:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:47:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:47:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:47:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:47:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:47:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:47:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 06:47:45 INFO - Using env: {'DISPLAY': ':0', 06:47:45 INFO - 'HOME': '/home/cltbld', 06:47:45 INFO - 'LANG': 'en_US.UTF-8', 06:47:45 INFO - 'LANGUAGE': 'en_US:en', 06:47:45 INFO - 'LOGNAME': 'cltbld', 06:47:45 INFO - 'MAIL': '/var/mail/cltbld', 06:47:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:47:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:45 INFO - 'MOZ_NO_REMOTE': '1', 06:47:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:45 INFO - 'NO_EM_RESTART': '1', 06:47:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:47:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:47:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:47:45 INFO - 'SHELL': '/bin/bash', 06:47:45 INFO - 'SHLVL': '1', 06:47:45 INFO - 'TERM': 'linux', 06:47:45 INFO - 'TMOUT': '86400', 06:47:45 INFO - 'USER': 'cltbld', 06:47:45 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776', 06:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:45 INFO - '_': '/tools/buildbot/bin/python'} 06:47:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 06:47:45 INFO - mozversion INFO | application_buildid: 20151123043004 06:47:45 INFO - mozversion INFO | application_changeset: b9b6a1567ef6b27735e19b661e895753db58e902 06:47:45 INFO - mozversion INFO | application_display_name: Nightly 06:47:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:47:45 INFO - mozversion INFO | application_name: Firefox 06:47:45 INFO - mozversion INFO | application_remotingname: firefox 06:47:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:47:45 INFO - mozversion INFO | application_vendor: Mozilla 06:47:45 INFO - mozversion INFO | application_version: 45.0a1 06:47:45 INFO - mozversion INFO | platform_buildid: 20151123043004 06:47:45 INFO - mozversion INFO | platform_changeset: b9b6a1567ef6b27735e19b661e895753db58e902 06:47:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 06:47:45 INFO - mozversion INFO | platform_version: 45.0a1 06:47:45 INFO - 2015-11-23 06:47:45,300 DEBUG : using testdate: 1448290065 06:47:45 INFO - 2015-11-23 06:47:45,300 DEBUG : actual date: 1448290065 06:47:45 INFO - 2015-11-23 06:47:45,347 INFO : starting webserver on 'localhost:46450' 06:47:45 INFO - 2015-11-23 06:47:45,348 INFO : Starting test suite talos-linux64-ix-004 06:47:45 INFO - 2015-11-23 06:47:45,348 INFO : Starting test dromaeo_css 06:47:45 INFO - 2015-11-23 06:47:45,349 DEBUG : operating with platform_type : linux_ 06:47:45 INFO - 2015-11-23 06:47:45,349 INFO : Initialising browser for dromaeo_css test... 06:47:45 INFO - 2015-11-23 06:47:45,360 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmrLPZs/profile http://localhost:46450/getInfo.html 06:47:51 INFO - 2015-11-23 06:47:51,969 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:47:51 INFO - 2015-11-23 06:47:51,969 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:47:51 INFO - 2015-11-23 06:47:51,969 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:47:51 INFO - 2015-11-23 06:47:51,969 DEBUG : BROWSER_OUTPUT: __metrics 06:47:52 INFO - 2015-11-23 06:47:52,328 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:53 INFO - 2015-11-23 06:47:53,730 INFO : Browser initialized. 06:47:53 INFO - 2015-11-23 06:47:53,730 INFO : Running cycle 1/1 for dromaeo_css test... 06:47:53 INFO - 2015-11-23 06:47:53,730 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmrLPZs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:48:05 INFO - 2015-11-23 06:48:05,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 142262272 06:48:05 INFO - 2015-11-23 06:48:05,547 DEBUG : BROWSER_OUTPUT: 06:48:57 INFO - 2015-11-23 06:48:57,170 DEBUG : BROWSER_OUTPUT: 1448290137166 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] 06:51:06 INFO - 2015-11-23 06:51:06,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46450/tests/dromaeo/cssquery-ext.html) 06:51:07 INFO - 2015-11-23 06:51:07,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 278765568 06:51:07 INFO - 2015-11-23 06:51:07,312 DEBUG : BROWSER_OUTPUT: 06:54:09 INFO - 2015-11-23 06:54:09,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-ext.html (next: http://localhost:46450/tests/dromaeo/cssquery-jquery.html) 06:54:10 INFO - 2015-11-23 06:54:10,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 222568448 06:54:10 INFO - 2015-11-23 06:54:10,246 DEBUG : BROWSER_OUTPUT: 06:57:12 INFO - 2015-11-23 06:57:12,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46450/tests/dromaeo/cssquery-mootools.html) 06:57:12 INFO - 2015-11-23 06:57:12,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 214663168 06:57:12 INFO - 2015-11-23 06:57:12,628 DEBUG : BROWSER_OUTPUT: 07:00:14 INFO - 2015-11-23 07:00:14,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46450/tests/dromaeo/cssquery-prototype.html) 07:00:15 INFO - 2015-11-23 07:00:15,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 201048064 07:00:15 INFO - 2015-11-23 07:00:15,098 DEBUG : BROWSER_OUTPUT: 07:03:17 INFO - 2015-11-23 07:03:17,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46450/tests/dromaeo/cssquery-yui.html) 07:03:18 INFO - 2015-11-23 07:03:18,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 206348288 07:03:18 INFO - 2015-11-23 07:03:18,103 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/dromaeo/cssquery-yui.html (next: http://localhost:46450/tests/dromaeo/cssquery-dojo.html) 07:06:20 INFO - 2015-11-23 07:06:20,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 248238080 07:06:20 INFO - 2015-11-23 07:06:20,949 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,949 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:06:20 INFO - 2015-11-23 07:06:20,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:06:20 INFO - 2015-11-23 07:06:20,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:06:20 INFO - 2015-11-23 07:06:20,950 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:06:20 INFO - 2015-11-23 07:06:20,950 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3199.2641692410743;3257.609086909571;3304.140923359927;3306.48749443836;3335.066181469189;5217.426083130853;5385.434529374408;5476.096444086721;5491.88822896321;5499.340079190492;5387.19192121181;5432.293801805759;5447.1829225616175;5473.644213126144;5549.19536667184;4959.975200123994;5032.295478632976;5039.77321020555;5067.062593420211;5084.211947148198;4897.657163998521;5094.923576146361;5100.107481190796;5136.614753893455;5183.714895680736;4924.901501969958;4997.600191984632;5005.0990821652085;5013.548780609763;5021.774020169101;4995.425526064513;5005.074061298671;5005.9988002399305;5009.974950125263;5055;4897.142999975025;4991.575716064139;5007.649464537484;5011.599072074226;5015.3229314042865;5246.396664383607;5291.021161085211;5307.840764777063;5309.761060752276;5341.519263266286;5965.4631083202285;5966.3138739045135;5972.850678733023;5972.910406343908;5977.402259774031;5781.392953739881;5895.263092113486;5985.910211346833;5992.2809262888295;6000.399960004008;5498.257735205736;5551.1673249012165;5551.8889622208135;5553.8333849984165;5609.411011843779;6104.11490333908;6121.418465245794;6131.938969993885;6143.692815359214;6150.7232174552255;5682.659040457585;5744.798932037359;5797.507211887037;5940.31686356066;5979.940200597938;5891.528677705774;5900.43945825146;5957.702114894238;5965.045592705146;6021.458068773832;5905.852353691193;5906.852328691731;5914.290285165807;5916.112583112482;5940.762369505258;5744.569157313218;5834.708264586754;5851.414858514115;5892.909811684852;5905.645661260338;4522.118186953512;4552.772361381918;4586.128635559233;4594.035252596926;4603.125406172817;4049.0687141957515;4055.5741647127215;4067.7152599318356;4094.4267802507675;4111.8560850370095;5472.699001554953;5588.832335029874;5647.209390685307;5652.067408877571;5658.094704847204;5876.44173803488;5900.144479050514;5907.586468947133;5959.731812068468;6013.398660133952;5565.749541270652;5730;5759.798407055817;5764.308283006066;5766.625169363978;5047.924281135713;5244.737763111829;5248.186531087687;5248.895022099537;5252.632315737862;6041.6375017499095;6062.757489700362;6113.445692323776;6123.925419229976;6125.856697819315;5991.370906054802;5992.970035149797;5996.940030599638;6009.969950150221;6028.819135425944;5979.551533635082;6026.578139530191;6064.514838812796;6066.969665151646;6098.11577321277;5776.018076927016;5787.045137552257;5803.535717142534;5842.269716285465;5895.823125306248;5993.340732519332;5997.280326360865;6002.819915402545;6005.729742161526;6006.549508786771;5640.097584386478;5761.740721667451;5854.648721076749;5855.414458554111;5861.472467477947;5700.629459085146;5775.9133612995;5851.795187168429;5860.413958604106;5890.4993075589055;5724;5736.19693242938;5743.167240750151;5743.167240750151;5745.253117094751;5597.160425936142;5790.536757059341;5832.416758324133;5854;5893.263342082239;5720.199172115824;5807.680577568274;5814.127880817911;5814.709264536672;5844.298684157929 07:06:20 INFO - 2015-11-23 07:06:20,950 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.8611190258388;574.767219276193;602.4728362682653;608.106084056437;631.5926227583209;31764.364712705734;40007.59992400075;40221.59778402215;40246.39630405546;40299.194016119734;42894.78552607232;43563.564364356345;43601;43620.563794362046;43638.34542481865;7788.299053085221;7881.566513841736;8826.338024648145;9023.097690230958;10312.432816195107;10445;10447.216458765584;10552.630657926975;10554.472276386188;10555.366677999305;10409.635662751805;10446.320989135682;10480.633177838778;10496.527656255486;10508.316959397614;7950.1254861965135;8094.919050809505;10675.35947843124;10884.768622432382;10900;10424.166066714644;10532.42071686057;10537;10541.314814537107;10562.313449625826;40368.39447408291;40871.38692919609;40880;40886;40955.180896382204;3342.134519177337;3351.078453425303;3388.796672199676;3486.3724529584665;3785.5268091488565;30345;30488;30676.079717608507;30733.846330768425;30905.690943090733;3849.6727778138893;3928.666063384616;3984.4820173377275;4083.3670781028986;4088.1823635273063;291931;292001;292326;293578.53210734023;293864;55677;56848.715756420956;59471;59726.104108438405;59791.103133453034;67104;68183.31816681869;68427.65786171037;68455;68492;15900.76148857768;16014.359425623077;16184.433544825875;16187.595310117342;16188.109653969144;12167;12175.330356830282;12184.928562144456;12187.75624487523;12207.450664720109;18891.90554047221;19045.61908761817;19303.131359088875;19518.96761821065;19536.413907582795;7796.259355361231;8021.959890200512;8055.758327250074;8128.918710812816;8159.755207343789;925.5464822237055;938.2728385501291;999.7050869993369;1039.9636012739518;1068.3056013591229;25724.614130788053;27695.61790121305;27799.58300625492;28051.158465246077;28066.71933280682;1034.9249754242846;1066.2536224642781;1102.7684186320803;1103.4648195625116;1132.1282612388416;15118.773218401733;15414.614634634223;16089.839101608834;16151.434699785452;16179.672052567617;323204;330004;330098;330573;330788;52491.737541312046;52615.73692131515;52816.471835281154;52827.47172528225;52830.73584632129;1369.513822592985;1378.5864240727742;1387.947194192959;1389.3678376338944;1398.1541167593664;27799.44401111926;28643;28836.279093022844;29026.564601530572;29054.854725726236;43102.78448607737;45909.31136032895;46195.53804461913;46252.53747462482;46317;259884;295846;299618;301048;301826;31753.8412307937;32288.192795180308;32408.513872292406;32412.513812293306;32436.837815811716;42512.78743606262;42989.78505107454;43048.139037218454;43335.783321083196;43879.34180987224;35966;36126.458103129;36334.63665363418;36453;37559;35986.82994339362;36663;36675.816620916725;36902.446463302535;36952.630473695994;35755.642443576275;36141.819290903375;36195.45706814347;36903.81548092242;36946;29486.410271794015;30575.694243057285;32784.915105255845;32852.835735821165;32929.835350823094;25139.497210056063;25169.370765731004;25170.62244066377;25260.74739252584;25455.490890182464 07:06:20 INFO - 2015-11-23 07:06:20,951 DEBUG : BROWSER_OUTPUT: |2;jquery.html;359.89203239028285;363.7690066807576;364.1079355578832;365.4499977533811;366.3899607154088;14497;14824.332905019273;16564.088975106366;18236.45290641281;19443.902780486096;16860.494185174466;16928.576785580335;17192.484225473258;18173.636527269446;18300.725489117674;5288.153895376731;5427.267318911956;5430.13117901134;5432.483914028181;5434.864128396782;3982.721209515335;4068.7965601719798;5382.165764306539;5796.710164491779;6033.969830150843;5919.644821310713;5929.258842644669;5951.851203719898;5976.402359764033;5976.432238937294;5766.654000759947;5874.353821079678;5903.173555702184;5916.230889984275;5921.052631578927;5200.167973124282;5201.349831271091;5211.869703257411;5214.426413094557;5223.843284701465;12239.816402753966;12455.501779928793;12582.937085314607;12599.685007874876;21181;1991.6912878503856;2035.4097311779567;2079.376187143866;2099.286242677497;2112.640851055324;9561.808763824685;9623.663171789023;9629.181519570844;9847.359921605144;9853.359531630493;1722.3024675006643;1754.859611231111;1812.5106221320302;1900.2019151956074;1942.5435022769639;61951.38048619501;63514.07695667714;65731.67134164346;66405;66539.00191497082;10226.948865255627;10234.283600147919;10276.177905767521;10284.228682848667;10312.175025997902;13492.055556111174;13498.32508374597;13518.797218041736;13521.661958451117;13534.052616316763;7510.624468776539;7601.7719468416035;7627.161012288644;7699.923000770033;7857.05715314166;7222.695629207678;7397.149327827261;7430.517016393917;7516.699332026657;7672.693092276358;4392.077663690597;4405.581469760367;4408;4408.236705317834;4430.025394413224;1709.4700642800772;1749;1765.6027393836541;1802.2971041293645;1834.0737927346604;902.3503077783985;939.7086903059936;989.9257555683353;991.633095754561;995.5171741705267;14404.279786010658;16378.50864474044;16826.326946922232;17260.74108888368;17811;956.1920177450044;968.2060710217695;987.6839411388287;988.3279370028449;1011.9747006324753;9514.28642851789;9698.75753106178;9719.17387022111;9734.805303894023;9805.460699661444;540032;547080;549626;552731;553795;74064.25935740682;79471.60264198642;81995;82049.58975205086;82896.58551707203;1194.6893807610084;1195.9880401195876;1220.0544577952157;1239.3121817391434;1257.7798885195054;15036.248187590358;15641.53075407694;16290.674186515966;16326.836731632531;16378.508644740677;34719.82640086783;34795.65204348025;34815.82592087024;34865.30269394547;35182;47860.760696196296;48403.75798120987;48754.75622621864;50080.24879626882;51805.481945180065;9374.625014999323;9434.24526037929;9523.761905952406;9546.809063818824;9754.9024509754;17633.20650570753;17867.910660446614;18179.45461636153;18440.262389504805;18558.907205463885;14294.857051429353;14687.412503500167;14814.333354999266;14899.106053636817;15443.536693899201;9700.175485083846;13358.265295408457;14358.138511689333;14687.485937992546;15125.016873903161;11626.476808543466;14428.783568246694;14854.405823766929;15055.096694198382;15164.545063648107;9026.684066057656;9305;9396.342256042011;9698;9707.077827606367;10428.791424171626;10490;13615;14664.266786660412;15420.768688469458 07:06:20 INFO - 2015-11-23 07:06:20,951 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1363.4886917405972;1711.152979275259;1785.0450009245058;1791.176059012854;1817.8363947244745;6502.284748677647;7502.549847009176;7860.410469214818;7864.6460909259;7866.92133078669;7673.961630191855;7836.373090152789;7841.137474877759;7848.058233012032;7848.882266766003;1988.9005549722528;2026.3616960657419;2213.4245096275004;2255.5376147889683;2305.3890718959406;2300.1029598456616;2304.1129165271323;2304.4584522637165;2304.9654255186188;2307;2140.283005193262;2218.201447478906;2220.989449800345;2222.8332875034357;2223.2329846203033;1877.4367689693106;1911.560341121543;2120.67129594913;2152.074607918594;2157.223399576151;2293.5756884976167;2297.3797074789713;2332.498512819735;2334.393057804983;2349.1543044503965;7728.26581474759;7768.495047821873;7774.65014074368;7776.533407995538;7788.260115289038;4736.83421080264;4809.5430934061205;4826.879328016793;4827.300041493963;4835.854924352275;2969.524876019848;2973.4796410628055;3005.1885990782584;3023.8639261233297;3095.659477457478;934.2012579244716;939.5255396025032;944.650479322655;963.1476143612883;963.9903600963971;10754.623588174454;10769.676909692722;10772.515236814363;10775.191860610486;10779.999999999922;4248;4273;4286.07823841188;4350.717203381833;4402.405675233803;9132.3150763693;9132.543372831331;9141.954290228507;9142.177204051668;9151.130642588943;4703.7883295251795;4717.268823332389;4717.858464246078;4722.622190224843;4723.551262630044;4193.18232944579;4194;4194.6853985951175;4231.851885184004;4236.428082208924;3679.2641471705765;3689.7417180797624;3734.1224812169116;3774.830132644038;3776.66010059096;1183.9526418943146;1198.1193822540426;1203.9939800300942;1215.380156120385;1223.4311045363947;929.9953500232456;1303.817465554823;1310.744404841066;1323.4573824731813;1336.0647546717337;6396.584222025646;7467.327940485382;7530.6611202496015;7622.428317876071;7633.847323053508;596.2904144068544;597.7877853362081;599.7990673124552;612.650789050246;621.8787336469436;5748.942510574924;5800.187973683687;5852.619579727304;5862.765489380377;5867.9413205867395;9245.075492450836;9413.717588472357;9517;9518.571664275125;9522.047795220422;9101.362904596746;9346.15884570392;9353.345265831462;9362;9366.578503967337;7194.136703595497;7266.854662906712;7277.163126240444;7279.563226206445;7282.745103921443;6893.448524118159;7063.328983746535;7070.964645176741;7077.044598979072;7085.362317391459;8147;8183.672653094048;8208.917910821054;8404.579771011548;8417.326613870999;8378.53918034514;8550.700725474579;8551.187637174458;8551.187637174458;8575.442596231225;6684.632345220865;6730.899036514358;6733.124693789776;6739.629320387426;6741.52809303344;7276;7281.05346304977;7283.344498995116;7299.671514781954;7350.044494215717;6953.895691564529;6966.721331146698;7090.290970902868;7135.785926422215;7167.7132914682825;6823.624700641512;6904.792856214322;6972.860542789217;7009.719611215494;7116.964415177891;6150.446459818638;6295.276043255084;7066.929330706627;7070.929290707027;7077.5753454792875;6337.176167098248;6455.67721613908;6468.611883287018;6483.578567393104;6484.221893372825;6431.549791514736;6458.838529036624;6461.224653041665;6467.514936379885;6486.610803351814 07:06:20 INFO - 2015-11-23 07:06:20,953 DEBUG : BROWSER_OUTPUT: |4;prototype.html;339.84027507071676;341.7129611126653;347.591579893625;350.3448551209239;351.5113991551745;5912.704364781765;5915.438033386827;5976.402359764033;5978.910316345253;5986.580939334238;5616.101423772197;5731.942680573193;5778.0466223073245;5897.616654917428;5897.823065308037;4595.356650068993;4610.838620648278;4615.353850460921;4628.490866004737;4633.930491042629;4605.332226827108;4611.3544103825325;4612.354270402129;4618.792154353062;4625.676202665814;4365.148795984785;4430.246858034126;4438.977805110986;4448.110377924428;4449.688521803475;4444.97777511112;4503.1218912312115;4511.458624964992;4512.1878061949;4513.458384993789;3960.683145348365;3973.562908080109;3989.7007724420496;3990.620891015349;3998.800059997018;5568.749406276727;5572.136318870582;5614.242077319591;5619.662820230758;5624.29696287964;5192.844214673566;5266.34170728659;5285.524302812765;5312.3890752563175;5327.254184414185;6295.0872123542285;6313.053042043684;6314.210723659543;6318.399752023551;6319.715612797435;4424.269995450747;4424.491183513873;4431.756253406062;4433.645308375322;4434.157510073108;6390.712417941158;6574.2110946686225;6574.408303252682;6578.243501997236;6579.736810527621;4473.6868419211;4506.301523263899;4508.639308855284;4510.954890451119;4512.029913568533;4534.2745160774775;4561.178987782165;4565.360849481075;4566.292224705176;4567.908641827211;5275.498827611371;5288.7091209983055;5290.153575427913;5290.1800220965815;5293.338332708411;6168.9691551541955;6374.043893416025;6376.139221205078;6380.585261957958;6383.840403989938;1586.7778511008469;1608.6058915565761;1610.1868556378954;1611.6615510742874;1612.3550579767953;1028.783955369381;1030.2685093583489;1032.9896701032894;1046.2676126711333;1072.4423299884018;6152.569320147547;6166.876662466726;6172.783952561728;6173.166622505994;6176.197094377702;6513.348665133543;6521.0544471051435;6527.8694426111215;6530.216374035052;6536.738530458729;6008.579399442085;6091.969540152271;6095.8476038098515;6102.05418160177;6237.656928868865;3528.4530897710897;3538.3100295442655;3554.306910152495;3554.360215161244;3556.76881002734;6854.3145685432055;6855.177378714487;6856.280090590416;6862.897056544156;6872.484563657746;6595.4393876521035;6765.42493888025;6768.69540870662;6770.729170833111;6785.796426107225;6844.21291551468;6849.4177994871;6855.177378714586;6858;6859.2166036829785;6569.770058047945;6574.671266436755;6574.934250657432;6589.308122647053;6599.373059559334;6392.169018027626;6523.3150519194805;6567.737290508326;6574.704138313883;6607.3062328456745;6850.177978642595;6893.069940416692;6897.241303456716;6904.827379315558;6921.48088893325;4475.216837053437;4505.234110201208;4506.977465112654;4508.030773383738;4509.774511274358;6519.865058127535;6558.475321974135;6600.306967768315;6606.8017959461295;6612.801615951529;6413.615183089029;6417.422431981144;6419.325970773189;6421.775237866652;6432.35676432353;6371.267304260069;6375.171227740364;6377.2984971654005;6384;6393.104965304954;6135.570510064253;6255.53083518747;6263.060540918898;6287.993920972623;6291.591046581958;6408.455281301141;6413.35866413355;6419.743210271537;6422.293547709654;6442.8389290268115;6281.43467087946;6283.057541368831;6284.968575157095;6293.716782744696;6298.244210694746 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: |5;yui.html;849.6631586252706;857.3569822633025;865.1435079271523;876.294582860797;876.3602570123811;13548.119372240797;14009.50966716164;14090.859091409084;14091.647708807272;14099.859001409983;13396.933015334935;13454.730905381886;13470.461181552751;13482.797758033637;13484.66288342792;688.8415664397191;692.7817737412724;822.1942496353577;829.0424559633618;833.3749687734199;837.2757564706516;841.221869770463;844.2697067037;845.9365547583925;846.2510678049908;873.7378786364097;874.4490970688457;876.3339861705118;876.6843936182969;876.9298456123495;725.9673314700851;729.3508777188307;853.4154104438448;861.1861790607878;861.4185424838272;636.7198432689648;637.8564822914853;637.894747366684;640.8269767162886;641.9101325814389;13738.519151829638;13780.724385512234;13883.722325553534;13940.651483712887;13991;11509.48207330672;12369.443375048055;12434.564790232298;12615.936920315431;13402.664933376645;10260.435676037814;10419.895801041968;10439.843402348972;10526.10528105112;10701.785964280749;3563.516615108252;3627.7097832173363;3657.926841463156;3669.9816500917323;3679.521662183926;44841.55158448406;44996.55003449989;45279.77360113178;45313.320300195526;45507;10439.112675422673;10455;10490;10526.526306316235;10575.62985295511;18285.725714114298;18328.816711832977;18340.81659183391;18348.541286467946;18371.90814045921;7554.811129721691;7751.147373788879;7783.688652453951;7824.37405007598;7843.7254696085365;4309.612134907873;4415.602595766396;4425.336199570091;4434.955650443454;4471.754053527087;3106.7669924755733;3140.7173354398215;3141.5758872551914;3142.3715256948703;3156.021633293686;591.1487458060379;599.1342510072902;602.3795490644643;608.8417011576934;614.665007570875;652.9934700652933;656.9638669873203;673.2358772792818;714.2429025233165;715.6994062493765;8520.786980325542;8604.719749266449;8616.35377346689;8623.439476434012;8932.19610235069;547.151914532481;559.1193869655309;559.2031355318736;561.9522340601013;612.0757655939475;3751.174741556853;3772.641599048086;3920.686569999082;3926.823292951824;4158.521769996429;59130.70434647885;60116;60202.39797601968;60489;60738;52059.47940520622;52400.47599523956;52971.47028529742;53188.202176967374;53517.46482535125;46029.07941841144;46096.769516152206;46956.90426558238;47217.05565888663;47303.526964729914;8645.740627781177;8675.436096653697;8825.293976481995;9476.336656433983;9522.238220942447;36405;36666;36923.446148308336;38479;38483.615163848;42940.570594293655;48579.5142048575;49157.75421122871;49499;50322.49677503324;12035.939820300842;12073.57742479009;12125.090618203494;12241.571544995883;12819.359032048547;12635.684107897376;12789;13044.478220871059;13532.255725935169;13538.255395952923;11929.701757456132;12203.901648851646;12562.246265224116;12919.612411627666;12935.805962910752;11669.241499302518;12352.814707779571;12462.875371246171;12469.189502682297;12498.25010499373;11479.311241325548;11804.763904721685;12080;12190.57332993341;12587.181833180814;8993.190612844875;9040.276777857887;9465.100815422524;9521.523923803643;9805.215582753506;7525.2098529653595;7678.8080297993;7697.384209263358;7712.035995500562;7877 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1030 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:06:20 INFO - 2015-11-23 07:06:20,954 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291180946__endTimestamp 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5506.20 Median:5744.80 stddev:618.34 (10.8%) stddev-sans-first:593.16 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: Values: 3199.3 3257.6 3304.1 3306.5 3335.1 5217.4 5385.4 5476.1 5491.9 5499.3 5387.2 5432.3 5447.2 5473.6 5549.2 4960.0 5032.3 5039.8 5067.1 5084.2 4897.7 5094.9 5100.1 5136.6 5183.7 4924.9 4997.6 5005.1 5013.5 5021.8 4995.4 5005.1 5006.0 5010.0 5055.0 4897.1 4991.6 5007.6 5011.6 5015.3 5246.4 5291.0 5307.8 5309.8 5341.5 5965.5 5966.3 5972.9 5972.9 5977.4 5781.4 5895.3 5985.9 5992.3 6000.4 5498.3 5551.2 5551.9 5553.8 5609.4 6104.1 6121.4 6131.9 6143.7 6150.7 5682.7 5744.8 5797.5 5940.3 5979.9 5891.5 5900.4 5957.7 5965.0 6021.5 5905.9 5906.9 5914.3 5916.1 5940.8 5744.6 5834.7 5851.4 5892.9 5905.6 4522.1 4552.8 4586.1 4594.0 4603.1 4049.1 4055.6 4067.7 4094.4 4111.9 5472.7 5588.8 5647.2 5652.1 5658.1 5876.4 5900.1 5907.6 5959.7 6013.4 5565.7 5730.0 5759.8 5764.3 5766.6 5047.9 5244.7 5248.2 5248.9 5252.6 6041.6 6062.8 6113.4 6123.9 6125.9 5991.4 5993.0 5996.9 6010.0 6028.8 5979.6 6026.6 6064.5 6067.0 6098.1 5776.0 5787.0 5803.5 5842.3 5895.8 5993.3 5997.3 6002.8 6005.7 6006.5 5640.1 5761.7 5854.6 5855.4 5861.5 5700.6 5775.9 5851.8 5860.4 5890.5 5724.0 5736.2 5743.2 5743.2 5745.3 5597.2 5790.5 5832.4 5854.0 5893.3 5720.2 5807.7 5814.1 5814.7 5844.3 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,955 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47841.62 Median:32818.88 stddev:79709.37 (242.9%) stddev-sans-first:79853.94 07:06:20 INFO - 2015-11-23 07:06:20,956 DEBUG : BROWSER_OUTPUT: Values: 566.9 574.8 602.5 608.1 631.6 31764.4 40007.6 40221.6 40246.4 40299.2 42894.8 43563.6 43601.0 43620.6 43638.3 7788.3 7881.6 8826.3 9023.1 10312.4 10445.0 10447.2 10552.6 10554.5 10555.4 10409.6 10446.3 10480.6 10496.5 10508.3 7950.1 8094.9 10675.4 10884.8 10900.0 10424.2 10532.4 10537.0 10541.3 10562.3 40368.4 40871.4 40880.0 40886.0 40955.2 3342.1 3351.1 3388.8 3486.4 3785.5 30345.0 30488.0 30676.1 30733.8 30905.7 3849.7 3928.7 3984.5 4083.4 4088.2 291931.0 292001.0 292326.0 293578.5 293864.0 55677.0 56848.7 59471.0 59726.1 59791.1 67104.0 68183.3 68427.7 68455.0 68492.0 15900.8 16014.4 16184.4 16187.6 16188.1 12167.0 12175.3 12184.9 12187.8 12207.5 18891.9 19045.6 19303.1 19519.0 19536.4 7796.3 8022.0 8055.8 8128.9 8159.8 925.5 938.3 999.7 1040.0 1068.3 25724.6 27695.6 27799.6 28051.2 28066.7 1034.9 1066.3 1102.8 1103.5 1132.1 15118.8 15414.6 16089.8 16151.4 16179.7 323204.0 330004.0 330098.0 330573.0 330788.0 52491.7 52615.7 52816.5 52827.5 52830.7 1369.5 1378.6 1387.9 1389.4 1398.2 27799.4 28643.0 28836.3 29026.6 29054.9 43102.8 45909.3 46195.5 46252.5 46317.0 259884.0 295846.0 299618.0 301048.0 301826.0 31753.8 32288.2 32408.5 32412.5 32436.8 42512.8 42989.8 43048.1 43335.8 43879.3 35966.0 36126.5 36334.6 36453.0 37559.0 35986.8 36663.0 36675.8 36902.4 36952.6 35755.6 36141.8 36195.5 36903.8 36946.0 29486.4 30575.7 32784.9 32852.8 32929.8 25139.5 25169.4 25170.6 25260.7 25455.5 07:06:20 INFO - 2015-11-23 07:06:20,956 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,957 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29183.70 Median:4025.76 stddev:89703.06 (2228.2%) stddev-sans-first:89928.59 07:06:20 INFO - 2015-11-23 07:06:20,957 DEBUG : BROWSER_OUTPUT: Values: 359.9 363.8 364.1 365.4 366.4 14497.0 14824.3 16564.1 18236.5 19443.9 16860.5 16928.6 17192.5 18173.6 18300.7 5288.2 5427.3 5430.1 5432.5 5434.9 3982.7 4068.8 5382.2 5796.7 6034.0 5919.6 5929.3 5951.9 5976.4 5976.4 5766.7 5874.4 5903.2 5916.2 5921.1 5200.2 5201.3 5211.9 5214.4 5223.8 12239.8 12455.5 12582.9 12599.7 21181.0 1991.7 2035.4 2079.4 2099.3 2112.6 9561.8 9623.7 9629.2 9847.4 9853.4 1722.3 1754.9 1812.5 1900.2 1942.5 61951.4 63514.1 65731.7 66405.0 66539.0 10226.9 10234.3 10276.2 10284.2 10312.2 13492.1 13498.3 13518.8 13521.7 13534.1 7510.6 7601.8 7627.2 7699.9 7857.1 7222.7 7397.1 7430.5 7516.7 7672.7 4392.1 4405.6 4408.0 4408.2 4430.0 1709.5 1749.0 1765.6 1802.3 1834.1 902.4 939.7 989.9 991.6 995.5 14404.3 16378.5 16826.3 17260.7 17811.0 956.2 968.2 987.7 988.3 1012.0 9514.3 9698.8 9719.2 9734.8 9805.5 540032.0 547080.0 549626.0 552731.0 553795.0 74064.3 79471.6 81995.0 82049.6 82896.6 1194.7 1196.0 1220.1 1239.3 1257.8 15036.2 15641.5 16290.7 16326.8 16378.5 34719.8 34795.7 34815.8 34865.3 35182.0 47860.8 48403.8 48754.8 50080.2 51805.5 9374.6 9434.2 9523.8 9546.8 9754.9 17633.2 17867.9 18179.5 18440.3 18558.9 14294.9 14687.4 14814.3 14899.1 15443.5 9700.2 13358.3 14358.1 14687.5 15125.0 11626.5 14428.8 14854.4 15055.1 15164.5 9026.7 9305.0 9396.3 9698.0 9707.1 10428.8 10490.0 13615.0 14664.3 15420.8 07:06:20 INFO - 2015-11-23 07:06:20,957 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,957 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5422.60 Median:6460.03 stddev:2837.06 (43.9%) stddev-sans-first:2828.61 07:06:20 INFO - 2015-11-23 07:06:20,957 DEBUG : BROWSER_OUTPUT: Values: 1363.5 1711.2 1785.0 1791.2 1817.8 6502.3 7502.5 7860.4 7864.6 7866.9 7674.0 7836.4 7841.1 7848.1 7848.9 1988.9 2026.4 2213.4 2255.5 2305.4 2300.1 2304.1 2304.5 2305.0 2307.0 2140.3 2218.2 2221.0 2222.8 2223.2 1877.4 1911.6 2120.7 2152.1 2157.2 2293.6 2297.4 2332.5 2334.4 2349.2 7728.3 7768.5 7774.7 7776.5 7788.3 4736.8 4809.5 4826.9 4827.3 4835.9 2969.5 2973.5 3005.2 3023.9 3095.7 934.2 939.5 944.7 963.1 964.0 10754.6 10769.7 10772.5 10775.2 10780.0 4248.0 4273.0 4286.1 4350.7 4402.4 9132.3 9132.5 9142.0 9142.2 9151.1 4703.8 4717.3 4717.9 4722.6 4723.6 4193.2 4194.0 4194.7 4231.9 4236.4 3679.3 3689.7 3734.1 3774.8 3776.7 1184.0 1198.1 1204.0 1215.4 1223.4 930.0 1303.8 1310.7 1323.5 1336.1 6396.6 7467.3 7530.7 7622.4 7633.8 596.3 597.8 599.8 612.7 621.9 5748.9 5800.2 5852.6 5862.8 5867.9 9245.1 9413.7 9517.0 9518.6 9522.0 9101.4 9346.2 9353.3 9362.0 9366.6 7194.1 7266.9 7277.2 7279.6 7282.7 6893.4 7063.3 7071.0 7077.0 7085.4 8147.0 8183.7 8208.9 8404.6 8417.3 8378.5 8550.7 8551.2 8551.2 8575.4 6684.6 6730.9 6733.1 6739.6 6741.5 7276.0 7281.1 7283.3 7299.7 7350.0 6953.9 6966.7 7090.3 7135.8 7167.7 6823.6 6904.8 6972.9 7009.7 7117.0 6150.4 6295.3 7066.9 7070.9 7077.6 6337.2 6455.7 6468.6 6483.6 6484.2 6431.5 6458.8 6461.2 6467.5 6486.6 07:06:20 INFO - 2015-11-23 07:06:20,958 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,958 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5315.51 Median:6050.27 stddev:1613.47 (26.7%) stddev-sans-first:1574.18 07:06:20 INFO - 2015-11-23 07:06:20,958 DEBUG : BROWSER_OUTPUT: Values: 339.8 341.7 347.6 350.3 351.5 5912.7 5915.4 5976.4 5978.9 5986.6 5616.1 5731.9 5778.0 5897.6 5897.8 4595.4 4610.8 4615.4 4628.5 4633.9 4605.3 4611.4 4612.4 4618.8 4625.7 4365.1 4430.2 4439.0 4448.1 4449.7 4445.0 4503.1 4511.5 4512.2 4513.5 3960.7 3973.6 3989.7 3990.6 3998.8 5568.7 5572.1 5614.2 5619.7 5624.3 5192.8 5266.3 5285.5 5312.4 5327.3 6295.1 6313.1 6314.2 6318.4 6319.7 4424.3 4424.5 4431.8 4433.6 4434.2 6390.7 6574.2 6574.4 6578.2 6579.7 4473.7 4506.3 4508.6 4511.0 4512.0 4534.3 4561.2 4565.4 4566.3 4567.9 5275.5 5288.7 5290.2 5290.2 5293.3 6169.0 6374.0 6376.1 6380.6 6383.8 1586.8 1608.6 1610.2 1611.7 1612.4 1028.8 1030.3 1033.0 1046.3 1072.4 6152.6 6166.9 6172.8 6173.2 6176.2 6513.3 6521.1 6527.9 6530.2 6536.7 6008.6 6092.0 6095.8 6102.1 6237.7 3528.5 3538.3 3554.3 3554.4 3556.8 6854.3 6855.2 6856.3 6862.9 6872.5 6595.4 6765.4 6768.7 6770.7 6785.8 6844.2 6849.4 6855.2 6858.0 6859.2 6569.8 6574.7 6574.9 6589.3 6599.4 6392.2 6523.3 6567.7 6574.7 6607.3 6850.2 6893.1 6897.2 6904.8 6921.5 4475.2 4505.2 4507.0 4508.0 4509.8 6519.9 6558.5 6600.3 6606.8 6612.8 6413.6 6417.4 6419.3 6421.8 6432.4 6371.3 6375.2 6377.3 6384.0 6393.1 6135.6 6255.5 6263.1 6288.0 6291.6 6408.5 6413.4 6419.7 6422.3 6442.8 6281.4 6283.1 6285.0 6293.7 6298.2 07:06:20 INFO - 2015-11-23 07:06:20,958 DEBUG : BROWSER_OUTPUT: 07:06:20 INFO - 2015-11-23 07:06:20,958 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14163.15 Median:45768.04 stddev:16386.40 (35.8%) stddev-sans-first:16401.86 07:06:20 INFO - 2015-11-23 07:06:20,959 DEBUG : BROWSER_OUTPUT: Values: 849.7 857.4 865.1 876.3 876.4 13548.1 14009.5 14090.9 14091.6 14099.9 13396.9 13454.7 13470.5 13482.8 13484.7 688.8 692.8 822.2 829.0 833.4 837.3 841.2 844.3 845.9 846.3 873.7 874.4 876.3 876.7 876.9 726.0 729.4 853.4 861.2 861.4 636.7 637.9 637.9 640.8 641.9 13738.5 13780.7 13883.7 13940.7 13991.0 11509.5 12369.4 12434.6 12615.9 13402.7 10260.4 10419.9 10439.8 10526.1 10701.8 3563.5 3627.7 3657.9 3670.0 3679.5 44841.6 44996.6 45279.8 45313.3 45507.0 10439.1 10455.0 10490.0 10526.5 10575.6 18285.7 18328.8 18340.8 18348.5 18371.9 7554.8 7751.1 7783.7 7824.4 7843.7 4309.6 4415.6 4425.3 4435.0 4471.8 3106.8 3140.7 3141.6 3142.4 3156.0 591.1 599.1 602.4 608.8 614.7 653.0 657.0 673.2 714.2 715.7 8520.8 8604.7 8616.4 8623.4 8932.2 547.2 559.1 559.2 562.0 612.1 3751.2 3772.6 3920.7 3926.8 4158.5 59130.7 60116.0 60202.4 60489.0 60738.0 52059.5 52400.5 52971.5 53188.2 53517.5 46029.1 46096.8 46956.9 47217.1 47303.5 8645.7 8675.4 8825.3 9476.3 9522.2 36405.0 36666.0 36923.4 38479.0 38483.6 42940.6 48579.5 49157.8 49499.0 50322.5 12035.9 12073.6 12125.1 12241.6 12819.4 12635.7 12789.0 13044.5 13532.3 13538.3 11929.7 12203.9 12562.2 12919.6 12935.8 11669.2 12352.8 12462.9 12469.2 12498.3 11479.3 11804.8 12080.0 12190.6 12587.2 8993.2 9040.3 9465.1 9521.5 9805.2 7525.2 7678.8 7697.4 7712.0 7877.0 07:06:20 INFO - 2015-11-23 07:06:20,959 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:06:20 INFO - 2015-11-23 07:06:20,960 DEBUG : BROWSER_OUTPUT: 07:06:21 INFO - 2015-11-23 07:06:21,582 INFO : Browser exited with error code: 0 07:06:21 INFO - 2015-11-23 07:06:21,600 INFO : Completed test dromaeo_css (00:18:36) 07:06:21 INFO - 2015-11-23 07:06:21,600 INFO : Starting test kraken 07:06:21 INFO - 2015-11-23 07:06:21,601 DEBUG : operating with platform_type : linux_ 07:06:21 INFO - 2015-11-23 07:06:21,601 INFO : Initialising browser for kraken test... 07:06:21 INFO - 2015-11-23 07:06:21,607 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJISq7c/profile http://localhost:46450/getInfo.html 07:06:25 INFO - 2015-11-23 07:06:25,674 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:06:25 INFO - 2015-11-23 07:06:25,674 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:06:25 INFO - 2015-11-23 07:06:25,674 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:06:25 INFO - 2015-11-23 07:06:25,674 DEBUG : BROWSER_OUTPUT: __metrics 07:06:25 INFO - 2015-11-23 07:06:25,839 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:27 INFO - 2015-11-23 07:06:27,077 INFO : Browser initialized. 07:06:27 INFO - 2015-11-23 07:06:27,077 INFO : Running cycle 1/1 for kraken test... 07:06:27 INFO - 2015-11-23 07:06:27,078 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJISq7c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:06:38 INFO - 2015-11-23 07:06:38,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 142598144 07:06:38 INFO - 2015-11-23 07:06:38,791 DEBUG : BROWSER_OUTPUT: 07:06:41 INFO - 2015-11-23 07:06:41,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46450/tests/kraken/driver.html?testName=audio-beat-detection) 07:06:41 INFO - 2015-11-23 07:06:41,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 176197632 07:06:41 INFO - 2015-11-23 07:06:41,834 DEBUG : BROWSER_OUTPUT: 07:06:44 INFO - 2015-11-23 07:06:44,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46450/tests/kraken/driver.html?testName=audio-dft) 07:06:44 INFO - 2015-11-23 07:06:44,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 166273024 07:06:44 INFO - 2015-11-23 07:06:44,980 DEBUG : BROWSER_OUTPUT: 07:06:47 INFO - 2015-11-23 07:06:47,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46450/tests/kraken/driver.html?testName=audio-fft) 07:06:48 INFO - 2015-11-23 07:06:48,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 151900160 07:06:48 INFO - 2015-11-23 07:06:48,388 DEBUG : BROWSER_OUTPUT: 07:06:50 INFO - 2015-11-23 07:06:50,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46450/tests/kraken/driver.html?testName=audio-oscillator) 07:06:50 INFO - 2015-11-23 07:06:50,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 153075712 07:06:50 INFO - 2015-11-23 07:06:50,921 DEBUG : BROWSER_OUTPUT: 07:06:53 INFO - 2015-11-23 07:06:53,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:53 INFO - 2015-11-23 07:06:53,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 156839936 07:06:53 INFO - 2015-11-23 07:06:53,664 DEBUG : BROWSER_OUTPUT: 07:06:56 INFO - 2015-11-23 07:06:56,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46450/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:57 INFO - 2015-11-23 07:06:57,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 157712384 07:06:57 INFO - 2015-11-23 07:06:57,164 DEBUG : BROWSER_OUTPUT: 07:07:00 INFO - 2015-11-23 07:07:00,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46450/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:01 INFO - 2015-11-23 07:07:01,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 157700096 07:07:01 INFO - 2015-11-23 07:07:01,192 DEBUG : BROWSER_OUTPUT: 07:07:03 INFO - 2015-11-23 07:07:03,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46450/tests/kraken/driver.html?testName=json-parse-financial) 07:07:04 INFO - 2015-11-23 07:07:04,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 157908992 07:07:04 INFO - 2015-11-23 07:07:04,523 DEBUG : BROWSER_OUTPUT: 07:07:06 INFO - 2015-11-23 07:07:06,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:06 INFO - 2015-11-23 07:07:06,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 170143744 07:07:06 INFO - 2015-11-23 07:07:06,667 DEBUG : BROWSER_OUTPUT: 07:07:08 INFO - 2015-11-23 07:07:08,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:09 INFO - 2015-11-23 07:07:09,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 166768640 07:07:09 INFO - 2015-11-23 07:07:09,071 DEBUG : BROWSER_OUTPUT: 07:07:11 INFO - 2015-11-23 07:07:11,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:11 INFO - 2015-11-23 07:07:11,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 172380160 07:07:11 INFO - 2015-11-23 07:07:11,696 DEBUG : BROWSER_OUTPUT: 07:07:14 INFO - 2015-11-23 07:07:14,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:14 INFO - 2015-11-23 07:07:14,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 181944320 07:07:14 INFO - 2015-11-23 07:07:14,696 DEBUG : BROWSER_OUTPUT: 07:07:17 INFO - 2015-11-23 07:07:17,271 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:17 INFO - 2015-11-23 07:07:17,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 180678656 07:07:17 INFO - 2015-11-23 07:07:17,845 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46450/tests/kraken/driver.html?testName=ai-astar) 07:07:19 INFO - 2015-11-23 07:07:19,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 239108096 07:07:19 INFO - 2015-11-23 07:07:19,757 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;109;104;110;110;109;99;110;110;103 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;149;161;139;155;150;125;166;126 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;160;160;160;161;158;160;160 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;93;97;72;72;74;98;91;71 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;94;134;93;94;93;139;93;93;138 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;109;109;110;109;110 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;146;145;146;146;158;145;145;145 07:07:19 INFO - 2015-11-23 07:07:19,758 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;95;95;95;95;96;95;96 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;60;60;62;61;61;69;59;59 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;69;69;69;69;72 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;91;92;85;84;83;83;83;84 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;117;117;126;124;116;122;116;122;121 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;159;153;151;154;144;145;151;152;142 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;66;67;66;68;67;66;66;65 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:07:19 INFO - 2015-11-23 07:07:19,759 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,948 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291239752__endTimestamp 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.50 Median:110.00 stddev:4.03 (3.7%) stddev-sans-first:4.08 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 104.0 110.0 110.0 109.0 99.0 110.0 110.0 103.0 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,760 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.50 stddev:15.38 (10.3%) stddev-sans-first:16.22 07:07:19 INFO - 2015-11-23 07:07:19,761 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 149.0 161.0 139.0 155.0 150.0 125.0 166.0 126.0 07:07:19 INFO - 2015-11-23 07:07:19,761 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 160.0 160.0 160.0 161.0 158.0 160.0 160.0 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:82.50 stddev:12.02 (14.6%) stddev-sans-first:12.19 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 93.0 97.0 72.0 72.0 74.0 98.0 91.0 71.0 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:93.00 stddev:21.23 (22.8%) stddev-sans-first:21.88 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: Values: 92.0 94.0 134.0 93.0 94.0 93.0 139.0 93.0 93.0 138.0 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:07:19 INFO - 2015-11-23 07:07:19,762 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:145.50 stddev:4.03 (2.8%) stddev-sans-first:4.24 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 146.0 145.0 146.0 146.0 158.0 145.0 145.0 145.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:2.92 (4.8%) stddev-sans-first:3.07 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 60.0 60.0 62.0 61.0 61.0 69.0 59.0 59.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 72.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.33 (4.0%) stddev-sans-first:3.50 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 91.0 92.0 85.0 84.0 83.0 83.0 83.0 84.0 07:07:19 INFO - 2015-11-23 07:07:19,763 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:122.00 stddev:3.56 (2.9%) stddev-sans-first:3.72 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: Values: 122.0 117.0 117.0 126.0 124.0 116.0 122.0 116.0 122.0 121.0 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:151.50 stddev:5.48 (3.6%) stddev-sans-first:5.44 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: Values: 144.0 159.0 153.0 151.0 154.0 144.0 145.0 151.0 152.0 142.0 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 66.0 68.0 67.0 66.0 66.0 65.0 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:07:19 INFO - 2015-11-23 07:07:19,764 DEBUG : BROWSER_OUTPUT: 07:07:20 INFO - 2015-11-23 07:07:20,590 INFO : Browser exited with error code: 0 07:07:20 INFO - 2015-11-23 07:07:20,640 INFO : Completed test kraken (00:00:59) 07:07:20 INFO - 2015-11-23 07:07:20,640 INFO : Starting test v8_7 07:07:20 INFO - 2015-11-23 07:07:20,640 DEBUG : operating with platform_type : linux_ 07:07:20 INFO - 2015-11-23 07:07:20,640 INFO : Initialising browser for v8_7 test... 07:07:20 INFO - 2015-11-23 07:07:20,647 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEyzhFL/profile http://localhost:46450/getInfo.html 07:07:24 INFO - 2015-11-23 07:07:24,598 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:07:24 INFO - 2015-11-23 07:07:24,598 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:07:24 INFO - 2015-11-23 07:07:24,598 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:07:24 INFO - 2015-11-23 07:07:24,598 DEBUG : BROWSER_OUTPUT: __metrics 07:07:24 INFO - 2015-11-23 07:07:24,666 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:26 INFO - 2015-11-23 07:07:26,116 INFO : Browser initialized. 07:07:26 INFO - 2015-11-23 07:07:26,117 INFO : Running cycle 1/1 for v8_7 test... 07:07:26 INFO - 2015-11-23 07:07:26,117 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEyzhFL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:07:37 INFO - 2015-11-23 07:07:37,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 139837440 07:07:37 INFO - 2015-11-23 07:07:37,870 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46450/tests/v8_7/run.html (next: http://localhost:46450/tests/v8_7/run.html) 07:07:59 INFO - 2015-11-23 07:07:59,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 606728192 07:07:59 INFO - 2015-11-23 07:07:59,568 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,568 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: |0;Richards;182.7485380116959 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.16803670426305 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.16704288939053 07:07:59 INFO - 2015-11-23 07:07:59,569 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1941.7475728155339 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |8;Splay;642.2607578676943 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:07:59 INFO - 2015-11-23 07:07:59,570 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: __startTimestamp1448291279561__endTimestamp 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:182.75 Median:182.75 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: Values: 182.7 07:07:59 INFO - 2015-11-23 07:07:59,571 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.17 Median:191.17 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: Values: 191.2 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.17 Median:282.17 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: Values: 282.2 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,572 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: Values: 5035.2 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1941.75 Median:1941.75 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: Values: 1941.7 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,573 DEBUG : BROWSER_OUTPUT: Values: 794.3 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: Values: 12096.4 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: Values: 25575.0 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:642.26 Median:642.26 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: Values: 642.3 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:07:59 INFO - 2015-11-23 07:07:59,574 DEBUG : BROWSER_OUTPUT: 07:08:00 INFO - 2015-11-23 07:08:00,506 INFO : Browser exited with error code: 0 07:08:00 INFO - 2015-11-23 07:08:00,523 INFO : Completed test v8_7 (00:00:39) 07:08:01 INFO - 2015-11-23 07:08:01,020 INFO : Completed test suite (00:20:15) 07:08:01 INFO - 2015-11-23 07:08:01,021 DEBUG : Working with test: dromaeo_css 07:08:01 INFO - 2015-11-23 07:08:01,021 DEBUG : Generating results file: dromaeo_css 07:08:01 INFO - 2015-11-23 07:08:01,022 DEBUG : Working with test: kraken 07:08:01 INFO - 2015-11-23 07:08:01,022 DEBUG : Generating results file: kraken 07:08:01 INFO - 2015-11-23 07:08:01,022 INFO : javascript benchmark 07:08:01 INFO - 2015-11-23 07:08:01,022 DEBUG : Working with test: v8_7 07:08:01 INFO - 2015-11-23 07:08:01,023 DEBUG : Generating results file: v8_7 07:08:01 INFO - 2015-11-23 07:08:01,023 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:01 INFO - 2015-11-23 07:08:01,099 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 07:08:01 INFO - 2015-11-23 07:08:01,099 DEBUG : process_Request line: dromaeo_css 7080.56 graph.html#tests=[[72,63,35]] 07:08:01 INFO - 2015-11-23 07:08:01,099 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:01 INFO - 2015-11-23 07:08:01,134 DEBUG : process_Request line: kraken 1502.70 graph.html#tests=[[232,63,35]] 07:08:01 INFO - 2015-11-23 07:08:01,134 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:01 INFO - 2015-11-23 07:08:01,173 DEBUG : process_Request line: v8_7 19620.19 graph.html#tests=[[230,63,35]] 07:08:01 INFO - 2015-11-23 07:08:01,174 INFO : javascript benchmark 07:08:01 INFO - 2015-11-23 07:08:01,178 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3199.2641692410743, 3257.609086909571, 3304.140923359927, 3306.48749443836, 3335.066181469189, 5217.426083130853, 5385.434529374408, 5476.096444086721, 5491.88822896321, 5499.340079190492, 5387.19192121181, 5432.293801805759, 5447.1829225616175, 5473.644213126144, 5549.19536667184, 4959.975200123994, 5032.295478632976, 5039.77321020555, 5067.062593420211, 5084.211947148198, 4897.657163998521, 5094.923576146361, 5100.107481190796, 5136.614753893455, 5183.714895680736, 4924.901501969958, 4997.600191984632, 5005.0990821652085, 5013.548780609763, 5021.774020169101, 4995.425526064513, 5005.074061298671, 5005.9988002399305, 5009.974950125263, 5055.0, 4897.142999975025, 4991.575716064139, 5007.649464537484, 5011.599072074226, 5015.3229314042865, 5246.396664383607, 5291.021161085211, 5307.840764777063, 5309.761060752276, 5341.519263266286, 5965.4631083202285, 5966.3138739045135, 5972.850678733023, 5972.910406343908, 5977.402259774031, 5781.392953739881, 5895.263092113486, 5985.910211346833, 5992.2809262888295, 6000.399960004008, 5498.257735205736, 5551.1673249012165, 5551.8889622208135, 5553.8333849984165, 5609.411011843779, 6104.11490333908, 6121.418465245794, 6131.938969993885, 6143.692815359214, 6150.7232174552255, 5682.659040457585, 5744.798932037359, 5797.507211887037, 5940.31686356066, 5979.940200597938, 5891.528677705774, 5900.43945825146, 5957.702114894238, 5965.045592705146, 6021.458068773832, 5905.852353691193, 5906.852328691731, 5914.290285165807, 5916.112583112482, 5940.762369505258, 5744.569157313218, 5834.708264586754, 5851.414858514115, 5892.909811684852, 5905.645661260338, 4522.118186953512, 4552.772361381918, 4586.128635559233, 4594.035252596926, 4603.125406172817, 4049.0687141957515, 4055.5741647127215, 4067.7152599318356, 4094.4267802507675, 4111.8560850370095, 5472.699001554953, 5588.832335029874, 5647.209390685307, 5652.067408877571, 5658.094704847204, 5876.44173803488, 5900.144479050514, 5907.586468947133, 5959.731812068468, 6013.398660133952, 5565.749541270652, 5730.0, 5759.798407055817, 5764.308283006066, 5766.625169363978, 5047.924281135713, 5244.737763111829, 5248.186531087687, 5248.895022099537, 5252.632315737862, 6041.6375017499095, 6062.757489700362, 6113.445692323776, 6123.925419229976, 6125.856697819315, 5991.370906054802, 5992.970035149797, 5996.940030599638, 6009.969950150221, 6028.819135425944, 5979.551533635082, 6026.578139530191, 6064.514838812796, 6066.969665151646, 6098.11577321277, 5776.018076927016, 5787.045137552257, 5803.535717142534, 5842.269716285465, 5895.823125306248, 5993.340732519332, 5997.280326360865, 6002.819915402545, 6005.729742161526, 6006.549508786771, 5640.097584386478, 5761.740721667451, 5854.648721076749, 5855.414458554111, 5861.472467477947, 5700.629459085146, 5775.9133612995, 5851.795187168429, 5860.413958604106, 5890.4993075589055, 5724.0, 5736.19693242938, 5743.167240750151, 5743.167240750151, 5745.253117094751, 5597.160425936142, 5790.536757059341, 5832.416758324133, 5854.0, 5893.263342082239, 5720.199172115824, 5807.680577568274, 5814.127880817911, 5814.709264536672, 5844.298684157929], "unit": "ms", "name": "dojo.html", "value": 5465.536816779353}, {"lowerIsBetter": false, "replicates": [566.8611190258388, 574.767219276193, 602.4728362682653, 608.106084056437, 631.5926227583209, 31764.364712705734, 40007.59992400075, 40221.59778402215, 40246.39630405546, 40299.194016119734, 42894.78552607232, 43563.564364356345, 43601.0, 43620.563794362046, 43638.34542481865, 7788.299053085221, 7881.566513841736, 8826.338024648145, 9023.097690230958, 10312.432816195107, 10445.0, 10447.216458765584, 10552.630657926975, 10554.472276386188, 10555.366677999305, 10409.635662751805, 10446.320989135682, 10480.633177838778, 10496.527656255486, 10508.316959397614, 7950.1254861965135, 8094.919050809505, 10675.35947843124, 10884.768622432382, 10900.0, 10424.166066714644, 10532.42071686057, 10537.0, 10541.314814537107, 10562.313449625826, 40368.39447408291, 40871.38692919609, 40880.0, 40886.0, 40955.180896382204, 3342.134519177337, 3351.078453425303, 3388.796672199676, 3486.3724529584665, 3785.5268091488565, 30345.0, 30488.0, 30676.079717608507, 30733.846330768425, 30905.690943090733, 3849.6727778138893, 3928.666063384616, 3984.4820173377275, 4083.3670781028986, 4088.1823635273063, 291931.0, 292001.0, 292326.0, 293578.53210734023, 293864.0, 55677.0, 56848.715756420956, 59471.0, 59726.104108438405, 59791.103133453034, 67104.0, 68183.31816681869, 68427.65786171037, 68455.0, 68492.0, 15900.76148857768, 16014.359425623077, 16184.433544825875, 16187.595310117342, 16188.109653969144, 12167.0, 12175.330356830282, 12184.928562144456, 12187.75624487523, 12207.450664720109, 18891.90554047221, 19045.61908761817, 19303.131359088875, 19518.96761821065, 19536.413907582795, 7796.259355361231, 8021.959890200512, 8055.758327250074, 8128.918710812816, 8159.755207343789, 925.5464822237055, 938.2728385501291, 999.7050869993369, 1039.9636012739518, 1068.3056013591229, 25724.614130788053, 27695.61790121305, 27799.58300625492, 28051.158465246077, 28066.71933280682, 1034.9249754242846, 1066.2536224642781, 1102.7684186320803, 1103.4648195625116, 1132.1282612388416, 15118.773218401733, 15414.614634634223, 16089.839101608834, 16151.434699785452, 16179.672052567617, 323204.0, 330004.0, 330098.0, 330573.0, 330788.0, 52491.737541312046, 52615.73692131515, 52816.471835281154, 52827.47172528225, 52830.73584632129, 1369.513822592985, 1378.5864240727742, 1387.947194192959, 1389.3678376338944, 1398.1541167593664, 27799.44401111926, 28643.0, 28836.279093022844, 29026.564601530572, 29054.854725726236, 43102.78448607737, 45909.31136032895, 46195.53804461913, 46252.53747462482, 46317.0, 259884.0, 295846.0, 299618.0, 301048.0, 301826.0, 31753.8412307937, 32288.192795180308, 32408.513872292406, 32412.513812293306, 32436.837815811716, 42512.78743606262, 42989.78505107454, 43048.139037218454, 43335.783321083196, 43879.34180987224, 35966.0, 36126.458103129, 36334.63665363418, 36453.0, 37559.0, 35986.82994339362, 36663.0, 36675.816620916725, 36902.446463302535, 36952.630473695994, 35755.642443576275, 36141.819290903375, 36195.45706814347, 36903.81548092242, 36946.0, 29486.410271794015, 30575.694243057285, 32784.915105255845, 32852.835735821165, 32929.835350823094, 25139.497210056063, 25169.370765731004, 25170.62244066377, 25260.74739252584, 25455.490890182464], "unit": "ms", "name": "ext.html", "value": 19135.966128750122}, {"lowerIsBetter": false, "replicates": [359.89203239028285, 363.7690066807576, 364.1079355578832, 365.4499977533811, 366.3899607154088, 14497.0, 14824.332905019273, 16564.088975106366, 18236.45290641281, 19443.902780486096, 16860.494185174466, 16928.576785580335, 17192.484225473258, 18173.636527269446, 18300.725489117674, 5288.153895376731, 5427.267318911956, 5430.13117901134, 5432.483914028181, 5434.864128396782, 3982.721209515335, 4068.7965601719798, 5382.165764306539, 5796.710164491779, 6033.969830150843, 5919.644821310713, 5929.258842644669, 5951.851203719898, 5976.402359764033, 5976.432238937294, 5766.654000759947, 5874.353821079678, 5903.173555702184, 5916.230889984275, 5921.052631578927, 5200.167973124282, 5201.349831271091, 5211.869703257411, 5214.426413094557, 5223.843284701465, 12239.816402753966, 12455.501779928793, 12582.937085314607, 12599.685007874876, 21181.0, 1991.6912878503856, 2035.4097311779567, 2079.376187143866, 2099.286242677497, 2112.640851055324, 9561.808763824685, 9623.663171789023, 9629.181519570844, 9847.359921605144, 9853.359531630493, 1722.3024675006643, 1754.859611231111, 1812.5106221320302, 1900.2019151956074, 1942.5435022769639, 61951.38048619501, 63514.07695667714, 65731.67134164346, 66405.0, 66539.00191497082, 10226.948865255627, 10234.283600147919, 10276.177905767521, 10284.228682848667, 10312.175025997902, 13492.055556111174, 13498.32508374597, 13518.797218041736, 13521.661958451117, 13534.052616316763, 7510.624468776539, 7601.7719468416035, 7627.161012288644, 7699.923000770033, 7857.05715314166, 7222.695629207678, 7397.149327827261, 7430.517016393917, 7516.699332026657, 7672.693092276358, 4392.077663690597, 4405.581469760367, 4408.0, 4408.236705317834, 4430.025394413224, 1709.4700642800772, 1749.0, 1765.6027393836541, 1802.2971041293645, 1834.0737927346604, 902.3503077783985, 939.7086903059936, 989.9257555683353, 991.633095754561, 995.5171741705267, 14404.279786010658, 16378.50864474044, 16826.326946922232, 17260.74108888368, 17811.0, 956.1920177450044, 968.2060710217695, 987.6839411388287, 988.3279370028449, 1011.9747006324753, 9514.28642851789, 9698.75753106178, 9719.17387022111, 9734.805303894023, 9805.460699661444, 540032.0, 547080.0, 549626.0, 552731.0, 553795.0, 74064.25935740682, 79471.60264198642, 81995.0, 82049.58975205086, 82896.58551707203, 1194.6893807610084, 1195.9880401195876, 1220.0544577952157, 1239.3121817391434, 1257.7798885195054, 15036.248187590358, 15641.53075407694, 16290.674186515966, 16326.836731632531, 16378.508644740677, 34719.82640086783, 34795.65204348025, 34815.82592087024, 34865.30269394547, 35182.0, 47860.760696196296, 48403.75798120987, 48754.75622621864, 50080.24879626882, 51805.481945180065, 9374.625014999323, 9434.24526037929, 9523.761905952406, 9546.809063818824, 9754.9024509754, 17633.20650570753, 17867.910660446614, 18179.45461636153, 18440.262389504805, 18558.907205463885, 14294.857051429353, 14687.412503500167, 14814.333354999266, 14899.106053636817, 15443.536693899201, 9700.175485083846, 13358.265295408457, 14358.138511689333, 14687.485937992546, 15125.016873903161, 11626.476808543466, 14428.783568246694, 14854.405823766929, 15055.096694198382, 15164.545063648107, 9026.684066057656, 9305.0, 9396.342256042011, 9698.0, 9707.077827606367, 10428.791424171626, 10490.0, 13615.0, 14664.266786660412, 15420.768688469458], "unit": "ms", "name": "jquery.html", "value": 8895.668946981687}, {"lowerIsBetter": false, "replicates": [1363.4886917405972, 1711.152979275259, 1785.0450009245058, 1791.176059012854, 1817.8363947244745, 6502.284748677647, 7502.549847009176, 7860.410469214818, 7864.6460909259, 7866.92133078669, 7673.961630191855, 7836.373090152789, 7841.137474877759, 7848.058233012032, 7848.882266766003, 1988.9005549722528, 2026.3616960657419, 2213.4245096275004, 2255.5376147889683, 2305.3890718959406, 2300.1029598456616, 2304.1129165271323, 2304.4584522637165, 2304.9654255186188, 2307.0, 2140.283005193262, 2218.201447478906, 2220.989449800345, 2222.8332875034357, 2223.2329846203033, 1877.4367689693106, 1911.560341121543, 2120.67129594913, 2152.074607918594, 2157.223399576151, 2293.5756884976167, 2297.3797074789713, 2332.498512819735, 2334.393057804983, 2349.1543044503965, 7728.26581474759, 7768.495047821873, 7774.65014074368, 7776.533407995538, 7788.260115289038, 4736.83421080264, 4809.5430934061205, 4826.879328016793, 4827.300041493963, 4835.854924352275, 2969.524876019848, 2973.4796410628055, 3005.1885990782584, 3023.8639261233297, 3095.659477457478, 934.2012579244716, 939.5255396025032, 944.650479322655, 963.1476143612883, 963.9903600963971, 10754.623588174454, 10769.676909692722, 10772.515236814363, 10775.191860610486, 10779.999999999922, 4248.0, 4273.0, 4286.07823841188, 4350.717203381833, 4402.405675233803, 9132.3150763693, 9132.543372831331, 9141.954290228507, 9142.177204051668, 9151.130642588943, 4703.7883295251795, 4717.268823332389, 4717.858464246078, 4722.622190224843, 4723.551262630044, 4193.18232944579, 4194.0, 4194.6853985951175, 4231.851885184004, 4236.428082208924, 3679.2641471705765, 3689.7417180797624, 3734.1224812169116, 3774.830132644038, 3776.66010059096, 1183.9526418943146, 1198.1193822540426, 1203.9939800300942, 1215.380156120385, 1223.4311045363947, 929.9953500232456, 1303.817465554823, 1310.744404841066, 1323.4573824731813, 1336.0647546717337, 6396.584222025646, 7467.327940485382, 7530.6611202496015, 7622.428317876071, 7633.847323053508, 596.2904144068544, 597.7877853362081, 599.7990673124552, 612.650789050246, 621.8787336469436, 5748.942510574924, 5800.187973683687, 5852.619579727304, 5862.765489380377, 5867.9413205867395, 9245.075492450836, 9413.717588472357, 9517.0, 9518.571664275125, 9522.047795220422, 9101.362904596746, 9346.15884570392, 9353.345265831462, 9362.0, 9366.578503967337, 7194.136703595497, 7266.854662906712, 7277.163126240444, 7279.563226206445, 7282.745103921443, 6893.448524118159, 7063.328983746535, 7070.964645176741, 7077.044598979072, 7085.362317391459, 8147.0, 8183.672653094048, 8208.917910821054, 8404.579771011548, 8417.326613870999, 8378.53918034514, 8550.700725474579, 8551.187637174458, 8551.187637174458, 8575.442596231225, 6684.632345220865, 6730.899036514358, 6733.124693789776, 6739.629320387426, 6741.52809303344, 7276.0, 7281.05346304977, 7283.344498995116, 7299.671514781954, 7350.044494215717, 6953.895691564529, 6966.721331146698, 7090.290970902868, 7135.785926422215, 7167.7132914682825, 6823.624700641512, 6904.792856214322, 6972.860542789217, 7009.719611215494, 7116.964415177891, 6150.446459818638, 6295.276043255084, 7066.929330706627, 7070.929290707027, 7077.5753454792875, 6337.176167098248, 6455.67721613908, 6468.611883287018, 6483.578567393104, 6484.221893372825, 6431.549791514736, 6458.838529036624, 6461.224653041665, 6467.514936379885, 6486.610803351814], "unit": "ms", "name": "mootools.html", "value": 4398.761474734699}, {"lowerIsBetter": false, "replicates": [339.84027507071676, 341.7129611126653, 347.591579893625, 350.3448551209239, 351.5113991551745, 5912.704364781765, 5915.438033386827, 5976.402359764033, 5978.910316345253, 5986.580939334238, 5616.101423772197, 5731.942680573193, 5778.0466223073245, 5897.616654917428, 5897.823065308037, 4595.356650068993, 4610.838620648278, 4615.353850460921, 4628.490866004737, 4633.930491042629, 4605.332226827108, 4611.3544103825325, 4612.354270402129, 4618.792154353062, 4625.676202665814, 4365.148795984785, 4430.246858034126, 4438.977805110986, 4448.110377924428, 4449.688521803475, 4444.97777511112, 4503.1218912312115, 4511.458624964992, 4512.1878061949, 4513.458384993789, 3960.683145348365, 3973.562908080109, 3989.7007724420496, 3990.620891015349, 3998.800059997018, 5568.749406276727, 5572.136318870582, 5614.242077319591, 5619.662820230758, 5624.29696287964, 5192.844214673566, 5266.34170728659, 5285.524302812765, 5312.3890752563175, 5327.254184414185, 6295.0872123542285, 6313.053042043684, 6314.210723659543, 6318.399752023551, 6319.715612797435, 4424.269995450747, 4424.491183513873, 4431.756253406062, 4433.645308375322, 4434.157510073108, 6390.712417941158, 6574.2110946686225, 6574.408303252682, 6578.243501997236, 6579.736810527621, 4473.6868419211, 4506.301523263899, 4508.639308855284, 4510.954890451119, 4512.029913568533, 4534.2745160774775, 4561.178987782165, 4565.360849481075, 4566.292224705176, 4567.908641827211, 5275.498827611371, 5288.7091209983055, 5290.153575427913, 5290.1800220965815, 5293.338332708411, 6168.9691551541955, 6374.043893416025, 6376.139221205078, 6380.585261957958, 6383.840403989938, 1586.7778511008469, 1608.6058915565761, 1610.1868556378954, 1611.6615510742874, 1612.3550579767953, 1028.783955369381, 1030.2685093583489, 1032.9896701032894, 1046.2676126711333, 1072.4423299884018, 6152.569320147547, 6166.876662466726, 6172.783952561728, 6173.166622505994, 6176.197094377702, 6513.348665133543, 6521.0544471051435, 6527.8694426111215, 6530.216374035052, 6536.738530458729, 6008.579399442085, 6091.969540152271, 6095.8476038098515, 6102.05418160177, 6237.656928868865, 3528.4530897710897, 3538.3100295442655, 3554.306910152495, 3554.360215161244, 3556.76881002734, 6854.3145685432055, 6855.177378714487, 6856.280090590416, 6862.897056544156, 6872.484563657746, 6595.4393876521035, 6765.42493888025, 6768.69540870662, 6770.729170833111, 6785.796426107225, 6844.21291551468, 6849.4177994871, 6855.177378714586, 6858.0, 6859.2166036829785, 6569.770058047945, 6574.671266436755, 6574.934250657432, 6589.308122647053, 6599.373059559334, 6392.169018027626, 6523.3150519194805, 6567.737290508326, 6574.704138313883, 6607.3062328456745, 6850.177978642595, 6893.069940416692, 6897.241303456716, 6904.827379315558, 6921.48088893325, 4475.216837053437, 4505.234110201208, 4506.977465112654, 4508.030773383738, 4509.774511274358, 6519.865058127535, 6558.475321974135, 6600.306967768315, 6606.8017959461295, 6612.801615951529, 6413.615183089029, 6417.422431981144, 6419.325970773189, 6421.775237866652, 6432.35676432353, 6371.267304260069, 6375.171227740364, 6377.2984971654005, 6384.0, 6393.104965304954, 6135.570510064253, 6255.53083518747, 6263.060540918898, 6287.993920972623, 6291.591046581958, 6408.455281301141, 6413.35866413355, 6419.743210271537, 6422.293547709654, 6442.8389290268115, 6281.43467087946, 6283.057541368831, 6284.968575157095, 6293.716782744696, 6298.244210694746], "unit": "ms", "name": "prototype.html", "value": 4791.7553316309295}, {"lowerIsBetter": false, "replicates": [849.6631586252706, 857.3569822633025, 865.1435079271523, 876.294582860797, 876.3602570123811, 13548.119372240797, 14009.50966716164, 14090.859091409084, 14091.647708807272, 14099.859001409983, 13396.933015334935, 13454.730905381886, 13470.461181552751, 13482.797758033637, 13484.66288342792, 688.8415664397191, 692.7817737412724, 822.1942496353577, 829.0424559633618, 833.3749687734199, 837.2757564706516, 841.221869770463, 844.2697067037, 845.9365547583925, 846.2510678049908, 873.7378786364097, 874.4490970688457, 876.3339861705118, 876.6843936182969, 876.9298456123495, 725.9673314700851, 729.3508777188307, 853.4154104438448, 861.1861790607878, 861.4185424838272, 636.7198432689648, 637.8564822914853, 637.894747366684, 640.8269767162886, 641.9101325814389, 13738.519151829638, 13780.724385512234, 13883.722325553534, 13940.651483712887, 13991.0, 11509.48207330672, 12369.443375048055, 12434.564790232298, 12615.936920315431, 13402.664933376645, 10260.435676037814, 10419.895801041968, 10439.843402348972, 10526.10528105112, 10701.785964280749, 3563.516615108252, 3627.7097832173363, 3657.926841463156, 3669.9816500917323, 3679.521662183926, 44841.55158448406, 44996.55003449989, 45279.77360113178, 45313.320300195526, 45507.0, 10439.112675422673, 10455.0, 10490.0, 10526.526306316235, 10575.62985295511, 18285.725714114298, 18328.816711832977, 18340.81659183391, 18348.541286467946, 18371.90814045921, 7554.811129721691, 7751.147373788879, 7783.688652453951, 7824.37405007598, 7843.7254696085365, 4309.612134907873, 4415.602595766396, 4425.336199570091, 4434.955650443454, 4471.754053527087, 3106.7669924755733, 3140.7173354398215, 3141.5758872551914, 3142.3715256948703, 3156.021633293686, 591.1487458060379, 599.1342510072902, 602.3795490644643, 608.8417011576934, 614.665007570875, 652.9934700652933, 656.9638669873203, 673.2358772792818, 714.2429025233165, 715.6994062493765, 8520.786980325542, 8604.719749266449, 8616.35377346689, 8623.439476434012, 8932.19610235069, 547.151914532481, 559.1193869655309, 559.2031355318736, 561.9522340601013, 612.0757655939475, 3751.174741556853, 3772.641599048086, 3920.686569999082, 3926.823292951824, 4158.521769996429, 59130.70434647885, 60116.0, 60202.39797601968, 60489.0, 60738.0, 52059.47940520622, 52400.47599523956, 52971.47028529742, 53188.202176967374, 53517.46482535125, 46029.07941841144, 46096.769516152206, 46956.90426558238, 47217.05565888663, 47303.526964729914, 8645.740627781177, 8675.436096653697, 8825.293976481995, 9476.336656433983, 9522.238220942447, 36405.0, 36666.0, 36923.446148308336, 38479.0, 38483.615163848, 42940.570594293655, 48579.5142048575, 49157.75421122871, 49499.0, 50322.49677503324, 12035.939820300842, 12073.57742479009, 12125.090618203494, 12241.571544995883, 12819.359032048547, 12635.684107897376, 12789.0, 13044.478220871059, 13532.255725935169, 13538.255395952923, 11929.701757456132, 12203.901648851646, 12562.246265224116, 12919.612411627666, 12935.805962910752, 11669.241499302518, 12352.814707779571, 12462.875371246171, 12469.189502682297, 12498.25010499373, 11479.311241325548, 11804.763904721685, 12080.0, 12190.57332993341, 12587.181833180814, 8993.190612844875, 9040.276777857887, 9465.100815422524, 9521.523923803643, 9805.215582753506, 7525.2098529653595, 7678.8080297993, 7697.384209263358, 7712.035995500562, 7877.0], "unit": "ms", "name": "yui.html", "value": 6425.0459180741445}], "name": "dromaeo_css", "value": 7080.552872125426}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 104.0, 110.0, 110.0, 109.0, 99.0, 110.0, 110.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 149.0, 161.0, 139.0, 155.0, 150.0, 125.0, 166.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 158.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 93.0, 97.0, 72.0, 72.0, 74.0, 98.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 134.0, 93.0, 94.0, 93.0, 139.0, 93.0, 93.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 158.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 60.0, 62.0, 61.0, 61.0, 69.0, 59.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 72.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 91.0, 92.0, 85.0, 84.0, 83.0, 83.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 117.0, 126.0, 124.0, 116.0, 122.0, 116.0, 122.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [144.0, 159.0, 153.0, 151.0, 154.0, 144.0, 145.0, 151.0, 152.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1502.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [182.7485380116959], "unit": "score", "name": "Richards", "value": 193.17254399999996}, {"lowerIsBetter": false, "replicates": [191.16803670426305], "unit": "score", "name": "DeltaBlue", "value": 345.8632580000001}, {"lowerIsBetter": false, "replicates": [282.16704288939053], "unit": "score", "name": "Encrypt", "value": 943.3454639999995}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1941.7475728155339], "unit": "score", "name": "RayTrace", "value": 381.094335}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [642.2607578676943], "unit": "score", "name": "Splay", "value": 126.88148699999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19620.188184943498}]} 07:08:01 INFO - RETURN: dromaeo_css: 7080.56 07:08:01 INFO - RETURN: kraken: 1502.70 07:08:01 INFO - RETURN: v8_7: 19620.19 07:08:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19620.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1502.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "7080.56"}}} 07:08:01 INFO - Return code: 0 07:08:01 INFO - # TBPL SUCCESS # 07:08:01 INFO - Running post-action listener: _resource_record_post_action 07:08:01 INFO - Running post-run listener: _resource_record_post_run 07:08:02 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 24576; Write bytes: 506380288; Read time: 4832; Write time: 845348 07:08:02 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 130506752; Read time: 0; Write time: 178632 07:08:02 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 20480; Write bytes: 360738816; Read time: 3576; Write time: 560688 07:08:02 INFO - Running post-run listener: _upload_blobber_files 07:08:02 INFO - Blob upload gear active. 07:08:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:08:02 INFO - Copying logs to upload dir... 07:08:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.000948 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-23 07:08:01.625052) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:08:01.628634) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010012 build_url: 'https://queue.taskcluster.net/v1/task/WdWDprL5QV2RJs1ZFIdh4A/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:08:01.679375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:08:01.679707) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1448289554.946829-2131473776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:08:01.729491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:08:01.729812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:08:01.730116) ========= ========= Total master_lag: 0.17 =========