builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1448080895.19 results: success (0) buildid: 20151120193127 builduid: 85d8a643dd9f469992c2a7ef8f482c9e revision: eaa63e3f270780d6f7474f3e3153f896d6b49516 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.194514) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.195077) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.195378) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006547 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.232833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.233148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.301517) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.301808) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.363576) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.363887) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.364290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.364688) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 20:41:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-11-20 20:41:35 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187678 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.655282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.655566) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019303 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.733148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.733476) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eaa63e3f270780d6f7474f3e3153f896d6b49516 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eaa63e3f270780d6f7474f3e3153f896d6b49516 --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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 20:41:35,931 truncating revision to first 12 chars 2015-11-20 20:41:35,931 Setting DEBUG logging. 2015-11-20 20:41:35,931 attempt 1/10 2015-11-20 20:41:35,931 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/eaa63e3f2707?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 20:41:36,191 unpacking tar archive at: mozilla-inbound-eaa63e3f2707/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539718 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.303153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.303456) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.316531) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.316804) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.317195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2015-11-20 20:41:36.317495) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:41:36 INFO - MultiFileLogger online at 20151120 20:41:36 in /builds/slave/test-pgo 20:41:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:41:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:41:36 INFO - {'append_to_log': False, 20:41:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:41:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:41:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:41:36 INFO - 'branch': 'Mozilla-Inbound', 20:41:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:41:36 INFO - 'config_files': ('talos/linux_config.py',), 20:41:36 INFO - 'default_actions': ('clobber', 20:41:36 INFO - 'read-buildbot-config', 20:41:36 INFO - 'download-and-extract', 20:41:36 INFO - 'populate-webroot', 20:41:36 INFO - 'create-virtualenv', 20:41:36 INFO - 'install', 20:41:36 INFO - 'run-tests'), 20:41:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:41:36 INFO - 'download_minidump_stackwalk': True, 20:41:36 INFO - 'download_symbols': 'ondemand', 20:41:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:41:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:41:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:41:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:41:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:41:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:41:36 INFO - 'installer_path': 'installer.exe', 20:41:36 INFO - 'log_level': 'info', 20:41:36 INFO - 'log_name': 'talos', 20:41:36 INFO - 'log_to_console': True, 20:41:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:41:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:41:36 INFO - 'opt_config_files': (), 20:41:36 INFO - 'pip_index': False, 20:41:36 INFO - 'sps_profile': False, 20:41:36 INFO - 'sps_profile_interval': 0, 20:41:36 INFO - 'suite': 'dromaeojs', 20:41:36 INFO - 'system_bits': '64', 20:41:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:41:36 INFO - 'title': 'talos-linux64-ix-033', 20:41:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:41:36 INFO - 'use_talos_json': True, 20:41:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:41:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:41:36 INFO - 'work_dir': 'build'} 20:41:36 INFO - ##### 20:41:36 INFO - ##### Running clobber step. 20:41:36 INFO - ##### 20:41:36 INFO - Running pre-action listener: _resource_record_pre_action 20:41:36 INFO - Running main action method: clobber 20:41:36 INFO - rmtree: /builds/slave/test-pgo/build 20:41:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:41:37 INFO - Running post-action listener: _resource_record_post_action 20:41:37 INFO - ##### 20:41:37 INFO - ##### Running read-buildbot-config step. 20:41:37 INFO - ##### 20:41:37 INFO - Running pre-action listener: _resource_record_pre_action 20:41:37 INFO - Running main action method: read_buildbot_config 20:41:37 INFO - Using buildbot properties: 20:41:37 INFO - { 20:41:37 INFO - "properties": { 20:41:37 INFO - "buildnumber": 1289, 20:41:37 INFO - "product": "firefox", 20:41:37 INFO - "script_repo_revision": "production", 20:41:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 20:41:37 INFO - "repository": "", 20:41:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 20:41:37 INFO - "buildid": "20151120193127", 20:41:37 INFO - "slavename": "talos-linux64-ix-033", 20:41:37 INFO - "pgo_build": "True", 20:41:37 INFO - "basedir": "/builds/slave/test-pgo", 20:41:37 INFO - "project": "", 20:41:37 INFO - "platform": "ubuntu64_hw", 20:41:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:41:37 INFO - "slavebuilddir": "test", 20:41:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:41:37 INFO - "branch": "mozilla-inbound", 20:41:37 INFO - "repo_path": "integration/mozilla-inbound", 20:41:37 INFO - "stage_platform": "linux64-pgo", 20:41:37 INFO - "builduid": "85d8a643dd9f469992c2a7ef8f482c9e", 20:41:37 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:37 INFO - }, 20:41:37 INFO - "sourcestamp": { 20:41:37 INFO - "repository": "", 20:41:37 INFO - "hasPatch": false, 20:41:37 INFO - "project": "", 20:41:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 20:41:37 INFO - "changes": [ 20:41:37 INFO - { 20:41:37 INFO - "category": null, 20:41:37 INFO - "files": [ 20:41:37 INFO - { 20:41:37 INFO - "url": null, 20:41:37 INFO - "name": "https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:41:37 INFO - } 20:41:37 INFO - ], 20:41:37 INFO - "repository": "", 20:41:37 INFO - "rev": "eaa63e3f270780d6f7474f3e3153f896d6b49516", 20:41:37 INFO - "who": "sendchange", 20:41:37 INFO - "when": 1448080847, 20:41:37 INFO - "number": 6691870, 20:41:37 INFO - "comments": "", 20:41:37 INFO - "project": "", 20:41:37 INFO - "at": "Fri 20 Nov 2015 20:40:47", 20:41:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 20:41:37 INFO - "revlink": "", 20:41:37 INFO - "properties": [ 20:41:37 INFO - [ 20:41:37 INFO - "buildid", 20:41:37 INFO - "20151120193127", 20:41:37 INFO - "Change" 20:41:37 INFO - ], 20:41:37 INFO - [ 20:41:37 INFO - "builduid", 20:41:37 INFO - "85d8a643dd9f469992c2a7ef8f482c9e", 20:41:37 INFO - "Change" 20:41:37 INFO - ], 20:41:37 INFO - [ 20:41:37 INFO - "pgo_build", 20:41:37 INFO - "True", 20:41:37 INFO - "Change" 20:41:37 INFO - ] 20:41:37 INFO - ], 20:41:37 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:37 INFO - } 20:41:37 INFO - ], 20:41:37 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:37 INFO - } 20:41:37 INFO - } 20:41:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:41:37 INFO - Running post-action listener: _resource_record_post_action 20:41:37 INFO - ##### 20:41:37 INFO - ##### Running download-and-extract step. 20:41:37 INFO - ##### 20:41:37 INFO - Running pre-action listener: _resource_record_pre_action 20:41:37 INFO - Running main action method: download_and_extract 20:41:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:41:37 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')]} 20:41:37 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:41:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json 20:41:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json 20:41:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:41:47 INFO - Downloaded 1302 bytes. 20:41:47 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:41:47 INFO - Using the following test package requirements: 20:41:47 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:41:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'jsshell-linux-x86_64.zip'], 20:41:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:41:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:41:47 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:41:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:41:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:47 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:41:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:41:47 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')]} 20:41:47 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:51 INFO - Downloaded 22523516 bytes. 20:41:51 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 20:41:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:51 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 20:41:52 INFO - Return code: 0 20:41:52 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 20:41: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')]} 20:41:52 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:56 INFO - Downloaded 22523516 bytes. 20:41:56 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 20:41:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:56 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 20:41:58 INFO - Return code: 0 20:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:58 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:59 INFO - Downloaded 11130997 bytes. 20:41:59 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 20:41:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:41:59 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 20:41:59 INFO - Return code: 0 20:41:59 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')]} 20:41:59 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:41:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:41:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:41:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:42:01 INFO - Downloaded 57475353 bytes. 20:42:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:01 INFO - mkdir: /builds/slave/test-pgo/properties 20:42:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:42:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:42:01 INFO - Contents: 20:42:01 INFO - build_url:https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:01 INFO - Running post-action listener: _resource_record_post_action 20:42:01 INFO - Running post-action listener: set_extra_try_arguments 20:42:01 INFO - ##### 20:42:01 INFO - ##### Running populate-webroot step. 20:42:01 INFO - ##### 20:42:01 INFO - Running pre-action listener: _resource_record_pre_action 20:42:01 INFO - Running main action method: populate_webroot 20:42:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:42:01 INFO - '../fennec_ids.txt'], 20:42:01 INFO - 'tests': ['tcheck2']}, 20:42:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:01 INFO - '--tppagecycles', 20:42:01 INFO - '7'], 20:42:01 INFO - 'tests': ['tsvgm']}}, 20:42:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:42:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:42:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:42:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'tests': ['damp', 'tps']}, 20:42:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['damp', 'tps']}, 20:42:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:42:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:01 INFO - 'other': {'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'other_l64': {'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'other_nol64': {'tests': ['a11yr', 20:42:01 INFO - 'ts_paint', 20:42:01 INFO - 'tpaint', 20:42:01 INFO - 'sessionrestore', 20:42:01 INFO - 'sessionrestore_no_auto_restore']}, 20:42:01 INFO - 'svgr': {'tests': ['tsvgx', 20:42:01 INFO - 'tsvgr_opacity', 20:42:01 INFO - 'tart', 20:42:01 INFO - 'tscrollx', 20:42:01 INFO - 'cart']}, 20:42:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['tsvgx', 20:42:01 INFO - 'tsvgr_opacity', 20:42:01 INFO - 'tart', 20:42:01 INFO - 'tscrollx', 20:42:01 INFO - 'cart']}, 20:42:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'tests': ['tp5o']}, 20:42:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'talos_options': ['--e10s'], 20:42:01 INFO - 'tests': ['tp5o']}, 20:42:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'talos_options': ['--xperf_path', 20:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:01 INFO - 'tests': ['tp5n']}, 20:42:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:01 INFO - 'talos_options': ['--e10s', 20:42:01 INFO - '--xperf_path', 20:42:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:01 INFO - 'tests': ['tp5n']}}, 20:42:01 INFO - 'talos.zip': {'path': '', 20:42:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:01 INFO - Running post-action listener: _resource_record_post_action 20:42:01 INFO - ##### 20:42:01 INFO - ##### Running create-virtualenv step. 20:42:01 INFO - ##### 20:42:01 INFO - Running pre-action listener: _resource_record_pre_action 20:42:01 INFO - Running main action method: create_virtualenv 20:42:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:42:01 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 20:42:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:42:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:01 INFO - Using real prefix '/usr' 20:42:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:42:02 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:04 INFO - Installing pip.................done. 20:42:04 INFO - Return code: 0 20:42:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:42:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:42:04 INFO - Using env: {'DISPLAY': ':0', 20:42:04 INFO - 'HOME': '/home/cltbld', 20:42:04 INFO - 'LANG': 'en_US.UTF-8', 20:42:04 INFO - 'LANGUAGE': 'en_US:en', 20:42:04 INFO - 'LOGNAME': 'cltbld', 20:42:04 INFO - 'MAIL': '/var/mail/cltbld', 20:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:04 INFO - 'MOZ_NO_REMOTE': '1', 20:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:04 INFO - 'NO_EM_RESTART': '1', 20:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:04 INFO - 'SHELL': '/bin/bash', 20:42:04 INFO - 'SHLVL': '1', 20:42:04 INFO - 'TERM': 'linux', 20:42:04 INFO - 'TMOUT': '86400', 20:42:04 INFO - 'USER': 'cltbld', 20:42:04 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:04 INFO - '_': '/tools/buildbot/bin/python'} 20:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:04 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 20:42:04 INFO - Cleaning up... 20:42:04 INFO - Return code: 0 20:42:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:42:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:42:04 INFO - Using env: {'DISPLAY': ':0', 20:42:04 INFO - 'HOME': '/home/cltbld', 20:42:04 INFO - 'LANG': 'en_US.UTF-8', 20:42:04 INFO - 'LANGUAGE': 'en_US:en', 20:42:04 INFO - 'LOGNAME': 'cltbld', 20:42:04 INFO - 'MAIL': '/var/mail/cltbld', 20:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:04 INFO - 'MOZ_NO_REMOTE': '1', 20:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:04 INFO - 'NO_EM_RESTART': '1', 20:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:04 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:04 INFO - 'SHELL': '/bin/bash', 20:42:04 INFO - 'SHLVL': '1', 20:42:04 INFO - 'TERM': 'linux', 20:42:04 INFO - 'TMOUT': '86400', 20:42:04 INFO - 'USER': 'cltbld', 20:42:04 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:04 INFO - '_': '/tools/buildbot/bin/python'} 20:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:04 INFO - Downloading/unpacking psutil>=0.7.1 20:42: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 20:42: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 20:42: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 20:42: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 20:42: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 20:42: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 20:42:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:42:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:42:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:06 INFO - Installing collected packages: psutil 20:42:06 INFO - Running setup.py install for psutil 20:42:06 INFO - building 'psutil._psutil_linux' extension 20:42:06 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 20:42:06 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 20:42:06 INFO - building 'psutil._psutil_posix' extension 20:42:06 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 20:42:07 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 20:42:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:07 INFO - Successfully installed psutil 20:42:07 INFO - Cleaning up... 20:42:07 INFO - Return code: 0 20:42:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:42: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')]} 20:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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', '--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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:07 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 20:42:07 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 20:42:07 INFO - Using env: {'DISPLAY': ':0', 20:42:07 INFO - 'HOME': '/home/cltbld', 20:42:07 INFO - 'LANG': 'en_US.UTF-8', 20:42:07 INFO - 'LANGUAGE': 'en_US:en', 20:42:07 INFO - 'LOGNAME': 'cltbld', 20:42:07 INFO - 'MAIL': '/var/mail/cltbld', 20:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:07 INFO - 'MOZ_NO_REMOTE': '1', 20:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:07 INFO - 'NO_EM_RESTART': '1', 20:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:07 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:07 INFO - 'SHELL': '/bin/bash', 20:42:07 INFO - 'SHLVL': '1', 20:42:07 INFO - 'TERM': 'linux', 20:42:07 INFO - 'TMOUT': '86400', 20:42:07 INFO - 'USER': 'cltbld', 20:42:07 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:07 INFO - '_': '/tools/buildbot/bin/python'} 20:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:42:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:42:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:42:09 INFO - Installing collected packages: mozsystemmonitor 20:42:09 INFO - Running setup.py install for mozsystemmonitor 20:42:09 INFO - Successfully installed mozsystemmonitor 20:42:09 INFO - Cleaning up... 20:42:09 INFO - Return code: 0 20:42:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:42:09 INFO - Using env: {'DISPLAY': ':0', 20:42:09 INFO - 'HOME': '/home/cltbld', 20:42:09 INFO - 'LANG': 'en_US.UTF-8', 20:42:09 INFO - 'LANGUAGE': 'en_US:en', 20:42:09 INFO - 'LOGNAME': 'cltbld', 20:42:09 INFO - 'MAIL': '/var/mail/cltbld', 20:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:09 INFO - 'MOZ_NO_REMOTE': '1', 20:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:09 INFO - 'NO_EM_RESTART': '1', 20:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:09 INFO - 'SHELL': '/bin/bash', 20:42:09 INFO - 'SHLVL': '1', 20:42:09 INFO - 'TERM': 'linux', 20:42:09 INFO - 'TMOUT': '86400', 20:42:09 INFO - 'USER': 'cltbld', 20:42:09 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:09 INFO - '_': '/tools/buildbot/bin/python'} 20:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:09 INFO - Downloading/unpacking blobuploader==1.2.4 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:11 INFO - Downloading blobuploader-1.2.4.tar.gz 20:42:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:42:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:42:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:11 INFO - Downloading docopt-0.6.1.tar.gz 20:42:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:42:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:42:11 INFO - Installing collected packages: blobuploader, requests, docopt 20:42:11 INFO - Running setup.py install for blobuploader 20:42:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:42:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:42:11 INFO - Running setup.py install for requests 20:42:12 INFO - Running setup.py install for docopt 20:42:12 INFO - Successfully installed blobuploader requests docopt 20:42:12 INFO - Cleaning up... 20:42:12 INFO - Return code: 0 20:42:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:12 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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:12 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 20:42:12 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 20:42:12 INFO - Using env: {'DISPLAY': ':0', 20:42:12 INFO - 'HOME': '/home/cltbld', 20:42:12 INFO - 'LANG': 'en_US.UTF-8', 20:42:12 INFO - 'LANGUAGE': 'en_US:en', 20:42:12 INFO - 'LOGNAME': 'cltbld', 20:42:12 INFO - 'MAIL': '/var/mail/cltbld', 20:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:12 INFO - 'MOZ_NO_REMOTE': '1', 20:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:12 INFO - 'NO_EM_RESTART': '1', 20:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:12 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:12 INFO - 'SHELL': '/bin/bash', 20:42:12 INFO - 'SHLVL': '1', 20:42:12 INFO - 'TERM': 'linux', 20:42:12 INFO - 'TMOUT': '86400', 20:42:12 INFO - 'USER': 'cltbld', 20:42:12 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:12 INFO - '_': '/tools/buildbot/bin/python'} 20:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:12 INFO - Running setup.py (path:/tmp/pip-B6U74S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:12 INFO - Running setup.py (path:/tmp/pip-Q3cYre-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:12 INFO - Running setup.py (path:/tmp/pip-UKRiV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:12 INFO - Running setup.py (path:/tmp/pip-l2pf9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:12 INFO - Running setup.py (path:/tmp/pip-cNtJzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:13 INFO - Running setup.py (path:/tmp/pip-1V5EL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:13 INFO - Running setup.py (path:/tmp/pip-w0UiLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:13 INFO - Running setup.py (path:/tmp/pip-9ZrXOW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:13 INFO - Running setup.py (path:/tmp/pip-S2Xgfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:13 INFO - Running setup.py (path:/tmp/pip-YKBGgW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:13 INFO - Running setup.py (path:/tmp/pip-RmVSdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:13 INFO - Running setup.py (path:/tmp/pip-lNT3lm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:13 INFO - Running setup.py (path:/tmp/pip-6toYIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:13 INFO - Running setup.py (path:/tmp/pip-Heasn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:13 INFO - Running setup.py (path:/tmp/pip-XGku7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:13 INFO - Running setup.py (path:/tmp/pip-ArqQa6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:13 INFO - Running setup.py (path:/tmp/pip-_1siRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:13 INFO - Running setup.py install for manifestparser 20:42:14 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for mozcrash 20:42:14 INFO - Running setup.py install for mozdebug 20:42:14 INFO - Running setup.py install for mozdevice 20:42:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for mozfile 20:42:14 INFO - Running setup.py install for mozhttpd 20:42:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for mozinfo 20:42:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for mozInstall 20:42:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for mozleak 20:42:14 INFO - Running setup.py install for mozlog 20:42:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:42:14 INFO - Running setup.py install for moznetwork 20:42:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Running setup.py install for mozprocess 20:42:15 INFO - Running setup.py install for mozprofile 20:42:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Running setup.py install for mozrunner 20:42:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Running setup.py install for mozscreenshot 20:42:15 INFO - Running setup.py install for moztest 20:42:15 INFO - Running setup.py install for mozversion 20:42:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:15 INFO - Cleaning up... 20:42:15 INFO - Return code: 0 20:42:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:15 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 20:42:15 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 20:42:15 INFO - Using env: {'DISPLAY': ':0', 20:42:15 INFO - 'HOME': '/home/cltbld', 20:42:15 INFO - 'LANG': 'en_US.UTF-8', 20:42:15 INFO - 'LANGUAGE': 'en_US:en', 20:42:15 INFO - 'LOGNAME': 'cltbld', 20:42:15 INFO - 'MAIL': '/var/mail/cltbld', 20:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:15 INFO - 'MOZ_NO_REMOTE': '1', 20:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:15 INFO - 'NO_EM_RESTART': '1', 20:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:15 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:15 INFO - 'SHELL': '/bin/bash', 20:42:15 INFO - 'SHLVL': '1', 20:42:15 INFO - 'TERM': 'linux', 20:42:15 INFO - 'TMOUT': '86400', 20:42:15 INFO - 'USER': 'cltbld', 20:42:15 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:15 INFO - '_': '/tools/buildbot/bin/python'} 20:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:15 INFO - Running setup.py (path:/tmp/pip-Lh4jPW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:16 INFO - Running setup.py (path:/tmp/pip-tY0AxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:16 INFO - Running setup.py (path:/tmp/pip-QAA6re-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:16 INFO - Running setup.py (path:/tmp/pip-raIqoV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:16 INFO - Running setup.py (path:/tmp/pip-j7RoYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:16 INFO - Running setup.py (path:/tmp/pip-2e3zDL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:16 INFO - Running setup.py (path:/tmp/pip-F3I3ZT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:16 INFO - Running setup.py (path:/tmp/pip-YdgI3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:16 INFO - Running setup.py (path:/tmp/pip-9YweGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:16 INFO - Running setup.py (path:/tmp/pip-qYP6VX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:16 INFO - Running setup.py (path:/tmp/pip-xEYhdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:16 INFO - Running setup.py (path:/tmp/pip-avxEVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:16 INFO - Running setup.py (path:/tmp/pip-OjYUy9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:16 INFO - Running setup.py (path:/tmp/pip-j__eJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:16 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)) 20:42:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:16 INFO - Running setup.py (path:/tmp/pip-2lbbUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:17 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)) 20:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:17 INFO - Running setup.py (path:/tmp/pip-K3lflI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:17 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)) 20:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:17 INFO - Running setup.py (path:/tmp/pip-GG2U5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:17 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)) 20:42:17 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)) 20:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:42:17 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)) 20:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:42:17 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)) 20:42:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:17 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 20:42:17 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 20:42:17 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 20:42:17 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 20:42:17 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 20:42:17 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 20:42:18 INFO - Downloading blessings-1.5.1.tar.gz 20:42:18 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 20:42:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:18 INFO - Installing collected packages: blessings 20:42:18 INFO - Running setup.py install for blessings 20:42:19 INFO - Successfully installed blessings 20:42:19 INFO - Cleaning up... 20:42:19 INFO - Return code: 0 20:42:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:42:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:19 INFO - Reading from file tmpfile_stdout 20:42:19 INFO - Current package versions: 20:42:19 INFO - argparse == 1.2.1 20:42:19 INFO - blessings == 1.5.1 20:42:19 INFO - blobuploader == 1.2.4 20:42:19 INFO - docopt == 0.6.1 20:42:19 INFO - manifestparser == 1.1 20:42:19 INFO - mozInstall == 1.12 20:42:19 INFO - mozcrash == 0.16 20:42:19 INFO - mozdebug == 0.1 20:42:19 INFO - mozdevice == 0.47 20:42:19 INFO - mozfile == 1.2 20:42:19 INFO - mozhttpd == 0.7 20:42:19 INFO - mozinfo == 0.9 20:42:19 INFO - mozleak == 0.1 20:42:19 INFO - mozlog == 3.1 20:42:19 INFO - moznetwork == 0.27 20:42:19 INFO - mozprocess == 0.22 20:42:19 INFO - mozprofile == 0.27 20:42:19 INFO - mozrunner == 6.11 20:42:19 INFO - mozscreenshot == 0.1 20:42:19 INFO - mozsystemmonitor == 0.0 20:42:19 INFO - moztest == 0.7 20:42:19 INFO - mozversion == 1.4 20:42:19 INFO - psutil == 3.1.1 20:42:19 INFO - requests == 1.2.3 20:42:19 INFO - wsgiref == 0.1.2 20:42:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:19 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')]} 20:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:19 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')]} 20:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:19 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 0x7f1415201c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f96c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', '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 20:42:19 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 20:42:19 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 20:42:19 INFO - Using env: {'DISPLAY': ':0', 20:42:19 INFO - 'HOME': '/home/cltbld', 20:42:19 INFO - 'LANG': 'en_US.UTF-8', 20:42:19 INFO - 'LANGUAGE': 'en_US:en', 20:42:19 INFO - 'LOGNAME': 'cltbld', 20:42:19 INFO - 'MAIL': '/var/mail/cltbld', 20:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:19 INFO - 'MOZ_NO_REMOTE': '1', 20:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:19 INFO - 'NO_EM_RESTART': '1', 20:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:19 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:19 INFO - 'SHELL': '/bin/bash', 20:42:19 INFO - 'SHLVL': '1', 20:42:19 INFO - 'TERM': 'linux', 20:42:19 INFO - 'TMOUT': '86400', 20:42:19 INFO - 'USER': 'cltbld', 20:42:19 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:19 INFO - '_': '/tools/buildbot/bin/python'} 20:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 INFO - Cleaning up... 20:42:19 INFO - Return code: 0 20:42:19 INFO - Running post-action listener: _resource_record_post_action 20:42:19 INFO - Running post-action listener: _start_resource_monitoring 20:42:19 INFO - Starting resource monitoring. 20:42:19 INFO - ##### 20:42:19 INFO - ##### Running install step. 20:42:19 INFO - ##### 20:42:19 INFO - Running pre-action listener: _resource_record_pre_action 20:42:19 INFO - Running main action method: install 20:42:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:19 INFO - Reading from file tmpfile_stdout 20:42:19 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:42:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:42:19 INFO - Reading from file tmpfile_stdout 20:42:19 INFO - Output received: 20:42:19 INFO - Usage: mozinstall [options] installer 20:42:19 INFO - Options: 20:42:19 INFO - -h, --help show this help message and exit 20:42:19 INFO - -d DEST, --destination=DEST 20:42:19 INFO - Directory to install application into. [default: 20:42:19 INFO - "/builds/slave/test-pgo"] 20:42:19 INFO - --app=APP Application being installed. [default: firefox] 20:42:19 INFO - mkdir: /builds/slave/test-pgo/build/application 20:42:19 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'] 20:42:19 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 20:42:35 INFO - Reading from file tmpfile_stdout 20:42:35 INFO - Output received: 20:42:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:42:35 INFO - Running post-action listener: _resource_record_post_action 20:42:35 INFO - ##### 20:42:35 INFO - ##### Running run-tests step. 20:42:35 INFO - ##### 20:42:35 INFO - Running pre-action listener: _resource_record_pre_action 20:42:35 INFO - Running main action method: run_tests 20:42:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:42:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:42:35 INFO - Python 2.7.3 20:42:35 INFO - Return code: 0 20:42:35 INFO - grabbing minidump binary from tooltool 20:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24efd70>, '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 0x24f0b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f0fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:42:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 20:42:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:42:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:42:35 INFO - Return code: 0 20:42:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:42:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:42:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:42:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:42:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 20:42:35 INFO - Using env: {'DISPLAY': ':0', 20:42:35 INFO - 'HOME': '/home/cltbld', 20:42:35 INFO - 'LANG': 'en_US.UTF-8', 20:42:35 INFO - 'LANGUAGE': 'en_US:en', 20:42:35 INFO - 'LOGNAME': 'cltbld', 20:42:35 INFO - 'MAIL': '/var/mail/cltbld', 20:42:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:35 INFO - 'MOZ_NO_REMOTE': '1', 20:42:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:35 INFO - 'NO_EM_RESTART': '1', 20:42:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:35 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:42:35 INFO - 'SHELL': '/bin/bash', 20:42:35 INFO - 'SHLVL': '1', 20:42:35 INFO - 'TERM': 'linux', 20:42:35 INFO - 'TMOUT': '86400', 20:42:35 INFO - 'USER': 'cltbld', 20:42:35 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368', 20:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:35 INFO - '_': '/tools/buildbot/bin/python'} 20:42:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 20:42:35 INFO - mozversion INFO | application_buildid: 20151120193127 20:42:35 INFO - mozversion INFO | application_changeset: eaa63e3f270780d6f7474f3e3153f896d6b49516 20:42:35 INFO - mozversion INFO | application_display_name: Nightly 20:42:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:42:35 INFO - mozversion INFO | application_name: Firefox 20:42:35 INFO - mozversion INFO | application_remotingname: firefox 20:42:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:35 INFO - mozversion INFO | application_vendor: Mozilla 20:42:35 INFO - mozversion INFO | application_version: 45.0a1 20:42:35 INFO - mozversion INFO | platform_buildid: 20151120193127 20:42:35 INFO - mozversion INFO | platform_changeset: eaa63e3f270780d6f7474f3e3153f896d6b49516 20:42:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:35 INFO - mozversion INFO | platform_version: 45.0a1 20:42:35 INFO - 2015-11-20 20:42:35,831 DEBUG : using testdate: 1448080955 20:42:35 INFO - 2015-11-20 20:42:35,831 DEBUG : actual date: 1448080955 20:42:35 INFO - 2015-11-20 20:42:35,840 INFO : starting webserver on 'localhost:59652' 20:42:35 INFO - 2015-11-20 20:42:35,841 INFO : Starting test suite talos-linux64-ix-033 20:42:35 INFO - 2015-11-20 20:42:35,841 INFO : Starting test dromaeo_css 20:42:35 INFO - 2015-11-20 20:42:35,841 DEBUG : operating with platform_type : linux_ 20:42:35 INFO - 2015-11-20 20:42:35,841 INFO : Initialising browser for dromaeo_css test... 20:42:35 INFO - 2015-11-20 20:42:35,848 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDEWNju/profile http://localhost:59652/getInfo.html 20:42:42 INFO - 2015-11-20 20:42:42,156 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:42:42 INFO - 2015-11-20 20:42:42,156 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:42:42 INFO - 2015-11-20 20:42:42,156 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:42:42 INFO - 2015-11-20 20:42:42,156 DEBUG : BROWSER_OUTPUT: __metrics 20:42:42 INFO - 2015-11-20 20:42:42,394 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:42:44 INFO - 2015-11-20 20:42:44,368 INFO : Browser initialized. 20:42:44 INFO - 2015-11-20 20:42:44,368 INFO : Running cycle 1/1 for dromaeo_css test... 20:42:44 INFO - 2015-11-20 20:42:44,368 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDEWNju/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:42:56 INFO - 2015-11-20 20:42:56,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 141979648 20:42:56 INFO - 2015-11-20 20:42:56,102 DEBUG : BROWSER_OUTPUT: 20:43:47 INFO - 2015-11-20 20:43:47,660 DEBUG : BROWSER_OUTPUT: 1448081027654 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] 20:45:57 INFO - 2015-11-20 20:45:57,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59652/tests/dromaeo/cssquery-ext.html) 20:45:58 INFO - 2015-11-20 20:45:58,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 262508544 20:45:58 INFO - 2015-11-20 20:45:58,440 DEBUG : BROWSER_OUTPUT: 20:49:00 INFO - 2015-11-20 20:49:00,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-ext.html (next: http://localhost:59652/tests/dromaeo/cssquery-jquery.html) 20:49:01 INFO - 2015-11-20 20:49:01,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 231153664 20:49:01 INFO - 2015-11-20 20:49:01,453 DEBUG : BROWSER_OUTPUT: 20:52:03 INFO - 2015-11-20 20:52:03,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59652/tests/dromaeo/cssquery-mootools.html) 20:52:03 INFO - 2015-11-20 20:52:03,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 215724032 20:52:03 INFO - 2015-11-20 20:52:03,892 DEBUG : BROWSER_OUTPUT: 20:55:05 INFO - 2015-11-20 20:55:05,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59652/tests/dromaeo/cssquery-prototype.html) 20:55:06 INFO - 2015-11-20 20:55:06,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 191905792 20:55:06 INFO - 2015-11-20 20:55:06,408 DEBUG : BROWSER_OUTPUT: 20:58:08 INFO - 2015-11-20 20:58:08,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59652/tests/dromaeo/cssquery-yui.html) 20:58:09 INFO - 2015-11-20 20:58:09,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 205213696 20:58:09 INFO - 2015-11-20 20:58:09,402 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/dromaeo/cssquery-yui.html (next: http://localhost:59652/tests/dromaeo/cssquery-dojo.html) 21:01:12 INFO - 2015-11-20 21:01:12,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 246206464 21:01:12 INFO - 2015-11-20 21:01:12,404 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,405 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:01:12 INFO - 2015-11-20 21:01:12,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:01:12 INFO - 2015-11-20 21:01:12,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:01:12 INFO - 2015-11-20 21:01:12,406 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:01:12 INFO - 2015-11-20 21:01:12,407 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3194.6485886552477;3249.610046794385;3289.2599165187835;3293.8023718576887;3322.1528510229896;5227.137522308814;5331.600129990247;5433.6196466247375;5472.097103977844;5485.314335708032;5418.7019713915715;5453.754581043852;5462.317210348707;5477.863053423656;5591.580631452647;4958.206686930101;4976.3530741003615;4996.150654388744;5024.899502009957;5081.034603425356;4880.780364883589;5116.641835071547;5121.769520371592;5158.896822063575;5213.556847667953;4959.305697202412;4974.726390048546;5018.046571151506;5033.899322013539;5034.4713805050305;4972.6270529710055;4975.800967961313;4980.9252861207115;4981.178105612569;5022.497750224985;4869.123557759602;4961.751912404401;4966.850994470172;4975.577075948549;4976.850694479172;5138.075146473633;5224.346956630421;5230.398504172031;5247.658902171346;5270.420253772082;5904.763809447617;5908.497777688859;5915.615484993505;5917.053271476586;5941.049432090888;5795;5895.882082358372;5942.821715348547;5944;5953.464188223037;5465.9726701366235;5521.2270282160525;5531.446855314436;5548.167774833807;5602.663840169644;6124.846878827976;6133.662648554283;6147.415995480422;6151.876962460726;6152.200213972155;5702.344230413472;5799.3620701722775;5938.910916336258;5959.12410208554;6004.369541198199;5877.706114694248;5896.970515147397;5961.433663801932;6016.639001659827;6020.187274717945;5854.941450585525;6006.609570377911;6019.638821670714;6021.337652858269;6021.909671354933;5764.337101233328;5989.2812862456785;6007.639541627516;6009.639421634716;6010.248718910137;4494.910101797946;4535.909281814345;4567.680262381601;4613.1465678848845;4624.421947256593;4064.227796718614;4069.7558146511305;4084.571120032413;4087.141700242982;4109.8972525686495;5688.829335119953;5693.089105743061;5694.345150307768;5696.458836410535;5742.626729262584;5777.162311464898;5894.705264736746;5904.468597826216;5904.911426328608;5988.4909782668965;5659.434056594308;5663.348714897839;5664.26364572603;5713.285839270091;5734.512566431817;5178.456262092502;5188.8962220755375;5189.792408303626;5191.402988656353;5239.659422137625;5969;6074.301455332693;6123.203983482119;6123.510119190543;6143.662098584621;5827.562932779973;5903.055511118372;5909.23179986599;5914.792982245601;5966.164736936919;6126.540509461719;6144.8771024580155;6193.163922870535;6195.132681424514;6196.1635179252025;5690.317161940594;5761.711914404347;5822.94177058224;5909.409059094056;5925.674087925206;5778.537716982715;5843.357230704704;5848.707564621667;5861.443162899518;5916.26046744157;5802.158686990447;5874.530037596896;5875.471207591338;5878.118282257696;5885.293764748258;5656.23640808502;5813.970930145322;5822.534197264124;5827.650340979555;5871.823845284648;5649.576281778801;5739.397363276796;5741.25363702716;5744.798932037359;5789.8552536186935;5817.563682723898;5878.735456904364;5885.793997210077;5904.261967254093;5952.226210592596;5493.258410114743;5619.662820230799;5620.803271885465;5699.7435115419075;5749.166370876116 21:01:12 INFO - 2015-11-20 21:01:12,410 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.9441453061958;600.3336296710652;601.4646964201861;601.5007543738698;617.8918689229387;31527.842360788192;32414.18964525891;32454.350912981754;38712;39778;42684.57315426845;43436.131277374436;43468.3479747804;43559;43567.3464898026;8798.120187981198;8926.37515373924;8967.686130985418;8967.686130985418;8968.820623587524;7880.605969701521;8067.475614085066;10528.631497897575;10771.461426928661;10775.784484310308;10528.263021588491;10621.362718236931;10629.73425664357;10635.149188064976;10636.893631063667;7851.057873055212;8048.154943730882;10568;10644.787104257948;10680.359178449318;7748.535087894745;10597.258191926569;10894.400807955559;10906.781864362669;10907.727306817314;39995.200455956634;40447.59552404497;40464.595354046374;40508.59491405078;40593.188136237404;3211.7912335698106;3267.8856240031723;3300.273939733255;3488.953314005788;3991.5409727881083;30278.54582181269;30512;33141.834290828636;33799;35077.47383789245;3984.5816189299994;3993.101552150772;3996.6003399660094;4109.2808758467445;4191.7275377100395;253331;255326;255385;255950;256801;53688.82578503444;54625.180622290696;59933.40066599366;60168;60196.69901650551;70775.29224707687;71868.28131718721;72167;72413.27586724171;72512.63743681248;14539.27303634814;14720.411183552753;14752.926235368968;14763.409463621334;14796.852031479762;10557;10643;10699.197560182862;10760.139188864872;10782.08352290064;20359.287424940056;20507.69238461424;20549.8697571635;20617.793822061587;20665.27671531519;8169.591520423955;8212.34301255898;8323.1260717625;8421.789455263668;8509.702160424355;910.2717825739383;960.711786464058;984.8621193032981;1060.931039482431;1061.6231237910586;28816;29419.558706619417;29530.409391812045;32622.83688581542;33026.17434564155;1024.6618615856748;1026.5865995564627;1102.9834552481718;1121.7812526557407;1134.4157758754247;14592.270386480634;14740.852591474162;14761.630959225891;14905.478308259375;15030.924845375703;410989;415848;416131;416674;417379;52542.21186682203;52775.208371874454;52872.47127528753;52907.470925291025;53080;1358.7893876449166;1367.1113776045452;1367.8085068090475;1384.6261509392407;1397.2873834344355;27919.302017448914;28523;28730.42539149247;32143.196420089684;32205.838970804994;49738.25392619041;50407.49592504028;50447.24329134992;50464.74767626138;50572.4828255153;294889;296258;296297;296474;296582;26984.32539186536;32129;32296.35407291794;32318.19204519906;32440.513392299606;38083.42874856935;38205.80897095497;38275.42586861143;38282.42576361301;38973.41539876848;32567.837160814994;32623.510647340783;33013.339733205685;33278.667213328525;39146.4128038074;37259.44110838285;37430;37727;37830.43254351132;38123.80938095292;35988.82005589955;36488.635113648525;37043.814780925924;37158;37219;32805.50791738078;33213;34444.13889652678;34628.64523821412;34864.47703284503;25303.620445693698;25367.492650147262;25548.23355299344;25598;25770.35574110662 21:01:12 INFO - 2015-11-20 21:01:12,411 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.4859953068052;358.51421324105837;360.0889748935193;361.6166863125086;362.50880057522056;14440;14443.350049247783;17283.222254998524;17781.288748450064;18409.26362945482;16834.747478787798;16990.660186796256;17290.30838766451;17294.394696185635;17497.737533937;5381.246625472427;5477.972610136943;5510.090835012218;5537.723113844291;5541.861453463675;3923.0780766519847;4010.2981978153853;4014.3978403239457;4018;5442.727863606804;5772.30732312121;5907.143464197688;5927.1998280232265;5931.851703707421;5932.703364831763;5347.946520534783;5529.198266251411;5529.502344788968;5538.224648549206;5978.730957106941;5256.369235691704;5296.285001524822;5325.281087053237;5332.30680011596;5338.759755810997;12462.314572698499;12925.418356173996;12928.418221180069;12937.48250069996;13803.930980345134;2104.295061154515;2119.42775450629;2121.459027947879;2153.246363772683;2213.4908970936613;13078.149920255248;13151.934240328832;13237.338133093403;13333.06668533203;13571.389287482087;1797.5236562310997;1888.291890541047;1910;1920.894350810705;1929.9324523641747;60323.396766032216;62962.685186574236;63006.369936300965;63056.68471657658;63199;10119.848202276971;10166.949165254126;10207.234457415576;10228.386296822215;10260.127889129508;13584.1849489029;13599.728005440034;13620.863791362157;13622.727545449234;13631.863681363258;7509.286617771303;7600.581967991813;7603.2776886195725;7635.618219089023;7700.9614951926005;7317.41460683144;7339.559626422325;7340.192578816326;7369.705211791468;7377.9262207378315;4385.254506733863;4412.514623391425;4420.734755914656;4443.666724995638;4476.283794592915;1670.8830381873152;1755.490907636771;1763.3828160143846;1765.2674140231916;1769.566456218209;875.8598624220094;904.3579058868277;969.4231932000448;993.6571882700457;1004.9598016079422;14782.92608536972;16428.75356869648;17162.742558861628;17405.738913916302;17473.21370538329;868.9435186712843;908.3777612335572;912.9863052054225;920.62254475666;935.7239614313794;9330;9600.519974001272;9712.174465170398;9716.465594392235;9738.367006144577;512463;518035;524331;528723;536018;70521.99343598062;73618;74191;74465;76779.23220767721;1131.5813149134872;1141.6289705845634;1146.3607041929954;1163.4066626020622;1171.6367925942814;14711.852881471048;14714.558563242692;14728.189949552878;14820.7776883349;15103.773443398139;31843.840780796876;32036.35927281488;32064.519032215;32116.678833212303;32212.516812248305;43513.78243108764;43551.78224108859;44193.55806441895;45562;45959.54040459553;9117;9322.580483878106;9447.574859131219;9502.857457138287;9565.808683826146;17376.739348909523;17765.467035988942;18102.366417175337;18128.365507207713;18254.817451825842;14567.490137845549;14703.41186352534;14721.484748033767;14814.185219813015;15236;14510.85489145095;14688.678018978344;14723.484678036217;14729.779053314423;15277.465288714842;14007.43970241179;14503.492377766728;15245.923770381078;15415.152166630944;15644.608884777972;9272.119148680864;9311.906880931105;9560.091791279818;9562.374396352776;9906.207503399566;10694;14675.853241467876;14956.326965286806;15223.695526089637;15273.694526109193 21:01:12 INFO - 2015-11-20 21:01:12,414 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1315.1714419915452;1737.157478622868;1757.358564124095;1788.4187639017318;1796.811334809844;6560.868782624345;7266.091738532684;7300.452466065053;7377;7383.667734951927;7484.101907771062;7628.046494188213;7660.502067365617;7667.0416197975255;7685.11621163565;1938.6704260275717;1966.8426525877967;2187.7155969723913;2210.347947355526;2227.8440509164284;2228.253535065755;2231.7098777159026;2232.1852523828766;2232.2745107839937;2232.6985856909273;2154.2244791874914;2225.7885500877474;2225.7996780289773;2227.3318004598636;2236.6868638390556;1988.5426351939063;2032.6239645665526;2141.271967531039;2178.4771654802894;2178.836587255946;2174.2607513445346;2196.3081629286726;2202.48241663209;2223.144089525544;2226.0984301357976;7771.028621422322;7808.843823123562;7834.686612535492;7835.138134805167;7844.921550784533;4529.071540334224;4620.145273124449;4623.953760462419;4626.953730462686;4634.21218392874;2917;2960.674325824179;2970.524716045444;3011.3826665533734;3030.3181784098624;934.5514153206431;941.2517048946104;943.6319835264252;957.1720461800493;975.7219192530166;10698.625548105856;10699.358038517636;10700.357978521235;10701;10704.1436685065;4030.133521292936;4039.5354534228354;4089.4683691119963;4116.526599441043;4170.457840480718;9210.355275130676;9245.953770231106;9257.675981340755;9259.398139120936;9269.35114541989;4655.3249778782565;4665.930011049837;4672.6261899047995;4675.345451636774;4678.578927896438;4204.789760511962;4208.221479026329;4234.089670720809;4236.491621005499;4242.490901091889;3611.386064369011;3680.9079773005888;3696.648818362305;3717.665410113103;3721.1813401051727;1182.5092586576645;1191.142377488207;1198.7302856857136;1200.3578085724096;1212.805951047828;995.8655581496405;1257.4781465691635;1267.7781388257017;1268.6638040918979;1276.9999999999814;6406.8718625627225;7479.925200748032;7676.846463070819;7689.769306920802;7696.9615151925;618.4526693875952;621.1800423441015;624.6470744029609;648.824817299336;650.7884937395365;5739.253896993448;5801.9419805802245;5828.912566311508;5836.328822185503;5837.182794408786;9147.679831205876;9230.676926307548;9235;9307.11582399671;9323.393979391318;8977.506237157018;9212.30907681913;9220.631174752934;9222.86165707515;9237.630494780133;7144.964275178695;7152.570845749167;7165.89251161233;7218.3503484686635;7228.421726261887;6816.147981502312;6877.759278425231;6921.169459664872;6925.515213934977;6927.203371612329;8063.919360806317;8064.55644939534;8107.1892810718455;8122.83754324922;8122.918770812216;8282.627281772215;8344.707935222481;8446.197611226924;8471.195236452528;8474.872876906727;6741.865162696817;6815.250322464426;6815.89776153368;6818.113645226089;6819.215790184192;7415.406767458699;7454.627268636655;7462.664180111799;7462.888056679263;7464.738734144496;6574.211094668671;6894.517383783087;6899.275576064641;6960.164780226405;7075.787726368218;6727.966360168363;6886.173659160732;6912.930870691229;6963.234044255027;7028.402585780266;6873.20958089826;6933;6937.965310173417;6940.028396024662;6963.199232088172;5886.087656413263;5930.466258036798;6137.570370074052;6232.407921247474;6258.123862659322;6490.935090649033;6506.3493650634555;6520.869582608416;6544;6571.441427478718 21:01:12 INFO - 2015-11-20 21:01:12,416 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.96170940341864;336.76426501448975;338.3993411694241;342.37345657446866;344.54003904787106;6003.099535069742;6012.789552365668;6018.458338749511;6028.969855150729;6042.486388656969;5912.526997840173;5943.791967281146;5952.136940143677;5965.105234214859;5970.73131709073;4625.283081122431;4630.72215667061;4634.860954171363;4637.744924029177;4639.443266807988;4479.8432054878085;4588.311753237024;4604.861854144364;4606.032733126048;4610.031893302411;4563.155816174019;4564.703294285878;4574.130915126132;4574.725516469022;4575.428071491064;4361.476622805252;4425;4489.820407183709;4551.954480455202;4569.337446070318;3946.1515774108702;3967.8809635710977;3983;3985.7807820569856;3992.6606238469767;5597.3003374578175;5598.412166722517;5608.102703567451;5608.49523542879;5614.63504872182;5019.4227663818765;5133.589312854962;5185.092608793484;5275.103232450492;5275.314209152824;6267.247930248353;6281.403266689657;6283.434490895841;6290.905636415411;6303.369663033705;4353.825846966118;4369.3227549729845;4376.6498680105515;4383.978080109611;4389.780510974439;6408.487321014308;6485;6549.083128362033;6553.311902250242;6554.180727409074;4473.776311184428;4476.440444944382;4477.19410506112;4479.216137176047;4482.708623939434;4534.206513860127;4534.59188673021;4536.954630453719;4537.342085397599;4539.296409056601;5240.266362709223;5247.921281180786;5250.081235783722;5250.267411754112;5252.264682944391;6220.813375598739;6353.491720662336;6358.713857876407;6359.8092057238355;6368.649724265118;1589.1577463944127;1598.472504073653;1600.9913754334696;1601.071378600409;1601.599600099975;1061.3048453263125;1062.9043386095288;1068.989804634613;1080.222239987208;1089.1341383600056;6135.478484328793;6174;6174.598651087665;6180.536459765535;6188.412100850412;6538.640374779337;6550.606963582105;6554;6564.409203171737;6564.671766411756;6039.063945088518;6172.660503672251;6182;6182.907256391158;6187.938120618736;3523.3834079036064;3534.381483240474;3536.964630353715;3550.609432962372;3556.644335566423;6759.459243260528;6764.053032575345;6769.255381907986;6770.72917083321;6773.085633439521;6511;6528.902066469007;6702.430293425016;6707.463402927754;6708.060871477997;6454.870902582016;6732.899006514906;6877.724891004304;6886.655667216719;6889.793306200822;6610.933890661032;6621.404073633396;6627;6627.045021718508;6629;6564.770233041821;6566;6566.0479230512265;6566.310537393505;6572.047053177358;6698.162729658793;6870.416014638811;6885.173779146535;6895.138107736533;6899.448044156355;4431.20238357086;4454.643628509776;4455.821767129279;4464.352668862932;4467.15124126415;6550.181227346582;6556.3443655634055;6557.278699342973;6561.376669216417;6563.671816409256;6305.148804911279;6397.87204255903;6401.615903045832;6406.839829004312;6421.7110230038825;6383.872322553616;6393.392627700361;6399.488040956619;6409.198850143732;6418.0693799397895;6288.339724328879;6297.748090076346;6301.023341382093;6306.558540902276;6311.863864504433;6318.6840657965995;6446.9032964506505;6450.741970321134;6452.741890324334;6469.611823290617;6300;6301.369863013662;6301.873962520815;6302.212223472066;6309.274433440213 21:01:12 INFO - 2015-11-20 21:01:12,417 DEBUG : BROWSER_OUTPUT: |5;yui.html;840.0633293877329;864.0581765875195;866.3372520022182;867.8177582707631;893.0399820193294;13722.794158087625;14017.36921838517;14019.719605607881;14027.649308767286;14101.083429577084;13384.531541396052;13417.329133543308;13498.595042148727;13502.392392342344;13507.054506184571;668.238208442376;675.7364627795164;799.0611032037333;813.8616435206029;815.808285053012;804.4449329962307;807.7738233294687;810.7365106340434;811.2536466450879;811.4928169893816;702.2345643248858;851.2041241439274;858.4248553469159;859.5659192107977;859.8065435277044;704.0460176460898;704.1163340008283;706.307818338029;829.9543525106117;849.524266410812;630.5334052800895;630.7571584939785;630.7634637011121;631.0250662726054;631.0376675569747;13668.794968075486;13705.314734263247;13759.79360309596;13801.930990345085;13841.961852861075;12262.20295680778;12642.367881605975;13045.217286962812;13151.802722959163;13209;10549.84175237372;10676.306040107445;10757.462126893624;10758.408287544182;10758.838617420744;3629.836657350399;3670.06413364593;3716.7955762433057;3732.4774531565604;3799.0502374406396;45549.54450455486;46460.53539464596;46776.2983555247;47049.52950470486;47627;9444.974213293253;9677.37097088687;9752.853707194397;9799;9838.06538378853;18367.17347719356;18407.90796046011;18413.907930460264;18417;18429.631407371777;7465.925340746631;7661.770146895602;7662.846743065219;7668.271514206142;7847.803804904809;4208.137331846964;4336.783160841946;4377.146456441027;4424.446944131983;4496.213162696515;2818.0559512563523;2878.6977367376544;2879.1794338613395;2881.380503191782;2883.3800732842537;501.6313009937693;507.90603738308533;510.4104759003357;521.5123859191668;523.8166641675459;515.4047075627581;529.9072662284085;531.5163201486629;535.7910414938177;556.2407314016339;8329.791755206046;8367.288780453608;8662.220400164015;8704.477731336141;8831.60257788401;434.1794009322383;444.3268448300827;452.8120829855639;453.8456924645636;482.77309664457647;3656.634336566322;3676.779393236361;3684.9263014739554;3860.285847118292;3872.128771026553;57580.42419575751;58383.70808145932;58397.416025840044;58537.26821415592;58538;51654.48345516572;51826.48173518292;51856.48143518517;51967.480325196266;52312.738436307576;43144.56855431468;43804.342934856;44469.77765111154;44488.77755611266;44659.77670111629;7175.820604484721;7203.243659415895;7324.754791685533;7369.37360324357;7475.850482990201;33610.663893360754;33861;33873;34882.127946801535;35153.47269791007;39620.603793961694;44390.77804610956;44919.55080449153;45002.32496512489;45094.77452612716;9122.726318210463;9154.176124148858;9197.954010229905;9235.445873247627;9420.246380289698;10696.41169735672;10929.071028962628;10953.34279943206;11680.47437865281;12009;9685.031496850259;10261.538230779783;10455.895441045492;10626.468676566295;10817.1346292298;9863.704088877344;9890.406575605486;10237.078662920372;10479.895201047892;10497.212709047004;7506.28690274423;9632.27757918145;10288.897111028793;10448.895511045097;10513.89486105129;8574.528400938008;8673.219410253107;9110.908890911007;9424.481653508848;9580.281478888972;8421.975220110928;8878.911210887809;8885.289176865965;8919.73240802777;8938 21:01:12 INFO - 2015-11-20 21:01:12,417 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:01:12 INFO - 2015-11-20 21:01:12,417 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:01:12 INFO - 2015-11-20 21:01:12,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 21:01:12 INFO - 2015-11-20 21:01:12,418 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:01:12 INFO - 2015-11-20 21:01:12,418 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082072404__endTimestamp 21:01:12 INFO - 2015-11-20 21:01:12,418 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,418 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:01:12 INFO - 2015-11-20 21:01:12,419 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:01:12 INFO - 2015-11-20 21:01:12,419 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,419 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5502.11 Median:5739.40 stddev:623.93 (10.9%) stddev-sans-first:599.01 21:01:12 INFO - 2015-11-20 21:01:12,420 DEBUG : BROWSER_OUTPUT: Values: 3194.6 3249.6 3289.3 3293.8 3322.2 5227.1 5331.6 5433.6 5472.1 5485.3 5418.7 5453.8 5462.3 5477.9 5591.6 4958.2 4976.4 4996.2 5024.9 5081.0 4880.8 5116.6 5121.8 5158.9 5213.6 4959.3 4974.7 5018.0 5033.9 5034.5 4972.6 4975.8 4980.9 4981.2 5022.5 4869.1 4961.8 4966.9 4975.6 4976.9 5138.1 5224.3 5230.4 5247.7 5270.4 5904.8 5908.5 5915.6 5917.1 5941.0 5795.0 5895.9 5942.8 5944.0 5953.5 5466.0 5521.2 5531.4 5548.2 5602.7 6124.8 6133.7 6147.4 6151.9 6152.2 5702.3 5799.4 5938.9 5959.1 6004.4 5877.7 5897.0 5961.4 6016.6 6020.2 5854.9 6006.6 6019.6 6021.3 6021.9 5764.3 5989.3 6007.6 6009.6 6010.2 4494.9 4535.9 4567.7 4613.1 4624.4 4064.2 4069.8 4084.6 4087.1 4109.9 5688.8 5693.1 5694.3 5696.5 5742.6 5777.2 5894.7 5904.5 5904.9 5988.5 5659.4 5663.3 5664.3 5713.3 5734.5 5178.5 5188.9 5189.8 5191.4 5239.7 5969.0 6074.3 6123.2 6123.5 6143.7 5827.6 5903.1 5909.2 5914.8 5966.2 6126.5 6144.9 6193.2 6195.1 6196.2 5690.3 5761.7 5822.9 5909.4 5925.7 5778.5 5843.4 5848.7 5861.4 5916.3 5802.2 5874.5 5875.5 5878.1 5885.3 5656.2 5814.0 5822.5 5827.7 5871.8 5649.6 5739.4 5741.3 5744.8 5789.9 5817.6 5878.7 5885.8 5904.3 5952.2 5493.3 5619.7 5620.8 5699.7 5749.2 21:01:12 INFO - 2015-11-20 21:01:12,420 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,421 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49411.11 Median:33245.83 stddev:86653.29 (260.6%) stddev-sans-first:86818.84 21:01:12 INFO - 2015-11-20 21:01:12,422 DEBUG : BROWSER_OUTPUT: Values: 587.9 600.3 601.5 601.5 617.9 31527.8 32414.2 32454.4 38712.0 39778.0 42684.6 43436.1 43468.3 43559.0 43567.3 8798.1 8926.4 8967.7 8967.7 8968.8 7880.6 8067.5 10528.6 10771.5 10775.8 10528.3 10621.4 10629.7 10635.1 10636.9 7851.1 8048.2 10568.0 10644.8 10680.4 7748.5 10597.3 10894.4 10906.8 10907.7 39995.2 40447.6 40464.6 40508.6 40593.2 3211.8 3267.9 3300.3 3489.0 3991.5 30278.5 30512.0 33141.8 33799.0 35077.5 3984.6 3993.1 3996.6 4109.3 4191.7 253331.0 255326.0 255385.0 255950.0 256801.0 53688.8 54625.2 59933.4 60168.0 60196.7 70775.3 71868.3 72167.0 72413.3 72512.6 14539.3 14720.4 14752.9 14763.4 14796.9 10557.0 10643.0 10699.2 10760.1 10782.1 20359.3 20507.7 20549.9 20617.8 20665.3 8169.6 8212.3 8323.1 8421.8 8509.7 910.3 960.7 984.9 1060.9 1061.6 28816.0 29419.6 29530.4 32622.8 33026.2 1024.7 1026.6 1103.0 1121.8 1134.4 14592.3 14740.9 14761.6 14905.5 15030.9 410989.0 415848.0 416131.0 416674.0 417379.0 52542.2 52775.2 52872.5 52907.5 53080.0 1358.8 1367.1 1367.8 1384.6 1397.3 27919.3 28523.0 28730.4 32143.2 32205.8 49738.3 50407.5 50447.2 50464.7 50572.5 294889.0 296258.0 296297.0 296474.0 296582.0 26984.3 32129.0 32296.4 32318.2 32440.5 38083.4 38205.8 38275.4 38282.4 38973.4 32567.8 32623.5 33013.3 33278.7 39146.4 37259.4 37430.0 37727.0 37830.4 38123.8 35988.8 36488.6 37043.8 37158.0 37219.0 32805.5 33213.0 34444.1 34628.6 34864.5 25303.6 25367.5 25548.2 25598.0 25770.4 21:01:12 INFO - 2015-11-20 21:01:12,422 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,422 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28123.27 Median:16283.50 stddev:85534.78 (525.3%) stddev-sans-first:85749.32 21:01:12 INFO - 2015-11-20 21:01:12,424 DEBUG : BROWSER_OUTPUT: Values: 354.5 358.5 360.1 361.6 362.5 14440.0 14443.4 17283.2 17781.3 18409.3 16834.7 16990.7 17290.3 17294.4 17497.7 5381.2 5478.0 5510.1 5537.7 5541.9 3923.1 4010.3 4014.4 4018.0 5442.7 5772.3 5907.1 5927.2 5931.9 5932.7 5347.9 5529.2 5529.5 5538.2 5978.7 5256.4 5296.3 5325.3 5332.3 5338.8 12462.3 12925.4 12928.4 12937.5 13803.9 2104.3 2119.4 2121.5 2153.2 2213.5 13078.1 13151.9 13237.3 13333.1 13571.4 1797.5 1888.3 1910.0 1920.9 1929.9 60323.4 62962.7 63006.4 63056.7 63199.0 10119.8 10166.9 10207.2 10228.4 10260.1 13584.2 13599.7 13620.9 13622.7 13631.9 7509.3 7600.6 7603.3 7635.6 7701.0 7317.4 7339.6 7340.2 7369.7 7377.9 4385.3 4412.5 4420.7 4443.7 4476.3 1670.9 1755.5 1763.4 1765.3 1769.6 875.9 904.4 969.4 993.7 1005.0 14782.9 16428.8 17162.7 17405.7 17473.2 868.9 908.4 913.0 920.6 935.7 9330.0 9600.5 9712.2 9716.5 9738.4 512463.0 518035.0 524331.0 528723.0 536018.0 70522.0 73618.0 74191.0 74465.0 76779.2 1131.6 1141.6 1146.4 1163.4 1171.6 14711.9 14714.6 14728.2 14820.8 15103.8 31843.8 32036.4 32064.5 32116.7 32212.5 43513.8 43551.8 44193.6 45562.0 45959.5 9117.0 9322.6 9447.6 9502.9 9565.8 17376.7 17765.5 18102.4 18128.4 18254.8 14567.5 14703.4 14721.5 14814.2 15236.0 14510.9 14688.7 14723.5 14729.8 15277.5 14007.4 14503.5 15245.9 15415.2 15644.6 9272.1 9311.9 9560.1 9562.4 9906.2 10694.0 14675.9 14956.3 15223.7 15273.7 21:01:12 INFO - 2015-11-20 21:01:12,424 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,424 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5364.98 Median:3578.57 stddev:2815.00 (78.7%) stddev-sans-first:2806.44 21:01:12 INFO - 2015-11-20 21:01:12,425 DEBUG : BROWSER_OUTPUT: Values: 1315.2 1737.2 1757.4 1788.4 1796.8 6560.9 7266.1 7300.5 7377.0 7383.7 7484.1 7628.0 7660.5 7667.0 7685.1 1938.7 1966.8 2187.7 2210.3 2227.8 2228.3 2231.7 2232.2 2232.3 2232.7 2154.2 2225.8 2225.8 2227.3 2236.7 1988.5 2032.6 2141.3 2178.5 2178.8 2174.3 2196.3 2202.5 2223.1 2226.1 7771.0 7808.8 7834.7 7835.1 7844.9 4529.1 4620.1 4624.0 4627.0 4634.2 2917.0 2960.7 2970.5 3011.4 3030.3 934.6 941.3 943.6 957.2 975.7 10698.6 10699.4 10700.4 10701.0 10704.1 4030.1 4039.5 4089.5 4116.5 4170.5 9210.4 9246.0 9257.7 9259.4 9269.4 4655.3 4665.9 4672.6 4675.3 4678.6 4204.8 4208.2 4234.1 4236.5 4242.5 3611.4 3680.9 3696.6 3717.7 3721.2 1182.5 1191.1 1198.7 1200.4 1212.8 995.9 1257.5 1267.8 1268.7 1277.0 6406.9 7479.9 7676.8 7689.8 7697.0 618.5 621.2 624.6 648.8 650.8 5739.3 5801.9 5828.9 5836.3 5837.2 9147.7 9230.7 9235.0 9307.1 9323.4 8977.5 9212.3 9220.6 9222.9 9237.6 7145.0 7152.6 7165.9 7218.4 7228.4 6816.1 6877.8 6921.2 6925.5 6927.2 8063.9 8064.6 8107.2 8122.8 8122.9 8282.6 8344.7 8446.2 8471.2 8474.9 6741.9 6815.3 6815.9 6818.1 6819.2 7415.4 7454.6 7462.7 7462.9 7464.7 6574.2 6894.5 6899.3 6960.2 7075.8 6728.0 6886.2 6912.9 6963.2 7028.4 6873.2 6933.0 6938.0 6940.0 6963.2 5886.1 5930.5 6137.6 6232.4 6258.1 6490.9 6506.3 6520.9 6544.0 6571.4 21:01:12 INFO - 2015-11-20 21:01:12,425 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,426 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5311.70 Median:6088.98 stddev:1610.16 (26.4%) stddev-sans-first:1570.72 21:01:12 INFO - 2015-11-20 21:01:12,427 DEBUG : BROWSER_OUTPUT: Values: 333.0 336.8 338.4 342.4 344.5 6003.1 6012.8 6018.5 6029.0 6042.5 5912.5 5943.8 5952.1 5965.1 5970.7 4625.3 4630.7 4634.9 4637.7 4639.4 4479.8 4588.3 4604.9 4606.0 4610.0 4563.2 4564.7 4574.1 4574.7 4575.4 4361.5 4425.0 4489.8 4552.0 4569.3 3946.2 3967.9 3983.0 3985.8 3992.7 5597.3 5598.4 5608.1 5608.5 5614.6 5019.4 5133.6 5185.1 5275.1 5275.3 6267.2 6281.4 6283.4 6290.9 6303.4 4353.8 4369.3 4376.6 4384.0 4389.8 6408.5 6485.0 6549.1 6553.3 6554.2 4473.8 4476.4 4477.2 4479.2 4482.7 4534.2 4534.6 4537.0 4537.3 4539.3 5240.3 5247.9 5250.1 5250.3 5252.3 6220.8 6353.5 6358.7 6359.8 6368.6 1589.2 1598.5 1601.0 1601.1 1601.6 1061.3 1062.9 1069.0 1080.2 1089.1 6135.5 6174.0 6174.6 6180.5 6188.4 6538.6 6550.6 6554.0 6564.4 6564.7 6039.1 6172.7 6182.0 6182.9 6187.9 3523.4 3534.4 3537.0 3550.6 3556.6 6759.5 6764.1 6769.3 6770.7 6773.1 6511.0 6528.9 6702.4 6707.5 6708.1 6454.9 6732.9 6877.7 6886.7 6889.8 6610.9 6621.4 6627.0 6627.0 6629.0 6564.8 6566.0 6566.0 6566.3 6572.0 6698.2 6870.4 6885.2 6895.1 6899.4 4431.2 4454.6 4455.8 4464.4 4467.2 6550.2 6556.3 6557.3 6561.4 6563.7 6305.1 6397.9 6401.6 6406.8 6421.7 6383.9 6393.4 6399.5 6409.2 6418.1 6288.3 6297.7 6301.0 6306.6 6311.9 6318.7 6446.9 6450.7 6452.7 6469.6 6300.0 6301.4 6301.9 6302.2 6309.3 21:01:12 INFO - 2015-11-20 21:01:12,427 DEBUG : BROWSER_OUTPUT: 21:01:12 INFO - 2015-11-20 21:01:12,427 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13471.13 Median:504.77 stddev:15846.00 (3139.3%) stddev-sans-first:15862.07 21:01:12 INFO - 2015-11-20 21:01:12,427 DEBUG : BROWSER_OUTPUT: Values: 840.1 864.1 866.3 867.8 893.0 13722.8 14017.4 14019.7 14027.6 14101.1 13384.5 13417.3 13498.6 13502.4 13507.1 668.2 675.7 799.1 813.9 815.8 804.4 807.8 810.7 811.3 811.5 702.2 851.2 858.4 859.6 859.8 704.0 704.1 706.3 830.0 849.5 630.5 630.8 630.8 631.0 631.0 13668.8 13705.3 13759.8 13801.9 13842.0 12262.2 12642.4 13045.2 13151.8 13209.0 10549.8 10676.3 10757.5 10758.4 10758.8 3629.8 3670.1 3716.8 3732.5 3799.1 45549.5 46460.5 46776.3 47049.5 47627.0 9445.0 9677.4 9752.9 9799.0 9838.1 18367.2 18407.9 18413.9 18417.0 18429.6 7465.9 7661.8 7662.8 7668.3 7847.8 4208.1 4336.8 4377.1 4424.4 4496.2 2818.1 2878.7 2879.2 2881.4 2883.4 501.6 507.9 510.4 521.5 523.8 515.4 529.9 531.5 535.8 556.2 8329.8 8367.3 8662.2 8704.5 8831.6 434.2 444.3 452.8 453.8 482.8 3656.6 3676.8 3684.9 3860.3 3872.1 57580.4 58383.7 58397.4 58537.3 58538.0 51654.5 51826.5 51856.5 51967.5 52312.7 43144.6 43804.3 44469.8 44488.8 44659.8 7175.8 7203.2 7324.8 7369.4 7475.9 33610.7 33861.0 33873.0 34882.1 35153.5 39620.6 44390.8 44919.6 45002.3 45094.8 9122.7 9154.2 9198.0 9235.4 9420.2 10696.4 10929.1 10953.3 11680.5 12009.0 9685.0 10261.5 10455.9 10626.5 10817.1 9863.7 9890.4 10237.1 10479.9 10497.2 7506.3 9632.3 10288.9 10448.9 10513.9 8574.5 8673.2 9110.9 9424.5 9580.3 8422.0 8878.9 8885.3 8919.7 8938.0 21:01:12 INFO - 2015-11-20 21:01:12,428 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:01:12 INFO - 2015-11-20 21:01:12,428 DEBUG : BROWSER_OUTPUT: 21:01:13 INFO - 2015-11-20 21:01:13,241 INFO : Browser exited with error code: 0 21:01:13 INFO - 2015-11-20 21:01:13,260 INFO : Completed test dromaeo_css (00:18:37) 21:01:13 INFO - 2015-11-20 21:01:13,260 INFO : Starting test kraken 21:01:13 INFO - 2015-11-20 21:01:13,260 DEBUG : operating with platform_type : linux_ 21:01:13 INFO - 2015-11-20 21:01:13,260 INFO : Initialising browser for kraken test... 21:01:13 INFO - 2015-11-20 21:01:13,266 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqmPMhI/profile http://localhost:59652/getInfo.html 21:01:17 INFO - 2015-11-20 21:01:17,672 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:01:17 INFO - 2015-11-20 21:01:17,672 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:01:17 INFO - 2015-11-20 21:01:17,672 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:01:17 INFO - 2015-11-20 21:01:17,672 DEBUG : BROWSER_OUTPUT: __metrics 21:01:17 INFO - 2015-11-20 21:01:17,837 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:01:19 INFO - 2015-11-20 21:01:19,271 INFO : Browser initialized. 21:01:19 INFO - 2015-11-20 21:01:19,272 INFO : Running cycle 1/1 for kraken test... 21:01:19 INFO - 2015-11-20 21:01:19,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqmPMhI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:01:31 INFO - 2015-11-20 21:01:31,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 142004224 21:01:31 INFO - 2015-11-20 21:01:31,048 DEBUG : BROWSER_OUTPUT: 21:01:33 INFO - 2015-11-20 21:01:33,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59652/tests/kraken/driver.html?testName=audio-beat-detection) 21:01:34 INFO - 2015-11-20 21:01:34,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 176975872 21:01:34 INFO - 2015-11-20 21:01:34,085 DEBUG : BROWSER_OUTPUT: 21:01:36 INFO - 2015-11-20 21:01:36,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59652/tests/kraken/driver.html?testName=audio-dft) 21:01:37 INFO - 2015-11-20 21:01:37,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 168755200 21:01:37 INFO - 2015-11-20 21:01:37,234 DEBUG : BROWSER_OUTPUT: 21:01:40 INFO - 2015-11-20 21:01:40,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59652/tests/kraken/driver.html?testName=audio-fft) 21:01:40 INFO - 2015-11-20 21:01:40,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 152182784 21:01:40 INFO - 2015-11-20 21:01:40,636 DEBUG : BROWSER_OUTPUT: 21:01:42 INFO - 2015-11-20 21:01:42,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59652/tests/kraken/driver.html?testName=audio-oscillator) 21:01:43 INFO - 2015-11-20 21:01:43,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 154152960 21:01:43 INFO - 2015-11-20 21:01:43,187 DEBUG : BROWSER_OUTPUT: 21:01:45 INFO - 2015-11-20 21:01:45,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:01:45 INFO - 2015-11-20 21:01:45,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 156975104 21:01:45 INFO - 2015-11-20 21:01:45,889 DEBUG : BROWSER_OUTPUT: 21:01:48 INFO - 2015-11-20 21:01:48,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59652/tests/kraken/driver.html?testName=imaging-darkroom) 21:01:49 INFO - 2015-11-20 21:01:49,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 155992064 21:01:49 INFO - 2015-11-20 21:01:49,358 DEBUG : BROWSER_OUTPUT: 21:01:52 INFO - 2015-11-20 21:01:52,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59652/tests/kraken/driver.html?testName=imaging-desaturate) 21:01:53 INFO - 2015-11-20 21:01:53,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 157429760 21:01:53 INFO - 2015-11-20 21:01:53,298 DEBUG : BROWSER_OUTPUT: 21:01:56 INFO - 2015-11-20 21:01:56,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59652/tests/kraken/driver.html?testName=json-parse-financial) 21:01:56 INFO - 2015-11-20 21:01:56,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 156475392 21:01:56 INFO - 2015-11-20 21:01:56,602 DEBUG : BROWSER_OUTPUT: 21:01:58 INFO - 2015-11-20 21:01:58,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:01:58 INFO - 2015-11-20 21:01:58,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 167665664 21:01:58 INFO - 2015-11-20 21:01:58,719 DEBUG : BROWSER_OUTPUT: 21:02:00 INFO - 2015-11-20 21:02:00,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:02:01 INFO - 2015-11-20 21:02:01,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 167518208 21:02:01 INFO - 2015-11-20 21:02:01,097 DEBUG : BROWSER_OUTPUT: 21:02:03 INFO - 2015-11-20 21:02:03,189 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:02:03 INFO - 2015-11-20 21:02:03,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 171073536 21:02:03 INFO - 2015-11-20 21:02:03,770 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:02:06 INFO - 2015-11-20 21:02:06,733 DEBUG : BROWSER_OUTPUT: RSS: Main: 179023872 21:02:06 INFO - 2015-11-20 21:02:06,733 DEBUG : BROWSER_OUTPUT: 21:02:09 INFO - 2015-11-20 21:02:09,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:02:09 INFO - 2015-11-20 21:02:09,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 178028544 21:02:09 INFO - 2015-11-20 21:02:09,842 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59652/tests/kraken/driver.html?testName=ai-astar) 21:02:11 INFO - 2015-11-20 21:02:11,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 237813760 21:02:11 INFO - 2015-11-20 21:02:11,757 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,758 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:02:11 INFO - 2015-11-20 21:02:11,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:02:11 INFO - 2015-11-20 21:02:11,759 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:02:11 INFO - 2015-11-20 21:02:11,759 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:02:11 INFO - 2015-11-20 21:02:11,759 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;109;110;111;99;109;109;109 21:02:11 INFO - 2015-11-20 21:02:11,760 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;132;147;164;126;149;146;124;164;125 21:02:11 INFO - 2015-11-20 21:02:11,760 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;161;161;161;162;162;164;161;162 21:02:11 INFO - 2015-11-20 21:02:11,760 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;82;97;72;72;73;126;89;72 21:02:11 INFO - 2015-11-20 21:02:11,760 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;90;139;90;91;91;137;90;91;130 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;109;110;111;110 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;144;146;145;145;146;145;145;145 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;96;96;95;95;95;95 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;57;57;58;57;64;53;55 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;68;69;69;69;70;69;70 21:02:11 INFO - 2015-11-20 21:02:11,761 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;85;93;86;87;97;84;86;86 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;116;120;115;126;114;116;115;121;115 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;143;153;147;149;138;148;149;147;136 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;69;65;65;66;66;67;65;65 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:02:11 INFO - 2015-11-20 21:02:11,762 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,918 21:02:11 INFO - 2015-11-20 21:02:11,763 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:02:11 INFO - 2015-11-20 21:02:11,763 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082131757__endTimestamp 21:02:11 INFO - 2015-11-20 21:02:11,763 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,766 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:02:11 INFO - 2015-11-20 21:02:11,766 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:02:11 INFO - 2015-11-20 21:02:11,766 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.74 (3.4%) stddev-sans-first:3.97 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 109.0 110.0 111.0 99.0 109.0 109.0 109.0 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.00 Median:148.00 stddev:15.41 (10.4%) stddev-sans-first:15.92 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: Values: 153.0 132.0 147.0 164.0 126.0 149.0 146.0 124.0 164.0 125.0 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.33 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 161.0 161.0 161.0 162.0 162.0 164.0 161.0 162.0 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.80 Median:73.00 stddev:17.53 (24.0%) stddev-sans-first:18.23 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 82.0 97.0 72.0 72.0 73.0 126.0 89.0 72.0 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:90.50 stddev:21.68 (24.0%) stddev-sans-first:22.55 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: Values: 92.0 90.0 139.0 90.0 91.0 91.0 137.0 90.0 91.0 130.0 21:02:11 INFO - 2015-11-20 21:02:11,767 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 109.0 110.0 111.0 110.0 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 144.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.79 (4.9%) stddev-sans-first:2.95 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 57.0 57.0 58.0 57.0 64.0 53.0 55.0 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 68.0 69.0 69.0 69.0 70.0 69.0 70.0 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,768 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.00 stddev:4.43 (5.2%) stddev-sans-first:4.45 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 85.0 93.0 86.0 87.0 97.0 84.0 86.0 86.0 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.80 Median:118.00 stddev:5.43 (4.6%) stddev-sans-first:3.97 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: Values: 130.0 116.0 120.0 115.0 126.0 114.0 116.0 115.0 121.0 115.0 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:147.50 stddev:5.73 (3.9%) stddev-sans-first:5.53 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: Values: 138.0 143.0 153.0 147.0 149.0 138.0 148.0 149.0 147.0 136.0 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 69.0 65.0 65.0 66.0 66.0 67.0 65.0 65.0 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:02:11 INFO - 2015-11-20 21:02:11,769 DEBUG : BROWSER_OUTPUT: 21:02:12 INFO - 2015-11-20 21:02:12,617 INFO : Browser exited with error code: 0 21:02:12 INFO - 2015-11-20 21:02:12,668 INFO : Completed test kraken (00:00:59) 21:02:12 INFO - 2015-11-20 21:02:12,668 INFO : Starting test v8_7 21:02:12 INFO - 2015-11-20 21:02:12,668 DEBUG : operating with platform_type : linux_ 21:02:12 INFO - 2015-11-20 21:02:12,668 INFO : Initialising browser for v8_7 test... 21:02:12 INFO - 2015-11-20 21:02:12,674 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLdjgYP/profile http://localhost:59652/getInfo.html 21:02:17 INFO - 2015-11-20 21:02:17,075 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:02:17 INFO - 2015-11-20 21:02:17,075 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:02:17 INFO - 2015-11-20 21:02:17,075 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:02:17 INFO - 2015-11-20 21:02:17,075 DEBUG : BROWSER_OUTPUT: __metrics 21:02:17 INFO - 2015-11-20 21:02:17,285 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:02:18 INFO - 2015-11-20 21:02:18,893 INFO : Browser initialized. 21:02:18 INFO - 2015-11-20 21:02:18,894 INFO : Running cycle 1/1 for v8_7 test... 21:02:18 INFO - 2015-11-20 21:02:18,894 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLdjgYP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:02:30 INFO - 2015-11-20 21:02:30,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 141955072 21:02:30 INFO - 2015-11-20 21:02:30,669 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59652/tests/v8_7/run.html (next: http://localhost:59652/tests/v8_7/run.html) 21:02:52 INFO - 2015-11-20 21:02:52,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 172318720 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:02:52 INFO - 2015-11-20 21:02:52,332 DEBUG : BROWSER_OUTPUT: |0;Richards;163.55904481517828 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.09937888198758 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.30670470756064 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1941.7475728155339 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |5;Earley;780.0312012480499 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |6;Boyer;12407.407407407407 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 21:02:52 INFO - 2015-11-20 21:02:52,333 DEBUG : BROWSER_OUTPUT: |8;Splay;620.3473945409429 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082172328__endTimestamp 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:02:52 INFO - 2015-11-20 21:02:52,334 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.56 Median:163.56 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: Values: 163.6 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.10 Median:194.10 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: Values: 194.1 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,335 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.31 Median:285.31 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: Values: 285.3 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: Values: 5045.2 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1941.75 Median:1941.75 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,336 DEBUG : BROWSER_OUTPUT: Values: 1941.7 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: Values: 780.0 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: Values: 12407.4 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: Values: 25871.8 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:620.35 Median:620.35 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: Values: 620.3 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: Values: 4840.6 21:02:52 INFO - 2015-11-20 21:02:52,337 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:02:52 INFO - 2015-11-20 21:02:52,338 DEBUG : BROWSER_OUTPUT: 21:02:53 INFO - 2015-11-20 21:02:53,233 INFO : Browser exited with error code: 0 21:02:53 INFO - 2015-11-20 21:02:53,250 INFO : Completed test v8_7 (00:00:40) 21:02:53 INFO - 2015-11-20 21:02:53,341 INFO : Completed test suite (00:20:17) 21:02:53 INFO - 2015-11-20 21:02:53,341 DEBUG : Working with test: dromaeo_css 21:02:53 INFO - 2015-11-20 21:02:53,341 DEBUG : Generating results file: dromaeo_css 21:02:53 INFO - 2015-11-20 21:02:53,342 DEBUG : Working with test: kraken 21:02:53 INFO - 2015-11-20 21:02:53,342 DEBUG : Generating results file: kraken 21:02:53 INFO - 2015-11-20 21:02:53,343 INFO : javascript benchmark 21:02:53 INFO - 2015-11-20 21:02:53,343 DEBUG : Working with test: v8_7 21:02:53 INFO - 2015-11-20 21:02:53,343 DEBUG : Generating results file: v8_7 21:02:53 INFO - 2015-11-20 21:02:53,343 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:53 INFO - 2015-11-20 21:02:53,468 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 21:02:53 INFO - 2015-11-20 21:02:53,468 DEBUG : process_Request line: dromaeo_css 6977.95 graph.html#tests=[[72,63,35]] 21:02:53 INFO - 2015-11-20 21:02:53,468 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:53 INFO - 2015-11-20 21:02:53,571 DEBUG : process_Request line: kraken 1492.80 graph.html#tests=[[232,63,35]] 21:02:53 INFO - 2015-11-20 21:02:53,571 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:53 INFO - 2015-11-20 21:02:53,691 DEBUG : process_Request line: v8_7 19813.59 graph.html#tests=[[230,63,35]] 21:02:53 INFO - 2015-11-20 21:02:53,692 INFO : javascript benchmark 21:02:53 INFO - 2015-11-20 21:02:53,696 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3194.6485886552477, 3249.610046794385, 3289.2599165187835, 3293.8023718576887, 3322.1528510229896, 5227.137522308814, 5331.600129990247, 5433.6196466247375, 5472.097103977844, 5485.314335708032, 5418.7019713915715, 5453.754581043852, 5462.317210348707, 5477.863053423656, 5591.580631452647, 4958.206686930101, 4976.3530741003615, 4996.150654388744, 5024.899502009957, 5081.034603425356, 4880.780364883589, 5116.641835071547, 5121.769520371592, 5158.896822063575, 5213.556847667953, 4959.305697202412, 4974.726390048546, 5018.046571151506, 5033.899322013539, 5034.4713805050305, 4972.6270529710055, 4975.800967961313, 4980.9252861207115, 4981.178105612569, 5022.497750224985, 4869.123557759602, 4961.751912404401, 4966.850994470172, 4975.577075948549, 4976.850694479172, 5138.075146473633, 5224.346956630421, 5230.398504172031, 5247.658902171346, 5270.420253772082, 5904.763809447617, 5908.497777688859, 5915.615484993505, 5917.053271476586, 5941.049432090888, 5795.0, 5895.882082358372, 5942.821715348547, 5944.0, 5953.464188223037, 5465.9726701366235, 5521.2270282160525, 5531.446855314436, 5548.167774833807, 5602.663840169644, 6124.846878827976, 6133.662648554283, 6147.415995480422, 6151.876962460726, 6152.200213972155, 5702.344230413472, 5799.3620701722775, 5938.910916336258, 5959.12410208554, 6004.369541198199, 5877.706114694248, 5896.970515147397, 5961.433663801932, 6016.639001659827, 6020.187274717945, 5854.941450585525, 6006.609570377911, 6019.638821670714, 6021.337652858269, 6021.909671354933, 5764.337101233328, 5989.2812862456785, 6007.639541627516, 6009.639421634716, 6010.248718910137, 4494.910101797946, 4535.909281814345, 4567.680262381601, 4613.1465678848845, 4624.421947256593, 4064.227796718614, 4069.7558146511305, 4084.571120032413, 4087.141700242982, 4109.8972525686495, 5688.829335119953, 5693.089105743061, 5694.345150307768, 5696.458836410535, 5742.626729262584, 5777.162311464898, 5894.705264736746, 5904.468597826216, 5904.911426328608, 5988.4909782668965, 5659.434056594308, 5663.348714897839, 5664.26364572603, 5713.285839270091, 5734.512566431817, 5178.456262092502, 5188.8962220755375, 5189.792408303626, 5191.402988656353, 5239.659422137625, 5969.0, 6074.301455332693, 6123.203983482119, 6123.510119190543, 6143.662098584621, 5827.562932779973, 5903.055511118372, 5909.23179986599, 5914.792982245601, 5966.164736936919, 6126.540509461719, 6144.8771024580155, 6193.163922870535, 6195.132681424514, 6196.1635179252025, 5690.317161940594, 5761.711914404347, 5822.94177058224, 5909.409059094056, 5925.674087925206, 5778.537716982715, 5843.357230704704, 5848.707564621667, 5861.443162899518, 5916.26046744157, 5802.158686990447, 5874.530037596896, 5875.471207591338, 5878.118282257696, 5885.293764748258, 5656.23640808502, 5813.970930145322, 5822.534197264124, 5827.650340979555, 5871.823845284648, 5649.576281778801, 5739.397363276796, 5741.25363702716, 5744.798932037359, 5789.8552536186935, 5817.563682723898, 5878.735456904364, 5885.793997210077, 5904.261967254093, 5952.226210592596, 5493.258410114743, 5619.662820230799, 5620.803271885465, 5699.7435115419075, 5749.166370876116], "unit": "ms", "name": "dojo.html", "value": 5460.79791688019}, {"lowerIsBetter": false, "replicates": [587.9441453061958, 600.3336296710652, 601.4646964201861, 601.5007543738698, 617.8918689229387, 31527.842360788192, 32414.18964525891, 32454.350912981754, 38712.0, 39778.0, 42684.57315426845, 43436.131277374436, 43468.3479747804, 43559.0, 43567.3464898026, 8798.120187981198, 8926.37515373924, 8967.686130985418, 8967.686130985418, 8968.820623587524, 7880.605969701521, 8067.475614085066, 10528.631497897575, 10771.461426928661, 10775.784484310308, 10528.263021588491, 10621.362718236931, 10629.73425664357, 10635.149188064976, 10636.893631063667, 7851.057873055212, 8048.154943730882, 10568.0, 10644.787104257948, 10680.359178449318, 7748.535087894745, 10597.258191926569, 10894.400807955559, 10906.781864362669, 10907.727306817314, 39995.200455956634, 40447.59552404497, 40464.595354046374, 40508.59491405078, 40593.188136237404, 3211.7912335698106, 3267.8856240031723, 3300.273939733255, 3488.953314005788, 3991.5409727881083, 30278.54582181269, 30512.0, 33141.834290828636, 33799.0, 35077.47383789245, 3984.5816189299994, 3993.101552150772, 3996.6003399660094, 4109.2808758467445, 4191.7275377100395, 253331.0, 255326.0, 255385.0, 255950.0, 256801.0, 53688.82578503444, 54625.180622290696, 59933.40066599366, 60168.0, 60196.69901650551, 70775.29224707687, 71868.28131718721, 72167.0, 72413.27586724171, 72512.63743681248, 14539.27303634814, 14720.411183552753, 14752.926235368968, 14763.409463621334, 14796.852031479762, 10557.0, 10643.0, 10699.197560182862, 10760.139188864872, 10782.08352290064, 20359.287424940056, 20507.69238461424, 20549.8697571635, 20617.793822061587, 20665.27671531519, 8169.591520423955, 8212.34301255898, 8323.1260717625, 8421.789455263668, 8509.702160424355, 910.2717825739383, 960.711786464058, 984.8621193032981, 1060.931039482431, 1061.6231237910586, 28816.0, 29419.558706619417, 29530.409391812045, 32622.83688581542, 33026.17434564155, 1024.6618615856748, 1026.5865995564627, 1102.9834552481718, 1121.7812526557407, 1134.4157758754247, 14592.270386480634, 14740.852591474162, 14761.630959225891, 14905.478308259375, 15030.924845375703, 410989.0, 415848.0, 416131.0, 416674.0, 417379.0, 52542.21186682203, 52775.208371874454, 52872.47127528753, 52907.470925291025, 53080.0, 1358.7893876449166, 1367.1113776045452, 1367.8085068090475, 1384.6261509392407, 1397.2873834344355, 27919.302017448914, 28523.0, 28730.42539149247, 32143.196420089684, 32205.838970804994, 49738.25392619041, 50407.49592504028, 50447.24329134992, 50464.74767626138, 50572.4828255153, 294889.0, 296258.0, 296297.0, 296474.0, 296582.0, 26984.32539186536, 32129.0, 32296.35407291794, 32318.19204519906, 32440.513392299606, 38083.42874856935, 38205.80897095497, 38275.42586861143, 38282.42576361301, 38973.41539876848, 32567.837160814994, 32623.510647340783, 33013.339733205685, 33278.667213328525, 39146.4128038074, 37259.44110838285, 37430.0, 37727.0, 37830.43254351132, 38123.80938095292, 35988.82005589955, 36488.635113648525, 37043.814780925924, 37158.0, 37219.0, 32805.50791738078, 33213.0, 34444.13889652678, 34628.64523821412, 34864.47703284503, 25303.620445693698, 25367.492650147262, 25548.23355299344, 25598.0, 25770.35574110662], "unit": "ms", "name": "ext.html", "value": 19128.79149742887}, {"lowerIsBetter": false, "replicates": [354.4859953068052, 358.51421324105837, 360.0889748935193, 361.6166863125086, 362.50880057522056, 14440.0, 14443.350049247783, 17283.222254998524, 17781.288748450064, 18409.26362945482, 16834.747478787798, 16990.660186796256, 17290.30838766451, 17294.394696185635, 17497.737533937, 5381.246625472427, 5477.972610136943, 5510.090835012218, 5537.723113844291, 5541.861453463675, 3923.0780766519847, 4010.2981978153853, 4014.3978403239457, 4018.0, 5442.727863606804, 5772.30732312121, 5907.143464197688, 5927.1998280232265, 5931.851703707421, 5932.703364831763, 5347.946520534783, 5529.198266251411, 5529.502344788968, 5538.224648549206, 5978.730957106941, 5256.369235691704, 5296.285001524822, 5325.281087053237, 5332.30680011596, 5338.759755810997, 12462.314572698499, 12925.418356173996, 12928.418221180069, 12937.48250069996, 13803.930980345134, 2104.295061154515, 2119.42775450629, 2121.459027947879, 2153.246363772683, 2213.4908970936613, 13078.149920255248, 13151.934240328832, 13237.338133093403, 13333.06668533203, 13571.389287482087, 1797.5236562310997, 1888.291890541047, 1910.0, 1920.894350810705, 1929.9324523641747, 60323.396766032216, 62962.685186574236, 63006.369936300965, 63056.68471657658, 63199.0, 10119.848202276971, 10166.949165254126, 10207.234457415576, 10228.386296822215, 10260.127889129508, 13584.1849489029, 13599.728005440034, 13620.863791362157, 13622.727545449234, 13631.863681363258, 7509.286617771303, 7600.581967991813, 7603.2776886195725, 7635.618219089023, 7700.9614951926005, 7317.41460683144, 7339.559626422325, 7340.192578816326, 7369.705211791468, 7377.9262207378315, 4385.254506733863, 4412.514623391425, 4420.734755914656, 4443.666724995638, 4476.283794592915, 1670.8830381873152, 1755.490907636771, 1763.3828160143846, 1765.2674140231916, 1769.566456218209, 875.8598624220094, 904.3579058868277, 969.4231932000448, 993.6571882700457, 1004.9598016079422, 14782.92608536972, 16428.75356869648, 17162.742558861628, 17405.738913916302, 17473.21370538329, 868.9435186712843, 908.3777612335572, 912.9863052054225, 920.62254475666, 935.7239614313794, 9330.0, 9600.519974001272, 9712.174465170398, 9716.465594392235, 9738.367006144577, 512463.0, 518035.0, 524331.0, 528723.0, 536018.0, 70521.99343598062, 73618.0, 74191.0, 74465.0, 76779.23220767721, 1131.5813149134872, 1141.6289705845634, 1146.3607041929954, 1163.4066626020622, 1171.6367925942814, 14711.852881471048, 14714.558563242692, 14728.189949552878, 14820.7776883349, 15103.773443398139, 31843.840780796876, 32036.35927281488, 32064.519032215, 32116.678833212303, 32212.516812248305, 43513.78243108764, 43551.78224108859, 44193.55806441895, 45562.0, 45959.54040459553, 9117.0, 9322.580483878106, 9447.574859131219, 9502.857457138287, 9565.808683826146, 17376.739348909523, 17765.467035988942, 18102.366417175337, 18128.365507207713, 18254.817451825842, 14567.490137845549, 14703.41186352534, 14721.484748033767, 14814.185219813015, 15236.0, 14510.85489145095, 14688.678018978344, 14723.484678036217, 14729.779053314423, 15277.465288714842, 14007.43970241179, 14503.492377766728, 15245.923770381078, 15415.152166630944, 15644.608884777972, 9272.119148680864, 9311.906880931105, 9560.091791279818, 9562.374396352776, 9906.207503399566, 10694.0, 14675.853241467876, 14956.326965286806, 15223.695526089637, 15273.694526109193], "unit": "ms", "name": "jquery.html", "value": 8815.631891626366}, {"lowerIsBetter": false, "replicates": [1315.1714419915452, 1737.157478622868, 1757.358564124095, 1788.4187639017318, 1796.811334809844, 6560.868782624345, 7266.091738532684, 7300.452466065053, 7377.0, 7383.667734951927, 7484.101907771062, 7628.046494188213, 7660.502067365617, 7667.0416197975255, 7685.11621163565, 1938.6704260275717, 1966.8426525877967, 2187.7155969723913, 2210.347947355526, 2227.8440509164284, 2228.253535065755, 2231.7098777159026, 2232.1852523828766, 2232.2745107839937, 2232.6985856909273, 2154.2244791874914, 2225.7885500877474, 2225.7996780289773, 2227.3318004598636, 2236.6868638390556, 1988.5426351939063, 2032.6239645665526, 2141.271967531039, 2178.4771654802894, 2178.836587255946, 2174.2607513445346, 2196.3081629286726, 2202.48241663209, 2223.144089525544, 2226.0984301357976, 7771.028621422322, 7808.843823123562, 7834.686612535492, 7835.138134805167, 7844.921550784533, 4529.071540334224, 4620.145273124449, 4623.953760462419, 4626.953730462686, 4634.21218392874, 2917.0, 2960.674325824179, 2970.524716045444, 3011.3826665533734, 3030.3181784098624, 934.5514153206431, 941.2517048946104, 943.6319835264252, 957.1720461800493, 975.7219192530166, 10698.625548105856, 10699.358038517636, 10700.357978521235, 10701.0, 10704.1436685065, 4030.133521292936, 4039.5354534228354, 4089.4683691119963, 4116.526599441043, 4170.457840480718, 9210.355275130676, 9245.953770231106, 9257.675981340755, 9259.398139120936, 9269.35114541989, 4655.3249778782565, 4665.930011049837, 4672.6261899047995, 4675.345451636774, 4678.578927896438, 4204.789760511962, 4208.221479026329, 4234.089670720809, 4236.491621005499, 4242.490901091889, 3611.386064369011, 3680.9079773005888, 3696.648818362305, 3717.665410113103, 3721.1813401051727, 1182.5092586576645, 1191.142377488207, 1198.7302856857136, 1200.3578085724096, 1212.805951047828, 995.8655581496405, 1257.4781465691635, 1267.7781388257017, 1268.6638040918979, 1276.9999999999814, 6406.8718625627225, 7479.925200748032, 7676.846463070819, 7689.769306920802, 7696.9615151925, 618.4526693875952, 621.1800423441015, 624.6470744029609, 648.824817299336, 650.7884937395365, 5739.253896993448, 5801.9419805802245, 5828.912566311508, 5836.328822185503, 5837.182794408786, 9147.679831205876, 9230.676926307548, 9235.0, 9307.11582399671, 9323.393979391318, 8977.506237157018, 9212.30907681913, 9220.631174752934, 9222.86165707515, 9237.630494780133, 7144.964275178695, 7152.570845749167, 7165.89251161233, 7218.3503484686635, 7228.421726261887, 6816.147981502312, 6877.759278425231, 6921.169459664872, 6925.515213934977, 6927.203371612329, 8063.919360806317, 8064.55644939534, 8107.1892810718455, 8122.83754324922, 8122.918770812216, 8282.627281772215, 8344.707935222481, 8446.197611226924, 8471.195236452528, 8474.872876906727, 6741.865162696817, 6815.250322464426, 6815.89776153368, 6818.113645226089, 6819.215790184192, 7415.406767458699, 7454.627268636655, 7462.664180111799, 7462.888056679263, 7464.738734144496, 6574.211094668671, 6894.517383783087, 6899.275576064641, 6960.164780226405, 7075.787726368218, 6727.966360168363, 6886.173659160732, 6912.930870691229, 6963.234044255027, 7028.402585780266, 6873.20958089826, 6933.0, 6937.965310173417, 6940.028396024662, 6963.199232088172, 5886.087656413263, 5930.466258036798, 6137.570370074052, 6232.407921247474, 6258.123862659322, 6490.935090649033, 6506.3493650634555, 6520.869582608416, 6544.0, 6571.441427478718], "unit": "ms", "name": "mootools.html", "value": 4353.777993507641}, {"lowerIsBetter": false, "replicates": [332.96170940341864, 336.76426501448975, 338.3993411694241, 342.37345657446866, 344.54003904787106, 6003.099535069742, 6012.789552365668, 6018.458338749511, 6028.969855150729, 6042.486388656969, 5912.526997840173, 5943.791967281146, 5952.136940143677, 5965.105234214859, 5970.73131709073, 4625.283081122431, 4630.72215667061, 4634.860954171363, 4637.744924029177, 4639.443266807988, 4479.8432054878085, 4588.311753237024, 4604.861854144364, 4606.032733126048, 4610.031893302411, 4563.155816174019, 4564.703294285878, 4574.130915126132, 4574.725516469022, 4575.428071491064, 4361.476622805252, 4425.0, 4489.820407183709, 4551.954480455202, 4569.337446070318, 3946.1515774108702, 3967.8809635710977, 3983.0, 3985.7807820569856, 3992.6606238469767, 5597.3003374578175, 5598.412166722517, 5608.102703567451, 5608.49523542879, 5614.63504872182, 5019.4227663818765, 5133.589312854962, 5185.092608793484, 5275.103232450492, 5275.314209152824, 6267.247930248353, 6281.403266689657, 6283.434490895841, 6290.905636415411, 6303.369663033705, 4353.825846966118, 4369.3227549729845, 4376.6498680105515, 4383.978080109611, 4389.780510974439, 6408.487321014308, 6485.0, 6549.083128362033, 6553.311902250242, 6554.180727409074, 4473.776311184428, 4476.440444944382, 4477.19410506112, 4479.216137176047, 4482.708623939434, 4534.206513860127, 4534.59188673021, 4536.954630453719, 4537.342085397599, 4539.296409056601, 5240.266362709223, 5247.921281180786, 5250.081235783722, 5250.267411754112, 5252.264682944391, 6220.813375598739, 6353.491720662336, 6358.713857876407, 6359.8092057238355, 6368.649724265118, 1589.1577463944127, 1598.472504073653, 1600.9913754334696, 1601.071378600409, 1601.599600099975, 1061.3048453263125, 1062.9043386095288, 1068.989804634613, 1080.222239987208, 1089.1341383600056, 6135.478484328793, 6174.0, 6174.598651087665, 6180.536459765535, 6188.412100850412, 6538.640374779337, 6550.606963582105, 6554.0, 6564.409203171737, 6564.671766411756, 6039.063945088518, 6172.660503672251, 6182.0, 6182.907256391158, 6187.938120618736, 3523.3834079036064, 3534.381483240474, 3536.964630353715, 3550.609432962372, 3556.644335566423, 6759.459243260528, 6764.053032575345, 6769.255381907986, 6770.72917083321, 6773.085633439521, 6511.0, 6528.902066469007, 6702.430293425016, 6707.463402927754, 6708.060871477997, 6454.870902582016, 6732.899006514906, 6877.724891004304, 6886.655667216719, 6889.793306200822, 6610.933890661032, 6621.404073633396, 6627.0, 6627.045021718508, 6629.0, 6564.770233041821, 6566.0, 6566.0479230512265, 6566.310537393505, 6572.047053177358, 6698.162729658793, 6870.416014638811, 6885.173779146535, 6895.138107736533, 6899.448044156355, 4431.20238357086, 4454.643628509776, 4455.821767129279, 4464.352668862932, 4467.15124126415, 6550.181227346582, 6556.3443655634055, 6557.278699342973, 6561.376669216417, 6563.671816409256, 6305.148804911279, 6397.87204255903, 6401.615903045832, 6406.839829004312, 6421.7110230038825, 6383.872322553616, 6393.392627700361, 6399.488040956619, 6409.198850143732, 6418.0693799397895, 6288.339724328879, 6297.748090076346, 6301.023341382093, 6306.558540902276, 6311.863864504433, 6318.6840657965995, 6446.9032964506505, 6450.741970321134, 6452.741890324334, 6469.611823290617, 6300.0, 6301.369863013662, 6301.873962520815, 6302.212223472066, 6309.274433440213], "unit": "ms", "name": "prototype.html", "value": 4788.579349504352}, {"lowerIsBetter": false, "replicates": [840.0633293877329, 864.0581765875195, 866.3372520022182, 867.8177582707631, 893.0399820193294, 13722.794158087625, 14017.36921838517, 14019.719605607881, 14027.649308767286, 14101.083429577084, 13384.531541396052, 13417.329133543308, 13498.595042148727, 13502.392392342344, 13507.054506184571, 668.238208442376, 675.7364627795164, 799.0611032037333, 813.8616435206029, 815.808285053012, 804.4449329962307, 807.7738233294687, 810.7365106340434, 811.2536466450879, 811.4928169893816, 702.2345643248858, 851.2041241439274, 858.4248553469159, 859.5659192107977, 859.8065435277044, 704.0460176460898, 704.1163340008283, 706.307818338029, 829.9543525106117, 849.524266410812, 630.5334052800895, 630.7571584939785, 630.7634637011121, 631.0250662726054, 631.0376675569747, 13668.794968075486, 13705.314734263247, 13759.79360309596, 13801.930990345085, 13841.961852861075, 12262.20295680778, 12642.367881605975, 13045.217286962812, 13151.802722959163, 13209.0, 10549.84175237372, 10676.306040107445, 10757.462126893624, 10758.408287544182, 10758.838617420744, 3629.836657350399, 3670.06413364593, 3716.7955762433057, 3732.4774531565604, 3799.0502374406396, 45549.54450455486, 46460.53539464596, 46776.2983555247, 47049.52950470486, 47627.0, 9444.974213293253, 9677.37097088687, 9752.853707194397, 9799.0, 9838.06538378853, 18367.17347719356, 18407.90796046011, 18413.907930460264, 18417.0, 18429.631407371777, 7465.925340746631, 7661.770146895602, 7662.846743065219, 7668.271514206142, 7847.803804904809, 4208.137331846964, 4336.783160841946, 4377.146456441027, 4424.446944131983, 4496.213162696515, 2818.0559512563523, 2878.6977367376544, 2879.1794338613395, 2881.380503191782, 2883.3800732842537, 501.6313009937693, 507.90603738308533, 510.4104759003357, 521.5123859191668, 523.8166641675459, 515.4047075627581, 529.9072662284085, 531.5163201486629, 535.7910414938177, 556.2407314016339, 8329.791755206046, 8367.288780453608, 8662.220400164015, 8704.477731336141, 8831.60257788401, 434.1794009322383, 444.3268448300827, 452.8120829855639, 453.8456924645636, 482.77309664457647, 3656.634336566322, 3676.779393236361, 3684.9263014739554, 3860.285847118292, 3872.128771026553, 57580.42419575751, 58383.70808145932, 58397.416025840044, 58537.26821415592, 58538.0, 51654.48345516572, 51826.48173518292, 51856.48143518517, 51967.480325196266, 52312.738436307576, 43144.56855431468, 43804.342934856, 44469.77765111154, 44488.77755611266, 44659.77670111629, 7175.820604484721, 7203.243659415895, 7324.754791685533, 7369.37360324357, 7475.850482990201, 33610.663893360754, 33861.0, 33873.0, 34882.127946801535, 35153.47269791007, 39620.603793961694, 44390.77804610956, 44919.55080449153, 45002.32496512489, 45094.77452612716, 9122.726318210463, 9154.176124148858, 9197.954010229905, 9235.445873247627, 9420.246380289698, 10696.41169735672, 10929.071028962628, 10953.34279943206, 11680.47437865281, 12009.0, 9685.031496850259, 10261.538230779783, 10455.895441045492, 10626.468676566295, 10817.1346292298, 9863.704088877344, 9890.406575605486, 10237.078662920372, 10479.895201047892, 10497.212709047004, 7506.28690274423, 9632.27757918145, 10288.897111028793, 10448.895511045097, 10513.89486105129, 8574.528400938008, 8673.219410253107, 9110.908890911007, 9424.481653508848, 9580.281478888972, 8421.975220110928, 8878.911210887809, 8885.289176865965, 8919.73240802777, 8938.0], "unit": "ms", "name": "yui.html", "value": 6012.512600519705}], "name": "dromaeo_css", "value": 6977.949113434866}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 109.0, 110.0, 111.0, 99.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [153.0, 132.0, 147.0, 164.0, 126.0, 149.0, 146.0, 124.0, 164.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 161.0, 161.0, 162.0, 162.0, 164.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 82.0, 97.0, 72.0, 72.0, 73.0, 126.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [92.0, 90.0, 139.0, 90.0, 91.0, 91.0, 137.0, 90.0, 91.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 144.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 58.0, 57.0, 64.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 93.0, 86.0, 87.0, 97.0, 84.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [130.0, 116.0, 120.0, 115.0, 126.0, 114.0, 116.0, 115.0, 121.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.8}, {"lowerIsBetter": true, "replicates": [138.0, 143.0, 153.0, 147.0, 149.0, 138.0, 148.0, 149.0, 147.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 69.0, 65.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1492.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.55904481517828], "unit": "score", "name": "Richards", "value": 215.83642799999996}, {"lowerIsBetter": false, "replicates": [194.09937888198758], "unit": "score", "name": "DeltaBlue", "value": 340.63993600000003}, {"lowerIsBetter": false, "replicates": [285.30670470756064], "unit": "score", "name": "Encrypt", "value": 932.9644049999997}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [1941.7475728155339], "unit": "score", "name": "RayTrace", "value": 381.094335}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [620.3473945409429], "unit": "score", "name": "Splay", "value": 131.363492}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19813.5937989924}]} 21:02:53 INFO - RETURN: dromaeo_css: 6977.95 21:02:53 INFO - RETURN: kraken: 1492.80 21:02:53 INFO - RETURN: v8_7: 19813.59 21:02:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19813.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1492.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6977.95"}}} 21:02:53 INFO - Return code: 0 21:02:53 INFO - # TBPL SUCCESS # 21:02:53 INFO - Running post-action listener: _resource_record_post_action 21:02:53 INFO - Running post-run listener: _resource_record_post_run 21:02:54 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506101760; Read time: 1332; Write time: 1168540 21:02:54 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 222253056; Read time: 0; Write time: 569380 21:02:54 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278032384; Read time: 1332; Write time: 561596 21:02:54 INFO - Running post-run listener: _upload_blobber_files 21:02:54 INFO - Blob upload gear active. 21:02:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:02:54 INFO - Copying logs to upload dir... 21:02:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.454174 ========= master_lag: 67.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 25 secs) (at 2015-11-20 21:04:02.155983) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:04:02.159522) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010255 build_url: 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.51 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:04:02.682422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:04:02.682744) ========= 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=a194aa7faa1be204aaca7d660000020b-1448078636.911106-1171229368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:04:02.696170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:04:02.696444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:04:02.696705) ========= ========= Total master_lag: 68.18 =========