builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1448268518.64 results: success (0) buildid: 20151122233003 builduid: a47ec66d713e415faa3bae2ac8c2f734 revision: f92df94073a3c3aca1b7b372c3a1fff843bbf127 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.637266) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.637699) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.637986) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008950 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.668637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.668917) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.729782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.730073) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.779645) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.779902) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.780277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.780555) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 00:48:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-23 00:48:39 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.977499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:38.977770) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.026640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.026954) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f92df94073a3c3aca1b7b372c3a1fff843bbf127 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f92df94073a3c3aca1b7b372c3a1fff843bbf127 --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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 00:48:39,315 truncating revision to first 12 chars 2015-11-23 00:48:39,315 Setting DEBUG logging. 2015-11-23 00:48:39,315 attempt 1/10 2015-11-23 00:48:39,315 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f92df94073a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 00:48:39,632 unpacking tar archive at: b2g-inbound-f92df94073a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.643920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.644252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.762785) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.763058) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 00:48:39.763449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 00:48:39.763735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:48:40 INFO - MultiFileLogger online at 20151123 00:48:40 in /builds/slave/test-pgo 00:48:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 00:48:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:48:40 INFO - {'append_to_log': False, 00:48:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:48:40 INFO - 'blob_upload_branch': 'B2G-Inbound', 00:48:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:48:40 INFO - 'branch': 'B2G-Inbound', 00:48:40 INFO - 'buildbot_json_path': 'buildprops.json', 00:48:40 INFO - 'config_files': ('talos/linux_config.py',), 00:48:40 INFO - 'default_actions': ('clobber', 00:48:40 INFO - 'read-buildbot-config', 00:48:40 INFO - 'download-and-extract', 00:48:40 INFO - 'populate-webroot', 00:48:40 INFO - 'create-virtualenv', 00:48:40 INFO - 'install', 00:48:40 INFO - 'run-tests'), 00:48:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:48:40 INFO - 'download_minidump_stackwalk': True, 00:48:40 INFO - 'download_symbols': 'ondemand', 00:48:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:48:40 INFO - 'tooltool.py': '/tools/tooltool.py', 00:48:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:48:40 INFO - '/tools/misc-python/virtualenv.py')}, 00:48:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:48:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:48:40 INFO - 'installer_path': 'installer.exe', 00:48:40 INFO - 'log_level': 'info', 00:48:40 INFO - 'log_name': 'talos', 00:48:40 INFO - 'log_to_console': True, 00:48:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:48:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:48:40 INFO - 'opt_config_files': (), 00:48:40 INFO - 'pip_index': False, 00:48:40 INFO - 'sps_profile': False, 00:48:40 INFO - 'sps_profile_interval': 0, 00:48:40 INFO - 'suite': 'dromaeojs', 00:48:40 INFO - 'system_bits': '64', 00:48:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:48:40 INFO - 'title': 'talos-linux64-ix-067', 00:48:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:48:40 INFO - 'use_talos_json': True, 00:48:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:48:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:48:40 INFO - 'work_dir': 'build'} 00:48:40 INFO - ##### 00:48:40 INFO - ##### Running clobber step. 00:48:40 INFO - ##### 00:48:40 INFO - Running pre-action listener: _resource_record_pre_action 00:48:40 INFO - Running main action method: clobber 00:48:40 INFO - rmtree: /builds/slave/test-pgo/build 00:48:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:48:40 INFO - Running post-action listener: _resource_record_post_action 00:48:40 INFO - ##### 00:48:40 INFO - ##### Running read-buildbot-config step. 00:48:40 INFO - ##### 00:48:40 INFO - Running pre-action listener: _resource_record_pre_action 00:48:40 INFO - Running main action method: read_buildbot_config 00:48:40 INFO - Using buildbot properties: 00:48:40 INFO - { 00:48:40 INFO - "properties": { 00:48:40 INFO - "buildnumber": 996, 00:48:40 INFO - "product": "firefox", 00:48:40 INFO - "script_repo_revision": "production", 00:48:40 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:48:40 INFO - "repository": "", 00:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 00:48:40 INFO - "buildid": "20151122233003", 00:48:40 INFO - "slavename": "talos-linux64-ix-067", 00:48:40 INFO - "pgo_build": "True", 00:48:40 INFO - "basedir": "/builds/slave/test-pgo", 00:48:40 INFO - "project": "", 00:48:40 INFO - "platform": "ubuntu64_hw", 00:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:48:40 INFO - "slavebuilddir": "test", 00:48:40 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 00:48:40 INFO - "branch": "b2g-inbound", 00:48:40 INFO - "repo_path": "integration/b2g-inbound", 00:48:40 INFO - "stage_platform": "linux64-pgo", 00:48:40 INFO - "builduid": "a47ec66d713e415faa3bae2ac8c2f734", 00:48:40 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 00:48:40 INFO - }, 00:48:40 INFO - "sourcestamp": { 00:48:40 INFO - "repository": "", 00:48:40 INFO - "hasPatch": false, 00:48:40 INFO - "project": "", 00:48:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:48:40 INFO - "changes": [ 00:48:40 INFO - { 00:48:40 INFO - "category": null, 00:48:40 INFO - "files": [ 00:48:40 INFO - { 00:48:40 INFO - "url": null, 00:48:40 INFO - "name": "https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:48:40 INFO - } 00:48:40 INFO - ], 00:48:40 INFO - "repository": "", 00:48:40 INFO - "rev": "f92df94073a3c3aca1b7b372c3a1fff843bbf127", 00:48:40 INFO - "who": "sendchange", 00:48:40 INFO - "when": 1448268464, 00:48:40 INFO - "number": 6694363, 00:48:40 INFO - "comments": "", 00:48:40 INFO - "project": "", 00:48:40 INFO - "at": "Mon 23 Nov 2015 00:47:44", 00:48:40 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 00:48:40 INFO - "revlink": "", 00:48:40 INFO - "properties": [ 00:48:40 INFO - [ 00:48:40 INFO - "buildid", 00:48:40 INFO - "20151122233003", 00:48:40 INFO - "Change" 00:48:40 INFO - ], 00:48:40 INFO - [ 00:48:40 INFO - "builduid", 00:48:40 INFO - "a47ec66d713e415faa3bae2ac8c2f734", 00:48:40 INFO - "Change" 00:48:40 INFO - ], 00:48:40 INFO - [ 00:48:40 INFO - "pgo_build", 00:48:40 INFO - "True", 00:48:40 INFO - "Change" 00:48:40 INFO - ] 00:48:40 INFO - ], 00:48:40 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 00:48:40 INFO - } 00:48:40 INFO - ], 00:48:40 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 00:48:40 INFO - } 00:48:40 INFO - } 00:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:48:40 INFO - Running post-action listener: _resource_record_post_action 00:48:40 INFO - ##### 00:48:40 INFO - ##### Running download-and-extract step. 00:48:40 INFO - ##### 00:48:40 INFO - Running pre-action listener: _resource_record_pre_action 00:48:40 INFO - Running main action method: download_and_extract 00:48:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:40 INFO - https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/test_packages.json 00:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/test_packages.json 00:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:48:41 INFO - Downloaded 1302 bytes. 00:48:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:48:41 INFO - Using the following test package requirements: 00:48:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:48:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'jsshell-linux-x86_64.zip'], 00:48:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:48:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:48:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:48:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:48:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:48:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:48:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:48:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:48:41 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')]} 00:48:41 INFO - https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:42 INFO - Downloaded 22522872 bytes. 00:48:42 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 00:48:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:42 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 00:48:43 INFO - Return code: 0 00:48:43 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 00:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:43 INFO - https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:44 INFO - Downloaded 22522872 bytes. 00:48:44 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 00:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:48:44 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 00:48:46 INFO - Return code: 0 00:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:46 INFO - https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:47 INFO - Downloaded 11130997 bytes. 00:48:47 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 00:48:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:48:47 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 00:48:48 INFO - Return code: 0 00:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:48:48 INFO - https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 00:48:49 INFO - Downloaded 57435978 bytes. 00:48:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:49 INFO - mkdir: /builds/slave/test-pgo/properties 00:48:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:48:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:48:49 INFO - Contents: 00:48:49 INFO - build_url:https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:48:49 INFO - Running post-action listener: _resource_record_post_action 00:48:49 INFO - Running post-action listener: set_extra_try_arguments 00:48:49 INFO - ##### 00:48:49 INFO - ##### Running populate-webroot step. 00:48:49 INFO - ##### 00:48:49 INFO - Running pre-action listener: _resource_record_pre_action 00:48:49 INFO - Running main action method: populate_webroot 00:48:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:48:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:48:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:48:49 INFO - '../fennec_ids.txt'], 00:48:49 INFO - 'tests': ['tcheck2']}, 00:48:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:48:49 INFO - '--tppagecycles', 00:48:49 INFO - '7'], 00:48:49 INFO - 'tests': ['tsvgm']}}, 00:48:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:48:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:48:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:48:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:48:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'tests': ['damp', 'tps']}, 00:48:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['damp', 'tps']}, 00:48:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:48:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:48:49 INFO - 'other': {'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'other_l64': {'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'other_nol64': {'tests': ['a11yr', 00:48:49 INFO - 'ts_paint', 00:48:49 INFO - 'tpaint', 00:48:49 INFO - 'sessionrestore', 00:48:49 INFO - 'sessionrestore_no_auto_restore']}, 00:48:49 INFO - 'svgr': {'tests': ['tsvgx', 00:48:49 INFO - 'tsvgr_opacity', 00:48:49 INFO - 'tart', 00:48:49 INFO - 'tscrollx', 00:48:49 INFO - 'cart']}, 00:48:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['tsvgx', 00:48:49 INFO - 'tsvgr_opacity', 00:48:49 INFO - 'tart', 00:48:49 INFO - 'tscrollx', 00:48:49 INFO - 'cart']}, 00:48:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'tests': ['tp5o']}, 00:48:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'talos_options': ['--e10s'], 00:48:49 INFO - 'tests': ['tp5o']}, 00:48:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'talos_options': ['--xperf_path', 00:48:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:49 INFO - 'tests': ['tp5n']}, 00:48:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:48:49 INFO - 'talos_options': ['--e10s', 00:48:49 INFO - '--xperf_path', 00:48:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:48:49 INFO - 'tests': ['tp5n']}}, 00:48:49 INFO - 'talos.zip': {'path': '', 00:48:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:48:49 INFO - Running post-action listener: _resource_record_post_action 00:48:49 INFO - ##### 00:48:49 INFO - ##### Running create-virtualenv step. 00:48:49 INFO - ##### 00:48:49 INFO - Running pre-action listener: _resource_record_pre_action 00:48:49 INFO - Running main action method: create_virtualenv 00:48:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:48:49 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 00:48:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:48:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:48:49 INFO - Using real prefix '/usr' 00:48:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:48:50 INFO - Installing distribute.............................................................................................................................................................................................done. 00:48:52 INFO - Installing pip.................done. 00:48:52 INFO - Return code: 0 00:48:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:48:52 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')]} 00:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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')]} 00:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:48:52 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 00:48:52 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 00:48:52 INFO - Using env: {'DISPLAY': ':0', 00:48:52 INFO - 'HOME': '/home/cltbld', 00:48:52 INFO - 'LANG': 'en_US.UTF-8', 00:48:52 INFO - 'LANGUAGE': 'en_US:en', 00:48:52 INFO - 'LOGNAME': 'cltbld', 00:48:52 INFO - 'MAIL': '/var/mail/cltbld', 00:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:52 INFO - 'MOZ_NO_REMOTE': '1', 00:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:52 INFO - 'NO_EM_RESTART': '1', 00:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:52 INFO - 'SHELL': '/bin/bash', 00:48:52 INFO - 'SHLVL': '1', 00:48:52 INFO - 'TERM': 'linux', 00:48:52 INFO - 'TMOUT': '86400', 00:48:52 INFO - 'USER': 'cltbld', 00:48:52 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:52 INFO - '_': '/tools/buildbot/bin/python'} 00:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:52 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 00:48:52 INFO - Cleaning up... 00:48:52 INFO - Return code: 0 00:48:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:48:52 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')]} 00:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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')]} 00:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:52 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:48:52 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 00:48:52 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 00:48:52 INFO - Using env: {'DISPLAY': ':0', 00:48:52 INFO - 'HOME': '/home/cltbld', 00:48:52 INFO - 'LANG': 'en_US.UTF-8', 00:48:52 INFO - 'LANGUAGE': 'en_US:en', 00:48:52 INFO - 'LOGNAME': 'cltbld', 00:48:52 INFO - 'MAIL': '/var/mail/cltbld', 00:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:52 INFO - 'MOZ_NO_REMOTE': '1', 00:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:52 INFO - 'NO_EM_RESTART': '1', 00:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:52 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:52 INFO - 'SHELL': '/bin/bash', 00:48:52 INFO - 'SHLVL': '1', 00:48:52 INFO - 'TERM': 'linux', 00:48:52 INFO - 'TMOUT': '86400', 00:48:52 INFO - 'USER': 'cltbld', 00:48:52 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:52 INFO - '_': '/tools/buildbot/bin/python'} 00:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:52 INFO - Downloading/unpacking psutil>=0.7.1 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:52 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 00:48:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 00:48:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:48:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:54 INFO - Installing collected packages: psutil 00:48:54 INFO - Running setup.py install for psutil 00:48:54 INFO - building 'psutil._psutil_linux' extension 00:48:54 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 00:48:54 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 00:48:54 INFO - building 'psutil._psutil_posix' extension 00:48:54 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 00:48:54 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 00:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:48:54 INFO - Successfully installed psutil 00:48:54 INFO - Cleaning up... 00:48:55 INFO - Return code: 0 00:48:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:48:55 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')]} 00:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:55 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')]} 00:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:55 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:48:55 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 00:48:55 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 00:48:55 INFO - Using env: {'DISPLAY': ':0', 00:48:55 INFO - 'HOME': '/home/cltbld', 00:48:55 INFO - 'LANG': 'en_US.UTF-8', 00:48:55 INFO - 'LANGUAGE': 'en_US:en', 00:48:55 INFO - 'LOGNAME': 'cltbld', 00:48:55 INFO - 'MAIL': '/var/mail/cltbld', 00:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:55 INFO - 'MOZ_NO_REMOTE': '1', 00:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:55 INFO - 'NO_EM_RESTART': '1', 00:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:55 INFO - 'SHELL': '/bin/bash', 00:48:55 INFO - 'SHLVL': '1', 00:48:55 INFO - 'TERM': 'linux', 00:48:55 INFO - 'TMOUT': '86400', 00:48:55 INFO - 'USER': 'cltbld', 00:48:55 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:55 INFO - '_': '/tools/buildbot/bin/python'} 00:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:48:55 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 00:48:55 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 00:48:55 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 00:48:55 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 00:48:55 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 00:48:55 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 00:48:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:48:56 INFO - Installing collected packages: mozsystemmonitor 00:48:56 INFO - Running setup.py install for mozsystemmonitor 00:48:57 INFO - Successfully installed mozsystemmonitor 00:48:57 INFO - Cleaning up... 00:48:57 INFO - Return code: 0 00:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:48: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')]} 00:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48: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')]} 00:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:48:57 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:48:57 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 00:48:57 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 00:48:57 INFO - Using env: {'DISPLAY': ':0', 00:48:57 INFO - 'HOME': '/home/cltbld', 00:48:57 INFO - 'LANG': 'en_US.UTF-8', 00:48:57 INFO - 'LANGUAGE': 'en_US:en', 00:48:57 INFO - 'LOGNAME': 'cltbld', 00:48:57 INFO - 'MAIL': '/var/mail/cltbld', 00:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:57 INFO - 'MOZ_NO_REMOTE': '1', 00:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:48:57 INFO - 'NO_EM_RESTART': '1', 00:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:48:57 INFO - 'SHELL': '/bin/bash', 00:48:57 INFO - 'SHLVL': '1', 00:48:57 INFO - 'TERM': 'linux', 00:48:57 INFO - 'TMOUT': '86400', 00:48:57 INFO - 'USER': 'cltbld', 00:48:57 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:57 INFO - '_': '/tools/buildbot/bin/python'} 00:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:57 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 00:48:58 INFO - Downloading blobuploader-1.2.4.tar.gz 00:48:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:48:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:48:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:48:59 INFO - Downloading docopt-0.6.1.tar.gz 00:48:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:48:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:48:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:48:59 INFO - Running setup.py install for blobuploader 00:48:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:48:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:48:59 INFO - Running setup.py install for requests 00:49:00 INFO - Running setup.py install for docopt 00:49:00 INFO - Successfully installed blobuploader requests docopt 00:49:00 INFO - Cleaning up... 00:49:00 INFO - Return code: 0 00:49:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:00 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')]} 00:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:00 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')]} 00:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:00 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:49:00 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 00:49:00 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 00:49:00 INFO - Using env: {'DISPLAY': ':0', 00:49:00 INFO - 'HOME': '/home/cltbld', 00:49:00 INFO - 'LANG': 'en_US.UTF-8', 00:49:00 INFO - 'LANGUAGE': 'en_US:en', 00:49:00 INFO - 'LOGNAME': 'cltbld', 00:49:00 INFO - 'MAIL': '/var/mail/cltbld', 00:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:00 INFO - 'MOZ_NO_REMOTE': '1', 00:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:00 INFO - 'NO_EM_RESTART': '1', 00:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:00 INFO - 'SHELL': '/bin/bash', 00:49:00 INFO - 'SHLVL': '1', 00:49:00 INFO - 'TERM': 'linux', 00:49:00 INFO - 'TMOUT': '86400', 00:49:00 INFO - 'USER': 'cltbld', 00:49:00 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:00 INFO - '_': '/tools/buildbot/bin/python'} 00:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:00 INFO - Running setup.py (path:/tmp/pip-9XpLG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:00 INFO - Running setup.py (path:/tmp/pip-msjZpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:00 INFO - Running setup.py (path:/tmp/pip-sVX_VF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:00 INFO - Running setup.py (path:/tmp/pip-4dYhfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:00 INFO - Running setup.py (path:/tmp/pip-LOalwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:00 INFO - Running setup.py (path:/tmp/pip-Y6kpXz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:00 INFO - Running setup.py (path:/tmp/pip-Hv_SPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:00 INFO - Running setup.py (path:/tmp/pip-2CwgNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:01 INFO - Running setup.py (path:/tmp/pip-WJLCQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:01 INFO - Running setup.py (path:/tmp/pip-puZ3a0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:01 INFO - Running setup.py (path:/tmp/pip-GJQLca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:01 INFO - Running setup.py (path:/tmp/pip-Vm8pOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:01 INFO - Running setup.py (path:/tmp/pip-z6kql2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:01 INFO - Running setup.py (path:/tmp/pip-VHK1Mu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:01 INFO - Running setup.py (path:/tmp/pip-ezvjhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:01 INFO - Running setup.py (path:/tmp/pip-7wsj7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:01 INFO - Running setup.py (path:/tmp/pip-kChAsJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:01 INFO - Running setup.py install for manifestparser 00:49:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:01 INFO - Running setup.py install for mozcrash 00:49:01 INFO - Running setup.py install for mozdebug 00:49:02 INFO - Running setup.py install for mozdevice 00:49:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozfile 00:49:02 INFO - Running setup.py install for mozhttpd 00:49:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozinfo 00:49:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozInstall 00:49:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozleak 00:49:02 INFO - Running setup.py install for mozlog 00:49:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for moznetwork 00:49:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:02 INFO - Running setup.py install for mozprocess 00:49:02 INFO - Running setup.py install for mozprofile 00:49:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:03 INFO - Running setup.py install for mozrunner 00:49:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:03 INFO - Running setup.py install for mozscreenshot 00:49:03 INFO - Running setup.py install for moztest 00:49:03 INFO - Running setup.py install for mozversion 00:49:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:03 INFO - Cleaning up... 00:49:03 INFO - Return code: 0 00:49:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:49:03 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 00:49:03 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 00:49:03 INFO - Using env: {'DISPLAY': ':0', 00:49:03 INFO - 'HOME': '/home/cltbld', 00:49:03 INFO - 'LANG': 'en_US.UTF-8', 00:49:03 INFO - 'LANGUAGE': 'en_US:en', 00:49:03 INFO - 'LOGNAME': 'cltbld', 00:49:03 INFO - 'MAIL': '/var/mail/cltbld', 00:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:03 INFO - 'MOZ_NO_REMOTE': '1', 00:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:03 INFO - 'NO_EM_RESTART': '1', 00:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:03 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:03 INFO - 'SHELL': '/bin/bash', 00:49:03 INFO - 'SHLVL': '1', 00:49:03 INFO - 'TERM': 'linux', 00:49:03 INFO - 'TMOUT': '86400', 00:49:03 INFO - 'USER': 'cltbld', 00:49:03 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:03 INFO - '_': '/tools/buildbot/bin/python'} 00:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:03 INFO - Running setup.py (path:/tmp/pip-ebjHh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:03 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)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:03 INFO - Running setup.py (path:/tmp/pip-LeWe_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:03 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)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:03 INFO - Running setup.py (path:/tmp/pip-3v3hXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:03 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)) 00:49:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:03 INFO - Running setup.py (path:/tmp/pip-J7ZsBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:04 INFO - Running setup.py (path:/tmp/pip-y64y9c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:04 INFO - Running setup.py (path:/tmp/pip-rS2nyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:04 INFO - Running setup.py (path:/tmp/pip-hvM80v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:04 INFO - Running setup.py (path:/tmp/pip-73GsYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:04 INFO - Running setup.py (path:/tmp/pip-8HTVnJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:04 INFO - Running setup.py (path:/tmp/pip-N1ySrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:04 INFO - Running setup.py (path:/tmp/pip-c7k7vs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:04 INFO - Running setup.py (path:/tmp/pip-mLIpHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:04 INFO - Running setup.py (path:/tmp/pip-rleJX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:04 INFO - Running setup.py (path:/tmp/pip-3e_URB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:04 INFO - Running setup.py (path:/tmp/pip-qmxHFl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:04 INFO - Running setup.py (path:/tmp/pip-F9SKVl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:04 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)) 00:49:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:04 INFO - Running setup.py (path:/tmp/pip-8Uu6f7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:04 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)) 00:49:04 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)) 00:49:04 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)) 00:49:04 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)) 00:49:04 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)) 00:49:04 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)) 00:49:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:06 INFO - Downloading blessings-1.5.1.tar.gz 00:49:06 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 00:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:06 INFO - Installing collected packages: blessings 00:49:06 INFO - Running setup.py install for blessings 00:49:06 INFO - Successfully installed blessings 00:49:06 INFO - Cleaning up... 00:49:06 INFO - Return code: 0 00:49:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:07 INFO - Reading from file tmpfile_stdout 00:49:07 INFO - Current package versions: 00:49:07 INFO - argparse == 1.2.1 00:49:07 INFO - blessings == 1.5.1 00:49:07 INFO - blobuploader == 1.2.4 00:49:07 INFO - docopt == 0.6.1 00:49:07 INFO - manifestparser == 1.1 00:49:07 INFO - mozInstall == 1.12 00:49:07 INFO - mozcrash == 0.16 00:49:07 INFO - mozdebug == 0.1 00:49:07 INFO - mozdevice == 0.47 00:49:07 INFO - mozfile == 1.2 00:49:07 INFO - mozhttpd == 0.7 00:49:07 INFO - mozinfo == 0.9 00:49:07 INFO - mozleak == 0.1 00:49:07 INFO - mozlog == 3.0 00:49:07 INFO - moznetwork == 0.27 00:49:07 INFO - mozprocess == 0.22 00:49:07 INFO - mozprofile == 0.27 00:49:07 INFO - mozrunner == 6.11 00:49:07 INFO - mozscreenshot == 0.1 00:49:07 INFO - mozsystemmonitor == 0.0 00:49:07 INFO - moztest == 0.7 00:49:07 INFO - mozversion == 1.4 00:49:07 INFO - psutil == 3.1.1 00:49:07 INFO - requests == 1.2.3 00:49:07 INFO - wsgiref == 0.1.2 00:49:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:07 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')]} 00:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:07 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')]} 00:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:07 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 0x7fbfbaf06c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a936c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b457c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, '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': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', '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 00:49:07 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 00:49:07 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 00:49:07 INFO - Using env: {'DISPLAY': ':0', 00:49:07 INFO - 'HOME': '/home/cltbld', 00:49:07 INFO - 'LANG': 'en_US.UTF-8', 00:49:07 INFO - 'LANGUAGE': 'en_US:en', 00:49:07 INFO - 'LOGNAME': 'cltbld', 00:49:07 INFO - 'MAIL': '/var/mail/cltbld', 00:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:07 INFO - 'MOZ_NO_REMOTE': '1', 00:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:07 INFO - 'NO_EM_RESTART': '1', 00:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:07 INFO - 'SHELL': '/bin/bash', 00:49:07 INFO - 'SHLVL': '1', 00:49:07 INFO - 'TERM': 'linux', 00:49:07 INFO - 'TMOUT': '86400', 00:49:07 INFO - 'USER': 'cltbld', 00:49:07 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:07 INFO - '_': '/tools/buildbot/bin/python'} 00:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 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)) 00:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 00:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 00:49:07 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)) 00:49:07 INFO - Cleaning up... 00:49:07 INFO - Return code: 0 00:49:07 INFO - Running post-action listener: _resource_record_post_action 00:49:07 INFO - Running post-action listener: _start_resource_monitoring 00:49:07 INFO - Starting resource monitoring. 00:49:07 INFO - ##### 00:49:07 INFO - ##### Running install step. 00:49:07 INFO - ##### 00:49:07 INFO - Running pre-action listener: _resource_record_pre_action 00:49:07 INFO - Running main action method: install 00:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:07 INFO - Reading from file tmpfile_stdout 00:49:07 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:49:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:49:07 INFO - Reading from file tmpfile_stdout 00:49:07 INFO - Output received: 00:49:07 INFO - Usage: mozinstall [options] installer 00:49:07 INFO - Options: 00:49:07 INFO - -h, --help show this help message and exit 00:49:07 INFO - -d DEST, --destination=DEST 00:49:07 INFO - Directory to install application into. [default: 00:49:07 INFO - "/builds/slave/test-pgo"] 00:49:07 INFO - --app=APP Application being installed. [default: firefox] 00:49:07 INFO - mkdir: /builds/slave/test-pgo/build/application 00:49:07 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'] 00:49:07 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 00:49:22 INFO - Reading from file tmpfile_stdout 00:49:22 INFO - Output received: 00:49:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:49:22 INFO - Running post-action listener: _resource_record_post_action 00:49:22 INFO - ##### 00:49:22 INFO - ##### Running run-tests step. 00:49:22 INFO - ##### 00:49:22 INFO - Running pre-action listener: _resource_record_pre_action 00:49:22 INFO - Running main action method: run_tests 00:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:49:22 INFO - Python 2.7.3 00:49:22 INFO - Return code: 0 00:49:22 INFO - grabbing minidump binary from tooltool 00:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:22 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 0x2b89d70>, '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 0x2b8ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b8afb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:49:22 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 00:49:22 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 00:49:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:49:22 INFO - Return code: 0 00:49:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:49:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:49:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:49:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 00:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 00:49:22 INFO - Using env: {'DISPLAY': ':0', 00:49:22 INFO - 'HOME': '/home/cltbld', 00:49:22 INFO - 'LANG': 'en_US.UTF-8', 00:49:22 INFO - 'LANGUAGE': 'en_US:en', 00:49:22 INFO - 'LOGNAME': 'cltbld', 00:49:22 INFO - 'MAIL': '/var/mail/cltbld', 00:49:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:22 INFO - 'MOZ_NO_REMOTE': '1', 00:49:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:22 INFO - 'NO_EM_RESTART': '1', 00:49:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:22 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:49:22 INFO - 'SHELL': '/bin/bash', 00:49:22 INFO - 'SHLVL': '1', 00:49:22 INFO - 'TERM': 'linux', 00:49:22 INFO - 'TMOUT': '86400', 00:49:22 INFO - 'USER': 'cltbld', 00:49:22 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932', 00:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:22 INFO - '_': '/tools/buildbot/bin/python'} 00:49:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 00:49:22 INFO - mozversion INFO | application_buildid: 20151122233003 00:49:22 INFO - mozversion INFO | application_changeset: f92df94073a3c3aca1b7b372c3a1fff843bbf127 00:49:22 INFO - mozversion INFO | application_display_name: Nightly 00:49:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:49:22 INFO - mozversion INFO | application_name: Firefox 00:49:22 INFO - mozversion INFO | application_remotingname: firefox 00:49:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:49:22 INFO - mozversion INFO | application_vendor: Mozilla 00:49:22 INFO - mozversion INFO | application_version: 45.0a1 00:49:22 INFO - mozversion INFO | platform_buildid: 20151122233003 00:49:22 INFO - mozversion INFO | platform_changeset: f92df94073a3c3aca1b7b372c3a1fff843bbf127 00:49:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:49:22 INFO - mozversion INFO | platform_version: 45.0a1 00:49:22 INFO - 2015-11-23 00:49:22,275 DEBUG : using testdate: 1448268562 00:49:22 INFO - 2015-11-23 00:49:22,275 DEBUG : actual date: 1448268562 00:49:22 INFO - 2015-11-23 00:49:22,323 INFO : starting webserver on 'localhost:45337' 00:49:22 INFO - 2015-11-23 00:49:22,324 INFO : Starting test suite talos-linux64-ix-067 00:49:22 INFO - 2015-11-23 00:49:22,324 INFO : Starting test dromaeo_css 00:49:22 INFO - 2015-11-23 00:49:22,324 DEBUG : operating with platform_type : linux_ 00:49:22 INFO - 2015-11-23 00:49:22,325 INFO : Initialising browser for dromaeo_css test... 00:49:22 INFO - 2015-11-23 00:49:22,338 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvulA6T/profile http://localhost:45337/getInfo.html 00:49:26 INFO - 2015-11-23 00:49:26,340 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:49:26 INFO - 2015-11-23 00:49:26,341 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:49:26 INFO - 2015-11-23 00:49:26,341 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:49:26 INFO - 2015-11-23 00:49:26,341 DEBUG : BROWSER_OUTPUT: __metrics 00:49:26 INFO - 2015-11-23 00:49:26,417 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:49:27 INFO - 2015-11-23 00:49:27,808 INFO : Browser initialized. 00:49:27 INFO - 2015-11-23 00:49:27,808 INFO : Running cycle 1/1 for dromaeo_css test... 00:49:27 INFO - 2015-11-23 00:49:27,809 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvulA6T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:49:39 INFO - 2015-11-23 00:49:39,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 00:49:39 INFO - 2015-11-23 00:49:39,491 DEBUG : BROWSER_OUTPUT: 00:50:31 INFO - 2015-11-23 00:50:31,034 DEBUG : BROWSER_OUTPUT: 1448268631030 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] 00:52:39 INFO - 2015-11-23 00:52:39,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45337/tests/dromaeo/cssquery-ext.html) 00:52:41 INFO - 2015-11-23 00:52:41,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 342249472 00:52:41 INFO - 2015-11-23 00:52:41,110 DEBUG : BROWSER_OUTPUT: 00:55:43 INFO - 2015-11-23 00:55:43,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-ext.html (next: http://localhost:45337/tests/dromaeo/cssquery-jquery.html) 00:55:44 INFO - 2015-11-23 00:55:44,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 233697280 00:55:44 INFO - 2015-11-23 00:55:44,255 DEBUG : BROWSER_OUTPUT: 00:58:46 INFO - 2015-11-23 00:58:46,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45337/tests/dromaeo/cssquery-mootools.html) 00:58:46 INFO - 2015-11-23 00:58:46,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 216129536 00:58:46 INFO - 2015-11-23 00:58:46,677 DEBUG : BROWSER_OUTPUT: 01:01:48 INFO - 2015-11-23 01:01:48,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45337/tests/dromaeo/cssquery-prototype.html) 01:01:49 INFO - 2015-11-23 01:01:49,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 204283904 01:01:49 INFO - 2015-11-23 01:01:49,103 DEBUG : BROWSER_OUTPUT: 01:04:51 INFO - 2015-11-23 01:04:51,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45337/tests/dromaeo/cssquery-yui.html) 01:04:52 INFO - 2015-11-23 01:04:52,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 207466496 01:04:52 INFO - 2015-11-23 01:04:52,284 DEBUG : BROWSER_OUTPUT: 01:07:54 INFO - 2015-11-23 01:07:54,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/dromaeo/cssquery-yui.html (next: http://localhost:45337/tests/dromaeo/cssquery-dojo.html) 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 236818432 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:07:55 INFO - 2015-11-23 01:07:55,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:07:55 INFO - 2015-11-23 01:07:55,055 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3207.8075315481074;3246.5130230465443;3289.3421315736846;3295.9670403295977;3296;5236.2931004314405;5342.866428339294;5448.046591846426;5473.425290344516;5508.504234618884;5322.20166974953;5443.319585051869;5446.2375267462585;5491.835244942648;5508.394076651565;4872.585830204419;4885.926711099345;4913.582345500637;4938.604911607063;4987.152184128707;4899.779509922062;5020.548150666439;5070.974645126769;5091.872703182432;5142.8714282143055;4954.033963377143;5003.174476211402;5003.224500202475;5029.245613158056;5033.395992480926;4991.276264941599;5030.84907452777;5035;5060.51925067118;5087.898242035176;4759;4863.343448634424;5004.9499505005215;5013.799448022075;5021.071101846133;5241.528262456397;5308;5308.92036619451;5325.946740532622;5327.600429967768;5957.523398128139;5962.224910761616;5968.850778730523;5980.671063091529;5982.282126144891;5732.541396688255;5880.911786323209;5967.7911273105665;5984.730687119047;5990.041593345088;5602.271704678447;5609.523190528769;5615.2700148980775;5616.269884914976;5640.661560306395;6028.517718582503;6034.788782392595;6052.485538729169;6057.545684073712;6067.0292753160165;5668.234788303526;5767.971160144256;5779.595428319977;5783.392743761929;5863.736131874076;5845.678487683218;5866.911996320058;5868.09044598088;5902.6458412495385;5910.704464776744;5817.7963771267805;5824;5872.588918775645;5903.822885313448;5928.7332070056955;5713.314402271754;5867.559933005042;5878.29460464747;5881.764729410861;5895.29256489224;4384.714993525411;4410.184115938561;4474.6420286377015;4542.159700455426;4553.203189441834;4067.3085575452246;4067.9593204067583;4077.6941729370415;4078.2455245779033;4102.0360215349365;5647.717614119278;5647.794095624106;5651.717414129277;5651.717414129277;5706.087026075808;5766;5787.739551720183;5817.505512031525;5875.294964604275;5960.225170727865;5619.690916999522;5627.043402621564;5681.971590142106;5685.943140568624;5688.601797874109;5186.844394668166;5188;5188.792448302102;5189.195674670432;5256.816011439581;5763.769449221984;5907.940920590825;6084.421979911901;6144.539159563051;6158.722857471335;5966.642001479751;5968.701564921824;5978.163057171912;5978.910316345346;6016.428439298435;6110.052941794029;6121.571489995836;6126.050462178369;6131.233595800525;6133.38666133401;5594.9720251398485;5646.265985422033;5712.857178570569;5765.221695071112;5882.970585147047;5923.170756094237;5924.851878703067;5932.970335148297;5935.376785437467;5936.406359364202;5731.369549349652;5778.971105144447;5785.103308987113;5785.82642520725;5794.913076303775;5530.446955304437;5567.4432556744005;5621.747021383966;5625.128105143709;5626.578006649435;5519.586031047767;5532.446755324436;5535.667859928417;5544.029794785815;5544.306961629796;5642.943570564406;5666.093425051972;5677.205191273142;5682.772689092555;5685.772569097356;5518.917216241679;5527.917081243865;5547.195656629847;5568.888622227451;5586.329640443173 01:07:55 INFO - 2015-11-23 01:07:55,058 DEBUG : BROWSER_OUTPUT: |1;ext.html;577.6765011593508;578.8118861370056;582.7144699097444;594.8334466349423;609.3510411411843;31416.842915785448;32193.356132877358;38404;39391.40912886309;39559.208815823666;42857.57142428582;43222.56777432233;43277;43387.566124338744;43599.56400435995;7644.885326720104;8580.485170889751;8819.95590022049;8823.205911467967;8833.779155521099;7656.808579785522;10492.422916739577;10787.5684972601;10796.5681372745;10802;10460.163186945065;10550.050495455407;10554.472276386188;10570.260081794277;10571.471426428649;7661.3487853532515;7814.804629884298;10202.48987550627;10379.688609341732;10483.68548943533;9847.064528869745;10052.44711540865;10055.89944100557;10063.849042264372;10068.496575171212;33693.326133477436;33733.325333493194;33793.15517112067;33802.49296260558;34215.4867676985;3261.4129456697783;3625.3836847735683;3999.8600048998437;4011.5587285398583;4126.277901367279;29628.111156665334;29990.250243743863;30061;30107;30318.54522182169;3567.9108022299392;3628.129248980252;3634.0914771307175;3687.6865466435383;3843.7885916274595;280054;280594;280621;281654;282555;53937.73031134819;55150;56272.71863640656;56720.71639641775;57095.42904570901;53887.461125389025;54050.72974635102;54193.72903135459;54292.18561721577;54337.72831135819;12816.615501534969;12887.93556032214;12904.741905161844;12990;12993.285369304778;9438.528073596293;9444.716658500256;9449.811003779885;9495.810083798286;9508.857367139499;19034.714479282822;19149.61700765977;19159.61680766377;19172.80827191738;19213.32753353626;7216.819579510554;7402.555846649218;7451.478396512301;7556.1310449299035;7596.772096837104;941.204682043672;965.1940629574244;1044.1907521670614;1046.864152394645;1097.3251450357973;25403;29186.562201566994;29668.258293542833;30122.54816177759;30199;995.4077323992213;1035.9896401036044;1071.7213524483534;1130.6155906991662;1143.0798207443088;13384;13530.797038044437;13658;15367.385304587691;15646.714190019995;260273;263308;264523;265007;266197;49781.50218497769;49975.25037124446;50042.74978625084;50120.49879501158;50121.74939125354;1122.814735568622;1321.4119716725966;1341.7651910915552;1346.5556366399064;1365.0581099041628;21646.891765541703;27417.177484674692;27552.311192219553;27947.161585152477;28016;45390.31914521351;45717;45802;45851;45969.31046034379;239489;239685;283191;292331;305692;29185.70814291915;29327.560086599144;29506.262343441587;29988.250293742833;30032.399352013275;38536.42195367016;39548.802255988536;39704.40443393409;39753.80123099482;40284.59715402809;32787;33880;35385.82307088448;36612.81693591515;37361;36625;37036;37524.437133443564;37538.2492350146;37598.43602346021;35130.29739405249;35318.823405883835;36184.63815361813;36205.81897090498;36235;31015.379692405575;33626.83186584051;33807.661923381434;33820;33872.66127338794;24801.1319603813;25527.744722552536;25578.10476633309;25676;25819.612705809803 01:07:55 INFO - 2015-11-23 01:07:55,058 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.4431521516675;341.2135028758711;356.3461048975132;357.47272772660347;358.99641003589954;14095.929520352409;14463.421463141489;16068.598285042879;16517.421890233843;17565.824341756594;13294.933525332384;14895.478658246964;14916.477923272687;16236.918815405936;16352.264148113334;5309.548688361484;5416.83749487516;5455.781768729246;5470.933168032236;5472.616916815825;3842.6925845932396;3954.2091581683635;5423.322084739408;5459.890802183973;5797.739101740411;5850.210221620069;5852.356240813507;5859.9414005860035;5881.117832325142;5883.0881213411985;5522.116461366182;5857.707114644272;5924.674142922137;5928.999999999978;5946.256717910262;5232.241325007891;5233.607479439019;5233.633645644806;5235.293235413209;5237.266782650432;19578.118984645724;19688.31090911811;19859.503512412306;20739;20748;2220.9333719988426;2268.206127855254;2295.6556516522487;2386.4511162432564;2619.5199712162566;12776.425060872283;12964.80552791709;12990.28553429561;13265.801012984813;13374;1789.5347209725564;1804.8917064976145;1808.2043900683657;1820.7450956866048;1830.9908450457663;48873.75563122162;49113.75443122797;49227.50772492301;49951;50090.7495462524;9877.06167914047;10094.192464602815;10103.545340459697;10117.19062475015;10135.138513226311;13390.464381424828;13397.665058373424;13402.865971340358;13408.865911340958;13409.865901341056;7257.782266532013;7380.557166570023;7431.702731890664;7471.775846724607;7504.774856754306;7187.209406965334;7206.855862882713;7246.746363877344;7253.455990800711;7263.128424588977;4312.180685669713;4382.715123516961;4382.7290085875375;4405.735655860659;4421.049474363027;1694.6017685843817;1756.9472915812546;1768.9823101769075;1773.202059073422;1816.8819026763217;856.6402111113223;899.4153800029902;925.2736601767715;928.132196396358;988.4810474500945;14880.70238595222;15061;15192.696146077238;16622.168891555375;16688.082155481567;827.2058823529479;893.3433926064338;921.6681994481982;941.7410212191566;944.3483996042709;8861.60122794463;9088.500132492643;9173.020176450382;9458.33791634579;9529;370432;373960;374094;396775;508647;67334.66332668404;73621.63189184127;74592;77081.22918770852;77779.61110194413;1100.4057808783327;1106.391484683421;1107.9390633515234;1117.1118960426481;1120.6974116988367;15031.098134111988;15038.17290049014;15229.923850380677;15362.769558456856;15593.922030389775;34079.14802129967;34109.317813644084;34203.144921376166;34424.48363274603;35122.82438587791;44276;44623.55376446194;44645.330320045876;47966.04067918552;50671;8760.386772925835;8909.331800114887;9204.401713888576;9208.217301529445;9232.261419086322;10618.469076546296;10628.149748019985;10701.785964280514;11710.590129345432;16221.35114595403;14324.212168330425;14376.856231437552;14561.490347837775;14696.853031469976;14739.778903316244;13663.111897726616;14231.35958881832;14266.64333391632;14295.356034056216;14375.424983000563;14458.566243012727;14503.78244326357;14644.19456929879;15002.399904003718;15219.847801521842;9263.953680231556;9691.370060946016;9697.806043879224;9779.41323520591;9807.21542276602;9984.850227246743;10079.546420411245;12843.87156128464;13888.305584720521;14450.566483005527 01:07:55 INFO - 2015-11-23 01:07:55,062 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1345.892328613711;1722.8535574476168;1765.2938824470211;1787.4101546489667;1794.7756530433696;6611.801645950623;7480.625968701564;7581.166071732105;7581.43139264556;7588.734394296201;7704.576248306341;7830.334421574159;7834.177411371795;7834.764957051283;7841.1374748777735;1971.152404466079;2000.6198822223803;2004.5189154602863;2285.7942785149335;2314.490812021361;2015.3349394699787;2296.81625469962;2317.8841057947034;2319.8376113672048;2344.22640528626;2283.828712846543;2287;2313.7505746896654;2346.3664810501155;2349.3421841884215;1924.2399252295404;1979.1291831594053;2266.2634643740766;2305.43516838374;2307.642315441101;1959.294653924586;2252.177955046396;2296.8851557422063;2307.3654744945106;2320.0951628864755;7762.45662803604;7847.764567062997;7866.0560732711865;7868;7875.684972601089;4666.300054991744;4696.741679207642;4720.126776546315;4731.384919960383;4762.3094651275715;3140.764442666809;3201.183698156978;3208.8876889308995;3219.6297425796097;3271.1495011297234;1043.155044414027;1058.7353161709573;1067.9466026698633;1083.4041277297533;1136.5737848306885;10923.126149908068;10924.726881827939;10960.780784384267;10966.616168434066;10973.561057557688;4420.9336859947125;4470.619997300266;4500.954990450119;4516.1419330327135;4534.909301813946;9336.90663093374;9339.112784285482;9343.906560934303;9346.392484488486;9350.158485736316;4915.016996600694;4943.307936888838;4958.132326842788;4971.825986090469;4973.701577905337;4492.685512014193;4493.415855938772;4497.820087196541;4500.122476117126;4502.842400515966;3730.9067273318383;3795.5065841440437;3805.6765174960437;3826.234753049401;3846.8653597123966;1230.4278510492486;1245.8567264764488;1249.6688377579949;1254.184779893077;1257.6415721519322;1299.7205600795874;1312.8949684025256;1334.2128144394853;1354.6681063139595;1379.2827729580763;7431.8142046449275;7500.624968751541;7691;7699.499532530368;7706.614669266626;1055.2454994678842;1058.5606973106228;1127.0870594818223;1127.622246547416;1153.5616465742964;5394.109971854678;5480.177973303957;5863.882722345615;5960.493358064527;6104.969475152596;9118.452892826452;9129.041450647586;9173.44959302444;9213.447193168431;9271.629134834531;8906;8969.37214394986;8994.415363001384;9076.591553380114;9096.226820720181;7020.368166865007;7207.387372073327;7239.276072392719;7248.238934911864;7257.237990011078;7321.782252311156;7442.702291908263;7443.851122977402;7465.477416580788;7466.178720340649;8313.542755148525;8406.453580517247;8551.35864810154;8607.569621518775;8623.137686231577;8530.574689776839;8813;8832.470051796912;8928.062553432055;8951.73144805657;6696.765613203709;6697.531172817856;6723.327667233433;6790.32096790317;6799.422049125879;7595.5822429766895;7652.04349456318;7665.195154508696;7668.923310766821;7671.808204794925;7170.1754298256365;7185.676644550903;7222.96388518054;7256.89114663291;7330;7103.538270012433;7107.253738357398;7188.964055179691;7194.1726701427915;7249.166345870081;7033.366996970297;7052.894206586802;7098.716051358095;7199.820004499929;7202.783916482514;6572.868542629216;6617.536772425884;6623.138991931018;6628.304028077176;6630.436412904957;6529.183852018497;6701.061851340719;6737.696803643946;6749.763758268437;6765.391114799691 01:07:55 INFO - 2015-11-23 01:07:55,063 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.31153602419084;345.05455053154367;349.9965000349996;353.09431308693183;354.28257777999545;5864.413558644133;6020.638761674302;6035.72839222235;6044.516438684906;6110.938890611093;5838.766449342022;5999.460048595625;6040.788572399967;6046.153538504613;6057.757689692407;4620.376249206364;4699.976500117503;4700.365450664168;4712.010477799649;4728.101660684476;4484.170428470743;4559.088182363524;4570.702904311209;4668.603168730662;4684.625229981611;4610.147122782279;4613.5847773700525;4625.79183936722;4659.394278743775;4664.416947881515;4628.213203755369;4630.259158534618;4632;4640.048789998043;4656.231721765938;4090.9386359204636;4097.1191193893455;4100.200460910124;4101.774402407867;4127.071408932996;5560.805371811967;5668.744906479218;5675.091985282335;5675.772969081232;5681.687507187103;5416.945830541684;5417.322834645669;5418.106012507931;5419.132938729824;5424.511793938525;6011.909821352683;6385.616862988236;6389.722055588901;6390.776322828725;6393.392627700361;4392.846250381222;4400.3399490076745;4511.729296242236;4517.096580683843;4521.570450807168;6578;6581.078648989145;6582.605043697441;6591.637459939701;6602.438792702626;4626.236670949255;4627.190241707688;4629.143608432383;4629.814807407666;4631.235846085358;4418.2047231498;4631.675782695246;4631.9536804631525;4691.648126390534;4692.788824502905;5328.200769884471;5364.275822763877;5366.785328586813;5373.650712703662;5378.1663842104535;6476.902846457307;6506.41442270198;6507.739690412425;6507.869842603216;6509.446697030806;1589.348367169455;1636.738121900514;1643.8520533152073;1644.6052947292803;1644.9095299758628;1062.984055239172;1069.887661795516;1072.4744875011188;1086.2124959404528;1117.6982214801958;6098.26820781509;6160.260768707694;6160.907586386208;6168.568200225941;6168.599041062316;6560.081588577603;6563.474922006228;6565.540412171103;6571.474282057424;6574.638394888327;6004.159417681528;6161.229846269216;6162;6162.106494558264;6168.660723660242;3537.5224344713647;3540.929181416357;3564.3405969895653;3567.2865426914723;3569.036360182788;6737.225219099768;6738.326167383222;6743.15710536183;6745.898811517831;6750.493712971547;6548.792385958678;6674.566153200027;6676.632785196861;6677.833054173588;6687.230968438595;6674.666266686646;6689.565178263398;6714.697838597275;6717.664116794141;6734.663266836638;6412.454941329853;6512.218533775977;6517;6541.116949211795;6576.934230657824;6593.241777195684;6594.175728033804;6598.505112116706;6634.369734875179;6657.667116644052;6827.48793840454;6887.5178737487895;6905.343992320722;6915.308469153045;6918.204406493318;4421.867343979686;4526.660500462544;4534.795934183036;4575.771211439348;4581.083783243298;6618.643178148372;6671.633060181736;6681.899771503334;6684.63234522106;6692.59844409337;6497.122888410004;6511.38141876521;6514.869702606016;6517.837054073686;6519.250286216956;6375.5537112403545;6503.772367967098;6505.804825855232;6550.934490655032;6555.2133743951035;6416.294207637249;6420.839479012875;6432.581882177644;6434.292227855026;6436.645984470899;6565.606063636197;6566.4418524424045;6570.704318305592;6582.703778330082;6586.80239592813;6246.781362652286;6416.48668106541;6435.388638079375;6436.485081193399;6438.581492202992 01:07:55 INFO - 2015-11-23 01:07:55,064 DEBUG : BROWSER_OUTPUT: |5;yui.html;737.2001378504324;738.837455759733;740.3263030642116;797.5892415406067;814.8003739083923;13393.464261429543;13666.248356340397;13678.0425370224;13689;13692.110012849158;12779.105462617597;12819.359032048384;12833.807492887614;12940.74118517629;12960.54638087667;669.4744625469008;677.5155763629004;804.6660635836121;804.7424824056304;819.8565251081037;814.8573999550055;816.1063635319316;821.6261600971574;822.1696086952162;829.531314807132;706.4524993130314;859.6045818923303;865.6580650642992;865.8571335729597;866.6403442571325;706.466617703633;839.7606682095604;868.9478631282143;870.0342619692136;870.2124577257592;629.078400143787;632.2855173653742;632.8196464007782;632.8797528469576;633.1041576169761;12731.172473789267;12875.806862897063;13000.609981700563;13003.089783715144;13007.804882926765;12124.939375303067;12719.745605087846;13022.348882555834;13089.06797687165;13251.403686834115;9222.769430764218;9306.627734890597;9322.440653560809;9365.391249568756;9409.952950235274;3588.7129029677562;3633.091727068233;3634.8727794527063;3644.234710710754;3657.4696668983115;46714.5328546717;47334;49216.75391623019;49898.50101499011;49919.50080499185;10166.4916754162;10186.796264074677;10263.557279319088;10419.374837509773;10474.947625261824;19176.137073831713;19215.231390744215;19217.423477295702;19218.231270749013;19252.518687032654;7289.70841166358;7368.815779605446;7470.252974702486;7482.625868706543;7621.618919054025;4177.56135605757;4199.832006719758;4214.726042807208;4225.3873188387515;4238.152369526107;3226.790258633181;3260.510923361515;3268.607767067967;3268.836558172082;3277.901662950115;558.6899270904687;581.7411251992908;582.1209972940806;584.4622946888787;585.7130006296969;601.6690820048956;625.5714835337717;648.4779752299444;650.768977013163;650.8340373204802;7593.620318984139;7851.018622672166;8010.279074883289;8033.1163572007035;8153.673853045931;529.9761510732027;538.8141091323487;539.2908325551965;544.2842661899668;615.3999850146162;3796.354619714655;3879.147719374859;3929.174873276587;3996.140829721624;4050.675945924319;55897;56172;56319.71840140855;56599.717001415556;56689;50388.74805625949;52109;52385.7380713094;52570.211446828325;52805.2079218812;45593;46169.76915115403;46508.7674561625;46691.5330846694;46753.5324646756;8199.590020498832;8390.790230244049;8447.577621118797;8568.143185681382;8588.828223435621;34939;34983.65016349804;35648.465273021444;35934.460983085795;36844.63155368412;42287.15425691407;44230.55769442264;46529.30206046844;46594.301085483065;46960.7651961738;10326.173906087344;10890.727731806768;11007.339559626447;11027.779444411228;11608.013318867654;12247.571335003233;12254.20347677398;12284.877151228731;12402.441890114786;12955.870441295467;10762.784744304914;10854.782904342026;11098.61154859576;11350.148738844455;11917.028672887867;11434.542618295174;11443.542258309575;11628.6511404658;11666.533338666697;12110.515579376726;8376.539290338846;9535.47554884488;10179;10417.42704151279;11487.885121148682;9235.445873247627;9498.382605130644;9819.55811988448;9934.552945117342;10021.348612340174;9510.429374237568;9936.900630993598;9958.936331380039;9991.800163996533;10019.348742331726 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1620 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: __startTimestamp1448269675051__endTimestamp 01:07:55 INFO - 2015-11-23 01:07:55,065 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,066 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:07:55 INFO - 2015-11-23 01:07:55,066 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:07:55 INFO - 2015-11-23 01:07:55,066 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,066 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5457.04 Median:5640.66 stddev:608.69 (10.8%) stddev-sans-first:584.43 01:07:55 INFO - 2015-11-23 01:07:55,068 DEBUG : BROWSER_OUTPUT: Values: 3207.8 3246.5 3289.3 3296.0 3296.0 5236.3 5342.9 5448.0 5473.4 5508.5 5322.2 5443.3 5446.2 5491.8 5508.4 4872.6 4885.9 4913.6 4938.6 4987.2 4899.8 5020.5 5071.0 5091.9 5142.9 4954.0 5003.2 5003.2 5029.2 5033.4 4991.3 5030.8 5035.0 5060.5 5087.9 4759.0 4863.3 5004.9 5013.8 5021.1 5241.5 5308.0 5308.9 5325.9 5327.6 5957.5 5962.2 5968.9 5980.7 5982.3 5732.5 5880.9 5967.8 5984.7 5990.0 5602.3 5609.5 5615.3 5616.3 5640.7 6028.5 6034.8 6052.5 6057.5 6067.0 5668.2 5768.0 5779.6 5783.4 5863.7 5845.7 5866.9 5868.1 5902.6 5910.7 5817.8 5824.0 5872.6 5903.8 5928.7 5713.3 5867.6 5878.3 5881.8 5895.3 4384.7 4410.2 4474.6 4542.2 4553.2 4067.3 4068.0 4077.7 4078.2 4102.0 5647.7 5647.8 5651.7 5651.7 5706.1 5766.0 5787.7 5817.5 5875.3 5960.2 5619.7 5627.0 5682.0 5685.9 5688.6 5186.8 5188.0 5188.8 5189.2 5256.8 5763.8 5907.9 6084.4 6144.5 6158.7 5966.6 5968.7 5978.2 5978.9 6016.4 6110.1 6121.6 6126.1 6131.2 6133.4 5595.0 5646.3 5712.9 5765.2 5883.0 5923.2 5924.9 5933.0 5935.4 5936.4 5731.4 5779.0 5785.1 5785.8 5794.9 5530.4 5567.4 5621.7 5625.1 5626.6 5519.6 5532.4 5535.7 5544.0 5544.3 5642.9 5666.1 5677.2 5682.8 5685.8 5518.9 5527.9 5547.2 5568.9 5586.3 01:07:55 INFO - 2015-11-23 01:07:55,068 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,068 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43915.97 Median:33763.24 stddev:71091.65 (210.6%) stddev-sans-first:71216.61 01:07:55 INFO - 2015-11-23 01:07:55,069 DEBUG : BROWSER_OUTPUT: Values: 577.7 578.8 582.7 594.8 609.4 31416.8 32193.4 38404.0 39391.4 39559.2 42857.6 43222.6 43277.0 43387.6 43599.6 7644.9 8580.5 8820.0 8823.2 8833.8 7656.8 10492.4 10787.6 10796.6 10802.0 10460.2 10550.1 10554.5 10570.3 10571.5 7661.3 7814.8 10202.5 10379.7 10483.7 9847.1 10052.4 10055.9 10063.8 10068.5 33693.3 33733.3 33793.2 33802.5 34215.5 3261.4 3625.4 3999.9 4011.6 4126.3 29628.1 29990.3 30061.0 30107.0 30318.5 3567.9 3628.1 3634.1 3687.7 3843.8 280054.0 280594.0 280621.0 281654.0 282555.0 53937.7 55150.0 56272.7 56720.7 57095.4 53887.5 54050.7 54193.7 54292.2 54337.7 12816.6 12887.9 12904.7 12990.0 12993.3 9438.5 9444.7 9449.8 9495.8 9508.9 19034.7 19149.6 19159.6 19172.8 19213.3 7216.8 7402.6 7451.5 7556.1 7596.8 941.2 965.2 1044.2 1046.9 1097.3 25403.0 29186.6 29668.3 30122.5 30199.0 995.4 1036.0 1071.7 1130.6 1143.1 13384.0 13530.8 13658.0 15367.4 15646.7 260273.0 263308.0 264523.0 265007.0 266197.0 49781.5 49975.3 50042.7 50120.5 50121.7 1122.8 1321.4 1341.8 1346.6 1365.1 21646.9 27417.2 27552.3 27947.2 28016.0 45390.3 45717.0 45802.0 45851.0 45969.3 239489.0 239685.0 283191.0 292331.0 305692.0 29185.7 29327.6 29506.3 29988.3 30032.4 38536.4 39548.8 39704.4 39753.8 40284.6 32787.0 33880.0 35385.8 36612.8 37361.0 36625.0 37036.0 37524.4 37538.2 37598.4 35130.3 35318.8 36184.6 36205.8 36235.0 31015.4 33626.8 33807.7 33820.0 33872.7 24801.1 25527.7 25578.1 25676.0 25819.6 01:07:55 INFO - 2015-11-23 01:07:55,069 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,070 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24409.72 Median:356.91 stddev:66805.79 (18717.9%) stddev-sans-first:66968.74 01:07:55 INFO - 2015-11-23 01:07:55,070 DEBUG : BROWSER_OUTPUT: Values: 334.4 341.2 356.3 357.5 359.0 14095.9 14463.4 16068.6 16517.4 17565.8 13294.9 14895.5 14916.5 16236.9 16352.3 5309.5 5416.8 5455.8 5470.9 5472.6 3842.7 3954.2 5423.3 5459.9 5797.7 5850.2 5852.4 5859.9 5881.1 5883.1 5522.1 5857.7 5924.7 5929.0 5946.3 5232.2 5233.6 5233.6 5235.3 5237.3 19578.1 19688.3 19859.5 20739.0 20748.0 2220.9 2268.2 2295.7 2386.5 2619.5 12776.4 12964.8 12990.3 13265.8 13374.0 1789.5 1804.9 1808.2 1820.7 1831.0 48873.8 49113.8 49227.5 49951.0 50090.7 9877.1 10094.2 10103.5 10117.2 10135.1 13390.5 13397.7 13402.9 13408.9 13409.9 7257.8 7380.6 7431.7 7471.8 7504.8 7187.2 7206.9 7246.7 7253.5 7263.1 4312.2 4382.7 4382.7 4405.7 4421.0 1694.6 1756.9 1769.0 1773.2 1816.9 856.6 899.4 925.3 928.1 988.5 14880.7 15061.0 15192.7 16622.2 16688.1 827.2 893.3 921.7 941.7 944.3 8861.6 9088.5 9173.0 9458.3 9529.0 370432.0 373960.0 374094.0 396775.0 508647.0 67334.7 73621.6 74592.0 77081.2 77779.6 1100.4 1106.4 1107.9 1117.1 1120.7 15031.1 15038.2 15229.9 15362.8 15593.9 34079.1 34109.3 34203.1 34424.5 35122.8 44276.0 44623.6 44645.3 47966.0 50671.0 8760.4 8909.3 9204.4 9208.2 9232.3 10618.5 10628.1 10701.8 11710.6 16221.4 14324.2 14376.9 14561.5 14696.9 14739.8 13663.1 14231.4 14266.6 14295.4 14375.4 14458.6 14503.8 14644.2 15002.4 15219.8 9264.0 9691.4 9697.8 9779.4 9807.2 9984.9 10079.5 12843.9 13888.3 14450.6 01:07:55 INFO - 2015-11-23 01:07:55,070 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,070 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5533.73 Median:6551.03 stddev:2832.81 (43.2%) stddev-sans-first:2823.27 01:07:55 INFO - 2015-11-23 01:07:55,071 DEBUG : BROWSER_OUTPUT: Values: 1345.9 1722.9 1765.3 1787.4 1794.8 6611.8 7480.6 7581.2 7581.4 7588.7 7704.6 7830.3 7834.2 7834.8 7841.1 1971.2 2000.6 2004.5 2285.8 2314.5 2015.3 2296.8 2317.9 2319.8 2344.2 2283.8 2287.0 2313.8 2346.4 2349.3 1924.2 1979.1 2266.3 2305.4 2307.6 1959.3 2252.2 2296.9 2307.4 2320.1 7762.5 7847.8 7866.1 7868.0 7875.7 4666.3 4696.7 4720.1 4731.4 4762.3 3140.8 3201.2 3208.9 3219.6 3271.1 1043.2 1058.7 1067.9 1083.4 1136.6 10923.1 10924.7 10960.8 10966.6 10973.6 4420.9 4470.6 4501.0 4516.1 4534.9 9336.9 9339.1 9343.9 9346.4 9350.2 4915.0 4943.3 4958.1 4971.8 4973.7 4492.7 4493.4 4497.8 4500.1 4502.8 3730.9 3795.5 3805.7 3826.2 3846.9 1230.4 1245.9 1249.7 1254.2 1257.6 1299.7 1312.9 1334.2 1354.7 1379.3 7431.8 7500.6 7691.0 7699.5 7706.6 1055.2 1058.6 1127.1 1127.6 1153.6 5394.1 5480.2 5863.9 5960.5 6105.0 9118.5 9129.0 9173.4 9213.4 9271.6 8906.0 8969.4 8994.4 9076.6 9096.2 7020.4 7207.4 7239.3 7248.2 7257.2 7321.8 7442.7 7443.9 7465.5 7466.2 8313.5 8406.5 8551.4 8607.6 8623.1 8530.6 8813.0 8832.5 8928.1 8951.7 6696.8 6697.5 6723.3 6790.3 6799.4 7595.6 7652.0 7665.2 7668.9 7671.8 7170.2 7185.7 7223.0 7256.9 7330.0 7103.5 7107.3 7189.0 7194.2 7249.2 7033.4 7052.9 7098.7 7199.8 7202.8 6572.9 6617.5 6623.1 6628.3 6630.4 6529.2 6701.1 6737.7 6749.8 6765.4 01:07:55 INFO - 2015-11-23 01:07:55,072 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,072 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5372.62 Median:6078.01 stddev:1610.79 (26.5%) stddev-sans-first:1570.36 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: Values: 338.3 345.1 350.0 353.1 354.3 5864.4 6020.6 6035.7 6044.5 6110.9 5838.8 5999.5 6040.8 6046.2 6057.8 4620.4 4700.0 4700.4 4712.0 4728.1 4484.2 4559.1 4570.7 4668.6 4684.6 4610.1 4613.6 4625.8 4659.4 4664.4 4628.2 4630.3 4632.0 4640.0 4656.2 4090.9 4097.1 4100.2 4101.8 4127.1 5560.8 5668.7 5675.1 5675.8 5681.7 5416.9 5417.3 5418.1 5419.1 5424.5 6011.9 6385.6 6389.7 6390.8 6393.4 4392.8 4400.3 4511.7 4517.1 4521.6 6578.0 6581.1 6582.6 6591.6 6602.4 4626.2 4627.2 4629.1 4629.8 4631.2 4418.2 4631.7 4632.0 4691.6 4692.8 5328.2 5364.3 5366.8 5373.7 5378.2 6476.9 6506.4 6507.7 6507.9 6509.4 1589.3 1636.7 1643.9 1644.6 1644.9 1063.0 1069.9 1072.5 1086.2 1117.7 6098.3 6160.3 6160.9 6168.6 6168.6 6560.1 6563.5 6565.5 6571.5 6574.6 6004.2 6161.2 6162.0 6162.1 6168.7 3537.5 3540.9 3564.3 3567.3 3569.0 6737.2 6738.3 6743.2 6745.9 6750.5 6548.8 6674.6 6676.6 6677.8 6687.2 6674.7 6689.6 6714.7 6717.7 6734.7 6412.5 6512.2 6517.0 6541.1 6576.9 6593.2 6594.2 6598.5 6634.4 6657.7 6827.5 6887.5 6905.3 6915.3 6918.2 4421.9 4526.7 4534.8 4575.8 4581.1 6618.6 6671.6 6681.9 6684.6 6692.6 6497.1 6511.4 6514.9 6517.8 6519.3 6375.6 6503.8 6505.8 6550.9 6555.2 6416.3 6420.8 6432.6 6434.3 6436.6 6565.6 6566.4 6570.7 6582.7 6586.8 6246.8 6416.5 6435.4 6436.5 6438.6 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13792.47 Median:47147.38 stddev:16035.31 (34.0%) stddev-sans-first:16050.32 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: Values: 737.2 738.8 740.3 797.6 814.8 13393.5 13666.2 13678.0 13689.0 13692.1 12779.1 12819.4 12833.8 12940.7 12960.5 669.5 677.5 804.7 804.7 819.9 814.9 816.1 821.6 822.2 829.5 706.5 859.6 865.7 865.9 866.6 706.5 839.8 868.9 870.0 870.2 629.1 632.3 632.8 632.9 633.1 12731.2 12875.8 13000.6 13003.1 13007.8 12124.9 12719.7 13022.3 13089.1 13251.4 9222.8 9306.6 9322.4 9365.4 9410.0 3588.7 3633.1 3634.9 3644.2 3657.5 46714.5 47334.0 49216.8 49898.5 49919.5 10166.5 10186.8 10263.6 10419.4 10474.9 19176.1 19215.2 19217.4 19218.2 19252.5 7289.7 7368.8 7470.3 7482.6 7621.6 4177.6 4199.8 4214.7 4225.4 4238.2 3226.8 3260.5 3268.6 3268.8 3277.9 558.7 581.7 582.1 584.5 585.7 601.7 625.6 648.5 650.8 650.8 7593.6 7851.0 8010.3 8033.1 8153.7 530.0 538.8 539.3 544.3 615.4 3796.4 3879.1 3929.2 3996.1 4050.7 55897.0 56172.0 56319.7 56599.7 56689.0 50388.7 52109.0 52385.7 52570.2 52805.2 45593.0 46169.8 46508.8 46691.5 46753.5 8199.6 8390.8 8447.6 8568.1 8588.8 34939.0 34983.7 35648.5 35934.5 36844.6 42287.2 44230.6 46529.3 46594.3 46960.8 10326.2 10890.7 11007.3 11027.8 11608.0 12247.6 12254.2 12284.9 12402.4 12955.9 10762.8 10854.8 11098.6 11350.1 11917.0 11434.5 11443.5 11628.7 11666.5 12110.5 8376.5 9535.5 10179.0 10417.4 11487.9 9235.4 9498.4 9819.6 9934.6 10021.3 9510.4 9936.9 9958.9 9991.8 10019.3 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:07:55 INFO - 2015-11-23 01:07:55,073 DEBUG : BROWSER_OUTPUT: 01:07:55 INFO - 2015-11-23 01:07:55,736 INFO : Browser exited with error code: 0 01:07:55 INFO - 2015-11-23 01:07:55,760 INFO : Completed test dromaeo_css (00:18:33) 01:07:55 INFO - 2015-11-23 01:07:55,760 INFO : Starting test kraken 01:07:55 INFO - 2015-11-23 01:07:55,760 DEBUG : operating with platform_type : linux_ 01:07:55 INFO - 2015-11-23 01:07:55,760 INFO : Initialising browser for kraken test... 01:07:55 INFO - 2015-11-23 01:07:55,766 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ_yyGB/profile http://localhost:45337/getInfo.html 01:07:59 INFO - 2015-11-23 01:07:59,480 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:07:59 INFO - 2015-11-23 01:07:59,480 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:07:59 INFO - 2015-11-23 01:07:59,480 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:07:59 INFO - 2015-11-23 01:07:59,480 DEBUG : BROWSER_OUTPUT: __metrics 01:07:59 INFO - 2015-11-23 01:07:59,622 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:00 INFO - 2015-11-23 01:08:00,802 INFO : Browser initialized. 01:08:00 INFO - 2015-11-23 01:08:00,803 INFO : Running cycle 1/1 for kraken test... 01:08:00 INFO - 2015-11-23 01:08:00,803 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ_yyGB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:08:12 INFO - 2015-11-23 01:08:12,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 141578240 01:08:12 INFO - 2015-11-23 01:08:12,571 DEBUG : BROWSER_OUTPUT: 01:08:15 INFO - 2015-11-23 01:08:15,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-beat-detection) 01:08:15 INFO - 2015-11-23 01:08:15,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 178769920 01:08:15 INFO - 2015-11-23 01:08:15,647 DEBUG : BROWSER_OUTPUT: 01:08:18 INFO - 2015-11-23 01:08:18,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-dft) 01:08:18 INFO - 2015-11-23 01:08:18,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 166932480 01:08:18 INFO - 2015-11-23 01:08:18,802 DEBUG : BROWSER_OUTPUT: 01:08:21 INFO - 2015-11-23 01:08:21,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-fft) 01:08:22 INFO - 2015-11-23 01:08:22,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 151900160 01:08:22 INFO - 2015-11-23 01:08:22,256 DEBUG : BROWSER_OUTPUT: 01:08:24 INFO - 2015-11-23 01:08:24,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45337/tests/kraken/driver.html?testName=audio-oscillator) 01:08:24 INFO - 2015-11-23 01:08:24,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 153788416 01:08:24 INFO - 2015-11-23 01:08:24,792 DEBUG : BROWSER_OUTPUT: 01:08:26 INFO - 2015-11-23 01:08:26,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:08:27 INFO - 2015-11-23 01:08:27,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 155844608 01:08:27 INFO - 2015-11-23 01:08:27,513 DEBUG : BROWSER_OUTPUT: 01:08:30 INFO - 2015-11-23 01:08:30,432 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-darkroom) 01:08:30 INFO - 2015-11-23 01:08:30,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 155037696 01:08:30 INFO - 2015-11-23 01:08:30,998 DEBUG : BROWSER_OUTPUT: 01:08:34 INFO - 2015-11-23 01:08:34,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45337/tests/kraken/driver.html?testName=imaging-desaturate) 01:08:34 INFO - 2015-11-23 01:08:34,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 156327936 01:08:34 INFO - 2015-11-23 01:08:34,949 DEBUG : BROWSER_OUTPUT: 01:08:37 INFO - 2015-11-23 01:08:37,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45337/tests/kraken/driver.html?testName=json-parse-financial) 01:08:38 INFO - 2015-11-23 01:08:38,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 156401664 01:08:38 INFO - 2015-11-23 01:08:38,263 DEBUG : BROWSER_OUTPUT: 01:08:39 INFO - 2015-11-23 01:08:39,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:08:40 INFO - 2015-11-23 01:08:40,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 162181120 01:08:40 INFO - 2015-11-23 01:08:40,397 DEBUG : BROWSER_OUTPUT: 01:08:42 INFO - 2015-11-23 01:08:42,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:08:42 INFO - 2015-11-23 01:08:42,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 163446784 01:08:42 INFO - 2015-11-23 01:08:42,781 DEBUG : BROWSER_OUTPUT: 01:08:44 INFO - 2015-11-23 01:08:44,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:08:45 INFO - 2015-11-23 01:08:45,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 168284160 01:08:45 INFO - 2015-11-23 01:08:45,431 DEBUG : BROWSER_OUTPUT: 01:08:47 INFO - 2015-11-23 01:08:47,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:08:48 INFO - 2015-11-23 01:08:48,392 DEBUG : BROWSER_OUTPUT: RSS: Main: 174817280 01:08:48 INFO - 2015-11-23 01:08:48,393 DEBUG : BROWSER_OUTPUT: 01:08:50 INFO - 2015-11-23 01:08:50,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:08:51 INFO - 2015-11-23 01:08:51,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 172843008 01:08:51 INFO - 2015-11-23 01:08:51,495 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45337/tests/kraken/driver.html?testName=ai-astar) 01:08:53 INFO - 2015-11-23 01:08:53,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 232112128 01:08:53 INFO - 2015-11-23 01:08:53,396 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,400 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:08:53 INFO - 2015-11-23 01:08:53,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:08:53 INFO - 2015-11-23 01:08:53,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:08:53 INFO - 2015-11-23 01:08:53,400 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:08:53 INFO - 2015-11-23 01:08:53,400 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;111;111;111;98;109;112;109 01:08:53 INFO - 2015-11-23 01:08:53,401 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;124;145;165;124;150;151;125;165;125 01:08:53 INFO - 2015-11-23 01:08:53,401 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;163;160;158;162;161;164 01:08:53 INFO - 2015-11-23 01:08:53,401 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;82;93;72;73;73;118;95;71 01:08:53 INFO - 2015-11-23 01:08:53,401 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;132;89;90;90;133;90;90;132 01:08:53 INFO - 2015-11-23 01:08:53,401 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;109;109;109;110;110 01:08:53 INFO - 2015-11-23 01:08:53,402 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;146;145;146;145;146 01:08:53 INFO - 2015-11-23 01:08:53,402 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;97;96;96;95;96 01:08:53 INFO - 2015-11-23 01:08:53,402 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;66;59;59;59;62;66;57;56 01:08:53 INFO - 2015-11-23 01:08:53,402 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;69;69;69;71;71;70 01:08:53 INFO - 2015-11-23 01:08:53,402 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;89;84;86;84;84;84;85;86 01:08:53 INFO - 2015-11-23 01:08:53,403 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;119;123;115;121;123;122;117;125;124 01:08:53 INFO - 2015-11-23 01:08:53,403 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;155;150;138;147;140;152;148;147;142 01:08:53 INFO - 2015-11-23 01:08:53,403 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;66;66;66;69;68;67;66;66 01:08:53 INFO - 2015-11-23 01:08:53,403 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:08:53 INFO - 2015-11-23 01:08:53,403 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:08:53 INFO - 2015-11-23 01:08:53,404 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,925 01:08:53 INFO - 2015-11-23 01:08:53,404 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:08:53 INFO - 2015-11-23 01:08:53,404 DEBUG : BROWSER_OUTPUT: __startTimestamp1448269733398__endTimestamp 01:08:53 INFO - 2015-11-23 01:08:53,404 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,405 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:08:53 INFO - 2015-11-23 01:08:53,405 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.50 Median:111.00 stddev:4.17 (3.8%) stddev-sans-first:4.42 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 111.0 111.0 111.0 98.0 109.0 112.0 109.0 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:149.00 stddev:16.58 (11.1%) stddev-sans-first:17.45 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: Values: 148.0 124.0 145.0 165.0 124.0 150.0 151.0 125.0 165.0 125.0 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,406 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 163.0 160.0 158.0 162.0 161.0 164.0 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.00 Median:73.00 stddev:15.60 (21.4%) stddev-sans-first:16.12 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 82.0 93.0 72.0 73.0 73.0 118.0 95.0 71.0 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,407 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:90.00 stddev:20.46 (22.7%) stddev-sans-first:21.17 01:08:53 INFO - 2015-11-23 01:08:53,408 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 132.0 89.0 90.0 90.0 133.0 90.0 90.0 132.0 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 01:08:53 INFO - 2015-11-23 01:08:53,409 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 95.0 96.0 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.00 stddev:3.41 (5.7%) stddev-sans-first:3.57 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 66.0 59.0 59.0 59.0 62.0 66.0 57.0 56.0 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 69.0 69.0 69.0 71.0 71.0 70.0 01:08:53 INFO - 2015-11-23 01:08:53,410 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:86.00 stddev:1.58 (1.8%) stddev-sans-first:1.66 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 89.0 84.0 86.0 84.0 84.0 84.0 85.0 86.0 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:122.50 stddev:3.30 (2.7%) stddev-sans-first:3.35 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 123.0 115.0 121.0 123.0 122.0 117.0 125.0 124.0 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:147.50 stddev:5.49 (3.7%) stddev-sans-first:5.61 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: Values: 142.0 155.0 150.0 138.0 147.0 140.0 152.0 148.0 147.0 142.0 01:08:53 INFO - 2015-11-23 01:08:53,411 DEBUG : BROWSER_OUTPUT: 01:08:53 INFO - 2015-11-23 01:08:53,412 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.12 01:08:53 INFO - 2015-11-23 01:08:53,412 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 66.0 66.0 66.0 69.0 68.0 67.0 66.0 66.0 01:08:53 INFO - 2015-11-23 01:08:53,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:08:53 INFO - 2015-11-23 01:08:53,412 DEBUG : BROWSER_OUTPUT: 01:08:54 INFO - 2015-11-23 01:08:54,256 INFO : Browser exited with error code: 0 01:08:54 INFO - 2015-11-23 01:08:54,307 INFO : Completed test kraken (00:00:58) 01:08:54 INFO - 2015-11-23 01:08:54,307 INFO : Starting test v8_7 01:08:54 INFO - 2015-11-23 01:08:54,307 DEBUG : operating with platform_type : linux_ 01:08:54 INFO - 2015-11-23 01:08:54,307 INFO : Initialising browser for v8_7 test... 01:08:54 INFO - 2015-11-23 01:08:54,313 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGwYnXe/profile http://localhost:45337/getInfo.html 01:08:58 INFO - 2015-11-23 01:08:58,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:08:58 INFO - 2015-11-23 01:08:58,066 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:08:58 INFO - 2015-11-23 01:08:58,066 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:08:58 INFO - 2015-11-23 01:08:58,066 DEBUG : BROWSER_OUTPUT: __metrics 01:08:58 INFO - 2015-11-23 01:08:58,194 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:59 INFO - 2015-11-23 01:08:59,432 INFO : Browser initialized. 01:08:59 INFO - 2015-11-23 01:08:59,432 INFO : Running cycle 1/1 for v8_7 test... 01:08:59 INFO - 2015-11-23 01:08:59,432 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGwYnXe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:09:11 INFO - 2015-11-23 01:09:11,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 141824000 01:09:11 INFO - 2015-11-23 01:09:11,203 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45337/tests/v8_7/run.html (next: http://localhost:45337/tests/v8_7/run.html) 01:09:32 INFO - 2015-11-23 01:09:32,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 612335616 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:09:32 INFO - 2015-11-23 01:09:32,892 DEBUG : BROWSER_OUTPUT: |0;Richards;163.26530612244898 01:09:32 INFO - 2015-11-23 01:09:32,893 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.46101760495262 01:09:32 INFO - 2015-11-23 01:09:32,893 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.6569883290635 01:09:32 INFO - 2015-11-23 01:09:32,893 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 01:09:32 INFO - 2015-11-23 01:09:32,893 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1941.7475728155339 01:09:32 INFO - 2015-11-23 01:09:32,893 DEBUG : BROWSER_OUTPUT: |5;Earley;801.924619085806 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: |6;Boyer;11916.666666666666 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: |8;Splay;644.2185514612453 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:09:32 INFO - 2015-11-23 01:09:32,894 DEBUG : BROWSER_OUTPUT: __startTimestamp1448269772889__endTimestamp 01:09:32 INFO - 2015-11-23 01:09:32,895 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,895 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:09:32 INFO - 2015-11-23 01:09:32,895 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:09:32 INFO - 2015-11-23 01:09:32,895 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,895 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.27 Median:163.27 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: Values: 163.3 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.46 Median:193.46 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: Values: 193.5 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.66 Median:284.66 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: Values: 284.7 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,896 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: Values: 5040.2 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1941.75 Median:1941.75 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: Values: 1941.7 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: Values: 801.9 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11916.67 Median:11916.67 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: Values: 11916.7 01:09:32 INFO - 2015-11-23 01:09:32,897 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: Values: 25450.0 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:644.22 Median:644.22 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: Values: 644.2 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: Values: 4845.4 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:09:32 INFO - 2015-11-23 01:09:32,898 DEBUG : BROWSER_OUTPUT: 01:09:33 INFO - 2015-11-23 01:09:33,796 INFO : Browser exited with error code: 0 01:09:33 INFO - 2015-11-23 01:09:33,811 INFO : Completed test v8_7 (00:00:39) 01:09:33 INFO - 2015-11-23 01:09:33,872 INFO : Completed test suite (00:20:11) 01:09:33 INFO - 2015-11-23 01:09:33,872 DEBUG : Working with test: dromaeo_css 01:09:33 INFO - 2015-11-23 01:09:33,872 DEBUG : Generating results file: dromaeo_css 01:09:33 INFO - 2015-11-23 01:09:33,873 DEBUG : Working with test: kraken 01:09:33 INFO - 2015-11-23 01:09:33,873 DEBUG : Generating results file: kraken 01:09:33 INFO - 2015-11-23 01:09:33,874 INFO : javascript benchmark 01:09:33 INFO - 2015-11-23 01:09:33,874 DEBUG : Working with test: v8_7 01:09:33 INFO - 2015-11-23 01:09:33,874 DEBUG : Generating results file: v8_7 01:09:33 INFO - 2015-11-23 01:09:33,874 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:33 INFO - 2015-11-23 01:09:33,931 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 01:09:33 INFO - 2015-11-23 01:09:33,932 DEBUG : process_Request line: dromaeo_css 6992.99 graph.html#tests=[[72,201,35]] 01:09:33 INFO - 2015-11-23 01:09:33,932 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:34 INFO - 2015-11-23 01:09:34,040 DEBUG : process_Request line: kraken 1496.00 graph.html#tests=[[232,201,35]] 01:09:34 INFO - 2015-11-23 01:09:34,040 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:34 INFO - 2015-11-23 01:09:34,137 DEBUG : process_Request line: v8_7 19809.29 graph.html#tests=[[230,201,35]] 01:09:34 INFO - 2015-11-23 01:09:34,139 INFO : javascript benchmark 01:09:34 INFO - 2015-11-23 01:09:34,142 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3207.8075315481074, 3246.5130230465443, 3289.3421315736846, 3295.9670403295977, 3296.0, 5236.2931004314405, 5342.866428339294, 5448.046591846426, 5473.425290344516, 5508.504234618884, 5322.20166974953, 5443.319585051869, 5446.2375267462585, 5491.835244942648, 5508.394076651565, 4872.585830204419, 4885.926711099345, 4913.582345500637, 4938.604911607063, 4987.152184128707, 4899.779509922062, 5020.548150666439, 5070.974645126769, 5091.872703182432, 5142.8714282143055, 4954.033963377143, 5003.174476211402, 5003.224500202475, 5029.245613158056, 5033.395992480926, 4991.276264941599, 5030.84907452777, 5035.0, 5060.51925067118, 5087.898242035176, 4759.0, 4863.343448634424, 5004.9499505005215, 5013.799448022075, 5021.071101846133, 5241.528262456397, 5308.0, 5308.92036619451, 5325.946740532622, 5327.600429967768, 5957.523398128139, 5962.224910761616, 5968.850778730523, 5980.671063091529, 5982.282126144891, 5732.541396688255, 5880.911786323209, 5967.7911273105665, 5984.730687119047, 5990.041593345088, 5602.271704678447, 5609.523190528769, 5615.2700148980775, 5616.269884914976, 5640.661560306395, 6028.517718582503, 6034.788782392595, 6052.485538729169, 6057.545684073712, 6067.0292753160165, 5668.234788303526, 5767.971160144256, 5779.595428319977, 5783.392743761929, 5863.736131874076, 5845.678487683218, 5866.911996320058, 5868.09044598088, 5902.6458412495385, 5910.704464776744, 5817.7963771267805, 5824.0, 5872.588918775645, 5903.822885313448, 5928.7332070056955, 5713.314402271754, 5867.559933005042, 5878.29460464747, 5881.764729410861, 5895.29256489224, 4384.714993525411, 4410.184115938561, 4474.6420286377015, 4542.159700455426, 4553.203189441834, 4067.3085575452246, 4067.9593204067583, 4077.6941729370415, 4078.2455245779033, 4102.0360215349365, 5647.717614119278, 5647.794095624106, 5651.717414129277, 5651.717414129277, 5706.087026075808, 5766.0, 5787.739551720183, 5817.505512031525, 5875.294964604275, 5960.225170727865, 5619.690916999522, 5627.043402621564, 5681.971590142106, 5685.943140568624, 5688.601797874109, 5186.844394668166, 5188.0, 5188.792448302102, 5189.195674670432, 5256.816011439581, 5763.769449221984, 5907.940920590825, 6084.421979911901, 6144.539159563051, 6158.722857471335, 5966.642001479751, 5968.701564921824, 5978.163057171912, 5978.910316345346, 6016.428439298435, 6110.052941794029, 6121.571489995836, 6126.050462178369, 6131.233595800525, 6133.38666133401, 5594.9720251398485, 5646.265985422033, 5712.857178570569, 5765.221695071112, 5882.970585147047, 5923.170756094237, 5924.851878703067, 5932.970335148297, 5935.376785437467, 5936.406359364202, 5731.369549349652, 5778.971105144447, 5785.103308987113, 5785.82642520725, 5794.913076303775, 5530.446955304437, 5567.4432556744005, 5621.747021383966, 5625.128105143709, 5626.578006649435, 5519.586031047767, 5532.446755324436, 5535.667859928417, 5544.029794785815, 5544.306961629796, 5642.943570564406, 5666.093425051972, 5677.205191273142, 5682.772689092555, 5685.772569097356, 5518.917216241679, 5527.917081243865, 5547.195656629847, 5568.888622227451, 5586.329640443173], "unit": "ms", "name": "dojo.html", "value": 5417.403485529557}, {"lowerIsBetter": false, "replicates": [577.6765011593508, 578.8118861370056, 582.7144699097444, 594.8334466349423, 609.3510411411843, 31416.842915785448, 32193.356132877358, 38404.0, 39391.40912886309, 39559.208815823666, 42857.57142428582, 43222.56777432233, 43277.0, 43387.566124338744, 43599.56400435995, 7644.885326720104, 8580.485170889751, 8819.95590022049, 8823.205911467967, 8833.779155521099, 7656.808579785522, 10492.422916739577, 10787.5684972601, 10796.5681372745, 10802.0, 10460.163186945065, 10550.050495455407, 10554.472276386188, 10570.260081794277, 10571.471426428649, 7661.3487853532515, 7814.804629884298, 10202.48987550627, 10379.688609341732, 10483.68548943533, 9847.064528869745, 10052.44711540865, 10055.89944100557, 10063.849042264372, 10068.496575171212, 33693.326133477436, 33733.325333493194, 33793.15517112067, 33802.49296260558, 34215.4867676985, 3261.4129456697783, 3625.3836847735683, 3999.8600048998437, 4011.5587285398583, 4126.277901367279, 29628.111156665334, 29990.250243743863, 30061.0, 30107.0, 30318.54522182169, 3567.9108022299392, 3628.129248980252, 3634.0914771307175, 3687.6865466435383, 3843.7885916274595, 280054.0, 280594.0, 280621.0, 281654.0, 282555.0, 53937.73031134819, 55150.0, 56272.71863640656, 56720.71639641775, 57095.42904570901, 53887.461125389025, 54050.72974635102, 54193.72903135459, 54292.18561721577, 54337.72831135819, 12816.615501534969, 12887.93556032214, 12904.741905161844, 12990.0, 12993.285369304778, 9438.528073596293, 9444.716658500256, 9449.811003779885, 9495.810083798286, 9508.857367139499, 19034.714479282822, 19149.61700765977, 19159.61680766377, 19172.80827191738, 19213.32753353626, 7216.819579510554, 7402.555846649218, 7451.478396512301, 7556.1310449299035, 7596.772096837104, 941.204682043672, 965.1940629574244, 1044.1907521670614, 1046.864152394645, 1097.3251450357973, 25403.0, 29186.562201566994, 29668.258293542833, 30122.54816177759, 30199.0, 995.4077323992213, 1035.9896401036044, 1071.7213524483534, 1130.6155906991662, 1143.0798207443088, 13384.0, 13530.797038044437, 13658.0, 15367.385304587691, 15646.714190019995, 260273.0, 263308.0, 264523.0, 265007.0, 266197.0, 49781.50218497769, 49975.25037124446, 50042.74978625084, 50120.49879501158, 50121.74939125354, 1122.814735568622, 1321.4119716725966, 1341.7651910915552, 1346.5556366399064, 1365.0581099041628, 21646.891765541703, 27417.177484674692, 27552.311192219553, 27947.161585152477, 28016.0, 45390.31914521351, 45717.0, 45802.0, 45851.0, 45969.31046034379, 239489.0, 239685.0, 283191.0, 292331.0, 305692.0, 29185.70814291915, 29327.560086599144, 29506.262343441587, 29988.250293742833, 30032.399352013275, 38536.42195367016, 39548.802255988536, 39704.40443393409, 39753.80123099482, 40284.59715402809, 32787.0, 33880.0, 35385.82307088448, 36612.81693591515, 37361.0, 36625.0, 37036.0, 37524.437133443564, 37538.2492350146, 37598.43602346021, 35130.29739405249, 35318.823405883835, 36184.63815361813, 36205.81897090498, 36235.0, 31015.379692405575, 33626.83186584051, 33807.661923381434, 33820.0, 33872.66127338794, 24801.1319603813, 25527.744722552536, 25578.10476633309, 25676.0, 25819.612705809803], "unit": "ms", "name": "ext.html", "value": 18122.76918011408}, {"lowerIsBetter": false, "replicates": [334.4431521516675, 341.2135028758711, 356.3461048975132, 357.47272772660347, 358.99641003589954, 14095.929520352409, 14463.421463141489, 16068.598285042879, 16517.421890233843, 17565.824341756594, 13294.933525332384, 14895.478658246964, 14916.477923272687, 16236.918815405936, 16352.264148113334, 5309.548688361484, 5416.83749487516, 5455.781768729246, 5470.933168032236, 5472.616916815825, 3842.6925845932396, 3954.2091581683635, 5423.322084739408, 5459.890802183973, 5797.739101740411, 5850.210221620069, 5852.356240813507, 5859.9414005860035, 5881.117832325142, 5883.0881213411985, 5522.116461366182, 5857.707114644272, 5924.674142922137, 5928.999999999978, 5946.256717910262, 5232.241325007891, 5233.607479439019, 5233.633645644806, 5235.293235413209, 5237.266782650432, 19578.118984645724, 19688.31090911811, 19859.503512412306, 20739.0, 20748.0, 2220.9333719988426, 2268.206127855254, 2295.6556516522487, 2386.4511162432564, 2619.5199712162566, 12776.425060872283, 12964.80552791709, 12990.28553429561, 13265.801012984813, 13374.0, 1789.5347209725564, 1804.8917064976145, 1808.2043900683657, 1820.7450956866048, 1830.9908450457663, 48873.75563122162, 49113.75443122797, 49227.50772492301, 49951.0, 50090.7495462524, 9877.06167914047, 10094.192464602815, 10103.545340459697, 10117.19062475015, 10135.138513226311, 13390.464381424828, 13397.665058373424, 13402.865971340358, 13408.865911340958, 13409.865901341056, 7257.782266532013, 7380.557166570023, 7431.702731890664, 7471.775846724607, 7504.774856754306, 7187.209406965334, 7206.855862882713, 7246.746363877344, 7253.455990800711, 7263.128424588977, 4312.180685669713, 4382.715123516961, 4382.7290085875375, 4405.735655860659, 4421.049474363027, 1694.6017685843817, 1756.9472915812546, 1768.9823101769075, 1773.202059073422, 1816.8819026763217, 856.6402111113223, 899.4153800029902, 925.2736601767715, 928.132196396358, 988.4810474500945, 14880.70238595222, 15061.0, 15192.696146077238, 16622.168891555375, 16688.082155481567, 827.2058823529479, 893.3433926064338, 921.6681994481982, 941.7410212191566, 944.3483996042709, 8861.60122794463, 9088.500132492643, 9173.020176450382, 9458.33791634579, 9529.0, 370432.0, 373960.0, 374094.0, 396775.0, 508647.0, 67334.66332668404, 73621.63189184127, 74592.0, 77081.22918770852, 77779.61110194413, 1100.4057808783327, 1106.391484683421, 1107.9390633515234, 1117.1118960426481, 1120.6974116988367, 15031.098134111988, 15038.17290049014, 15229.923850380677, 15362.769558456856, 15593.922030389775, 34079.14802129967, 34109.317813644084, 34203.144921376166, 34424.48363274603, 35122.82438587791, 44276.0, 44623.55376446194, 44645.330320045876, 47966.04067918552, 50671.0, 8760.386772925835, 8909.331800114887, 9204.401713888576, 9208.217301529445, 9232.261419086322, 10618.469076546296, 10628.149748019985, 10701.785964280514, 11710.590129345432, 16221.35114595403, 14324.212168330425, 14376.856231437552, 14561.490347837775, 14696.853031469976, 14739.778903316244, 13663.111897726616, 14231.35958881832, 14266.64333391632, 14295.356034056216, 14375.424983000563, 14458.566243012727, 14503.78244326357, 14644.19456929879, 15002.399904003718, 15219.847801521842, 9263.953680231556, 9691.370060946016, 9697.806043879224, 9779.41323520591, 9807.21542276602, 9984.850227246743, 10079.546420411245, 12843.87156128464, 13888.305584720521, 14450.566483005527], "unit": "ms", "name": "jquery.html", "value": 8617.395524969306}, {"lowerIsBetter": false, "replicates": [1345.892328613711, 1722.8535574476168, 1765.2938824470211, 1787.4101546489667, 1794.7756530433696, 6611.801645950623, 7480.625968701564, 7581.166071732105, 7581.43139264556, 7588.734394296201, 7704.576248306341, 7830.334421574159, 7834.177411371795, 7834.764957051283, 7841.1374748777735, 1971.152404466079, 2000.6198822223803, 2004.5189154602863, 2285.7942785149335, 2314.490812021361, 2015.3349394699787, 2296.81625469962, 2317.8841057947034, 2319.8376113672048, 2344.22640528626, 2283.828712846543, 2287.0, 2313.7505746896654, 2346.3664810501155, 2349.3421841884215, 1924.2399252295404, 1979.1291831594053, 2266.2634643740766, 2305.43516838374, 2307.642315441101, 1959.294653924586, 2252.177955046396, 2296.8851557422063, 2307.3654744945106, 2320.0951628864755, 7762.45662803604, 7847.764567062997, 7866.0560732711865, 7868.0, 7875.684972601089, 4666.300054991744, 4696.741679207642, 4720.126776546315, 4731.384919960383, 4762.3094651275715, 3140.764442666809, 3201.183698156978, 3208.8876889308995, 3219.6297425796097, 3271.1495011297234, 1043.155044414027, 1058.7353161709573, 1067.9466026698633, 1083.4041277297533, 1136.5737848306885, 10923.126149908068, 10924.726881827939, 10960.780784384267, 10966.616168434066, 10973.561057557688, 4420.9336859947125, 4470.619997300266, 4500.954990450119, 4516.1419330327135, 4534.909301813946, 9336.90663093374, 9339.112784285482, 9343.906560934303, 9346.392484488486, 9350.158485736316, 4915.016996600694, 4943.307936888838, 4958.132326842788, 4971.825986090469, 4973.701577905337, 4492.685512014193, 4493.415855938772, 4497.820087196541, 4500.122476117126, 4502.842400515966, 3730.9067273318383, 3795.5065841440437, 3805.6765174960437, 3826.234753049401, 3846.8653597123966, 1230.4278510492486, 1245.8567264764488, 1249.6688377579949, 1254.184779893077, 1257.6415721519322, 1299.7205600795874, 1312.8949684025256, 1334.2128144394853, 1354.6681063139595, 1379.2827729580763, 7431.8142046449275, 7500.624968751541, 7691.0, 7699.499532530368, 7706.614669266626, 1055.2454994678842, 1058.5606973106228, 1127.0870594818223, 1127.622246547416, 1153.5616465742964, 5394.109971854678, 5480.177973303957, 5863.882722345615, 5960.493358064527, 6104.969475152596, 9118.452892826452, 9129.041450647586, 9173.44959302444, 9213.447193168431, 9271.629134834531, 8906.0, 8969.37214394986, 8994.415363001384, 9076.591553380114, 9096.226820720181, 7020.368166865007, 7207.387372073327, 7239.276072392719, 7248.238934911864, 7257.237990011078, 7321.782252311156, 7442.702291908263, 7443.851122977402, 7465.477416580788, 7466.178720340649, 8313.542755148525, 8406.453580517247, 8551.35864810154, 8607.569621518775, 8623.137686231577, 8530.574689776839, 8813.0, 8832.470051796912, 8928.062553432055, 8951.73144805657, 6696.765613203709, 6697.531172817856, 6723.327667233433, 6790.32096790317, 6799.422049125879, 7595.5822429766895, 7652.04349456318, 7665.195154508696, 7668.923310766821, 7671.808204794925, 7170.1754298256365, 7185.676644550903, 7222.96388518054, 7256.89114663291, 7330.0, 7103.538270012433, 7107.253738357398, 7188.964055179691, 7194.1726701427915, 7249.166345870081, 7033.366996970297, 7052.894206586802, 7098.716051358095, 7199.820004499929, 7202.783916482514, 6572.868542629216, 6617.536772425884, 6623.138991931018, 6628.304028077176, 6630.436412904957, 6529.183852018497, 6701.061851340719, 6737.696803643946, 6749.763758268437, 6765.391114799691], "unit": "ms", "name": "mootools.html", "value": 4571.412034440706}, {"lowerIsBetter": false, "replicates": [338.31153602419084, 345.05455053154367, 349.9965000349996, 353.09431308693183, 354.28257777999545, 5864.413558644133, 6020.638761674302, 6035.72839222235, 6044.516438684906, 6110.938890611093, 5838.766449342022, 5999.460048595625, 6040.788572399967, 6046.153538504613, 6057.757689692407, 4620.376249206364, 4699.976500117503, 4700.365450664168, 4712.010477799649, 4728.101660684476, 4484.170428470743, 4559.088182363524, 4570.702904311209, 4668.603168730662, 4684.625229981611, 4610.147122782279, 4613.5847773700525, 4625.79183936722, 4659.394278743775, 4664.416947881515, 4628.213203755369, 4630.259158534618, 4632.0, 4640.048789998043, 4656.231721765938, 4090.9386359204636, 4097.1191193893455, 4100.200460910124, 4101.774402407867, 4127.071408932996, 5560.805371811967, 5668.744906479218, 5675.091985282335, 5675.772969081232, 5681.687507187103, 5416.945830541684, 5417.322834645669, 5418.106012507931, 5419.132938729824, 5424.511793938525, 6011.909821352683, 6385.616862988236, 6389.722055588901, 6390.776322828725, 6393.392627700361, 4392.846250381222, 4400.3399490076745, 4511.729296242236, 4517.096580683843, 4521.570450807168, 6578.0, 6581.078648989145, 6582.605043697441, 6591.637459939701, 6602.438792702626, 4626.236670949255, 4627.190241707688, 4629.143608432383, 4629.814807407666, 4631.235846085358, 4418.2047231498, 4631.675782695246, 4631.9536804631525, 4691.648126390534, 4692.788824502905, 5328.200769884471, 5364.275822763877, 5366.785328586813, 5373.650712703662, 5378.1663842104535, 6476.902846457307, 6506.41442270198, 6507.739690412425, 6507.869842603216, 6509.446697030806, 1589.348367169455, 1636.738121900514, 1643.8520533152073, 1644.6052947292803, 1644.9095299758628, 1062.984055239172, 1069.887661795516, 1072.4744875011188, 1086.2124959404528, 1117.6982214801958, 6098.26820781509, 6160.260768707694, 6160.907586386208, 6168.568200225941, 6168.599041062316, 6560.081588577603, 6563.474922006228, 6565.540412171103, 6571.474282057424, 6574.638394888327, 6004.159417681528, 6161.229846269216, 6162.0, 6162.106494558264, 6168.660723660242, 3537.5224344713647, 3540.929181416357, 3564.3405969895653, 3567.2865426914723, 3569.036360182788, 6737.225219099768, 6738.326167383222, 6743.15710536183, 6745.898811517831, 6750.493712971547, 6548.792385958678, 6674.566153200027, 6676.632785196861, 6677.833054173588, 6687.230968438595, 6674.666266686646, 6689.565178263398, 6714.697838597275, 6717.664116794141, 6734.663266836638, 6412.454941329853, 6512.218533775977, 6517.0, 6541.116949211795, 6576.934230657824, 6593.241777195684, 6594.175728033804, 6598.505112116706, 6634.369734875179, 6657.667116644052, 6827.48793840454, 6887.5178737487895, 6905.343992320722, 6915.308469153045, 6918.204406493318, 4421.867343979686, 4526.660500462544, 4534.795934183036, 4575.771211439348, 4581.083783243298, 6618.643178148372, 6671.633060181736, 6681.899771503334, 6684.63234522106, 6692.59844409337, 6497.122888410004, 6511.38141876521, 6514.869702606016, 6517.837054073686, 6519.250286216956, 6375.5537112403545, 6503.772367967098, 6505.804825855232, 6550.934490655032, 6555.2133743951035, 6416.294207637249, 6420.839479012875, 6432.581882177644, 6434.292227855026, 6436.645984470899, 6565.606063636197, 6566.4418524424045, 6570.704318305592, 6582.703778330082, 6586.80239592813, 6246.781362652286, 6416.48668106541, 6435.388638079375, 6436.485081193399, 6438.581492202992], "unit": "ms", "name": "prototype.html", "value": 4850.17293332844}, {"lowerIsBetter": false, "replicates": [737.2001378504324, 738.837455759733, 740.3263030642116, 797.5892415406067, 814.8003739083923, 13393.464261429543, 13666.248356340397, 13678.0425370224, 13689.0, 13692.110012849158, 12779.105462617597, 12819.359032048384, 12833.807492887614, 12940.74118517629, 12960.54638087667, 669.4744625469008, 677.5155763629004, 804.6660635836121, 804.7424824056304, 819.8565251081037, 814.8573999550055, 816.1063635319316, 821.6261600971574, 822.1696086952162, 829.531314807132, 706.4524993130314, 859.6045818923303, 865.6580650642992, 865.8571335729597, 866.6403442571325, 706.466617703633, 839.7606682095604, 868.9478631282143, 870.0342619692136, 870.2124577257592, 629.078400143787, 632.2855173653742, 632.8196464007782, 632.8797528469576, 633.1041576169761, 12731.172473789267, 12875.806862897063, 13000.609981700563, 13003.089783715144, 13007.804882926765, 12124.939375303067, 12719.745605087846, 13022.348882555834, 13089.06797687165, 13251.403686834115, 9222.769430764218, 9306.627734890597, 9322.440653560809, 9365.391249568756, 9409.952950235274, 3588.7129029677562, 3633.091727068233, 3634.8727794527063, 3644.234710710754, 3657.4696668983115, 46714.5328546717, 47334.0, 49216.75391623019, 49898.50101499011, 49919.50080499185, 10166.4916754162, 10186.796264074677, 10263.557279319088, 10419.374837509773, 10474.947625261824, 19176.137073831713, 19215.231390744215, 19217.423477295702, 19218.231270749013, 19252.518687032654, 7289.70841166358, 7368.815779605446, 7470.252974702486, 7482.625868706543, 7621.618919054025, 4177.56135605757, 4199.832006719758, 4214.726042807208, 4225.3873188387515, 4238.152369526107, 3226.790258633181, 3260.510923361515, 3268.607767067967, 3268.836558172082, 3277.901662950115, 558.6899270904687, 581.7411251992908, 582.1209972940806, 584.4622946888787, 585.7130006296969, 601.6690820048956, 625.5714835337717, 648.4779752299444, 650.768977013163, 650.8340373204802, 7593.620318984139, 7851.018622672166, 8010.279074883289, 8033.1163572007035, 8153.673853045931, 529.9761510732027, 538.8141091323487, 539.2908325551965, 544.2842661899668, 615.3999850146162, 3796.354619714655, 3879.147719374859, 3929.174873276587, 3996.140829721624, 4050.675945924319, 55897.0, 56172.0, 56319.71840140855, 56599.717001415556, 56689.0, 50388.74805625949, 52109.0, 52385.7380713094, 52570.211446828325, 52805.2079218812, 45593.0, 46169.76915115403, 46508.7674561625, 46691.5330846694, 46753.5324646756, 8199.590020498832, 8390.790230244049, 8447.577621118797, 8568.143185681382, 8588.828223435621, 34939.0, 34983.65016349804, 35648.465273021444, 35934.460983085795, 36844.63155368412, 42287.15425691407, 44230.55769442264, 46529.30206046844, 46594.301085483065, 46960.7651961738, 10326.173906087344, 10890.727731806768, 11007.339559626447, 11027.779444411228, 11608.013318867654, 12247.571335003233, 12254.20347677398, 12284.877151228731, 12402.441890114786, 12955.870441295467, 10762.784744304914, 10854.782904342026, 11098.61154859576, 11350.148738844455, 11917.028672887867, 11434.542618295174, 11443.542258309575, 11628.6511404658, 11666.533338666697, 12110.515579376726, 8376.539290338846, 9535.47554884488, 10179.0, 10417.42704151279, 11487.885121148682, 9235.445873247627, 9498.382605130644, 9819.55811988448, 9934.552945117342, 10021.348612340174, 9510.429374237568, 9936.900630993598, 9958.936331380039, 9991.800163996533, 10019.348742331726], "unit": "ms", "name": "yui.html", "value": 6233.637136879814}], "name": "dromaeo_css", "value": 6992.988769129858}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 111.0, 111.0, 111.0, 98.0, 109.0, 112.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [148.0, 124.0, 145.0, 165.0, 124.0, 150.0, 151.0, 125.0, 165.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 160.0, 158.0, 162.0, 161.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 82.0, 93.0, 72.0, 73.0, 73.0, 118.0, 95.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 132.0, 89.0, 90.0, 90.0, 133.0, 90.0, 90.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 66.0, 59.0, 59.0, 59.0, 62.0, 66.0, 57.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 89.0, 84.0, 86.0, 84.0, 84.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 123.0, 115.0, 121.0, 123.0, 122.0, 117.0, 125.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [142.0, 155.0, 150.0, 138.0, 147.0, 140.0, 152.0, 148.0, 147.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 66.0, 69.0, 68.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1496.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.26530612244898], "unit": "score", "name": "Richards", "value": 216.22475000000003}, {"lowerIsBetter": false, "replicates": [193.46101760495262], "unit": "score", "name": "DeltaBlue", "value": 341.7639419999998}, {"lowerIsBetter": false, "replicates": [284.6569883290635], "unit": "score", "name": "Encrypt", "value": 935.093853}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1941.7475728155339], "unit": "score", "name": "RayTrace", "value": 381.094335}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [11916.666666666666], "unit": "score", "name": "Boyer", "value": 55.926965034964994}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [644.2185514612453], "unit": "score", "name": "Splay", "value": 126.49589151873771}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19809.29146542345}]} 01:09:34 INFO - RETURN: dromaeo_css: 6992.99 01:09:34 INFO - RETURN: kraken: 1496.00 01:09:34 INFO - RETURN: v8_7: 19809.29 01:09:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19809.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1496.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6992.99"}}} 01:09:34 INFO - Return code: 0 01:09:34 INFO - # TBPL SUCCESS # 01:09:34 INFO - Running post-action listener: _resource_record_post_action 01:09:34 INFO - Running post-run listener: _resource_record_post_run 01:09:35 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 516096; Write bytes: 274124800; Read time: 156; Write time: 123536 01:09:35 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9420800; Read time: 0; Write time: 1464 01:09:35 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 516096; Write bytes: 264704000; Read time: 156; Write time: 122072 01:09:35 INFO - Running post-run listener: _upload_blobber_files 01:09:35 INFO - Blob upload gear active. 01:09:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:09:35 INFO - Copying logs to upload dir... 01:09:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.335004 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-11-23 01:09:35.097015) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 01:09:35.100709) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009848 build_url: 'https://queue.taskcluster.net/v1/task/QNL6cVC3RjmdRcyK7p8QqA/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 01:09:35.151185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 01:09:35.151533) ========= 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=3e14eba40af1795cf0357910000001c3-1448261063.933978-620484932 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 01:09:35.201201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 01:09:35.201526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 01:09:35.201883) ========= ========= Total master_lag: 0.22 =========