builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1447781736.48 results: success (0) buildid: 20151117073331 builduid: 7b13ee8d34ca46dbb0ba675ecbd95936 revision: f3eb66d21d1ca1e9b140a3052dda40717358562b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.481482) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.481910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.482210) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006690 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.503185) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.503525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.516686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.517054) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004770 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.566290) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.566607) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.566988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.567271) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 09:35:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-11-17 09:35:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117786 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.697527) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.697833) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.747481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:36.747806) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f3eb66d21d1ca1e9b140a3052dda40717358562b --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 f3eb66d21d1ca1e9b140a3052dda40717358562b --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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 09:35:36,973 truncating revision to first 12 chars 2015-11-17 09:35:36,973 Setting DEBUG logging. 2015-11-17 09:35:36,973 attempt 1/10 2015-11-17 09:35:36,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f3eb66d21d1c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 09:35:37,232 unpacking tar archive at: mozilla-inbound-f3eb66d21d1c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:37.317013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:37.317308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:37.341811) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:37.342102) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:35:37.342489) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-17 09:35:37.342765) ========= /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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:35:37 INFO - MultiFileLogger online at 20151117 09:35:37 in /builds/slave/test-pgo 09:35:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:35:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:35:37 INFO - {'append_to_log': False, 09:35:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:35:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:35:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:35:37 INFO - 'branch': 'Mozilla-Inbound', 09:35:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:37 INFO - 'config_files': ('talos/linux_config.py',), 09:35:37 INFO - 'default_actions': ('clobber', 09:35:37 INFO - 'read-buildbot-config', 09:35:37 INFO - 'download-and-extract', 09:35:37 INFO - 'populate-webroot', 09:35:37 INFO - 'create-virtualenv', 09:35:37 INFO - 'install', 09:35:37 INFO - 'run-tests'), 09:35:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:37 INFO - 'download_minidump_stackwalk': True, 09:35:37 INFO - 'download_symbols': 'ondemand', 09:35:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:37 INFO - 'installer_path': 'installer.exe', 09:35:37 INFO - 'log_level': 'info', 09:35:37 INFO - 'log_name': 'talos', 09:35:37 INFO - 'log_to_console': True, 09:35:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:35:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:35:37 INFO - 'opt_config_files': (), 09:35:37 INFO - 'pip_index': False, 09:35:37 INFO - 'sps_profile': False, 09:35:37 INFO - 'sps_profile_interval': 0, 09:35:37 INFO - 'suite': 'dromaeojs', 09:35:37 INFO - 'system_bits': '64', 09:35:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:37 INFO - 'title': 'talos-linux64-ix-011', 09:35:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:37 INFO - 'use_talos_json': True, 09:35:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:35:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:37 INFO - 'work_dir': 'build'} 09:35:37 INFO - ##### 09:35:37 INFO - ##### Running clobber step. 09:35:37 INFO - ##### 09:35:37 INFO - Running pre-action listener: _resource_record_pre_action 09:35:37 INFO - Running main action method: clobber 09:35:37 INFO - rmtree: /builds/slave/test-pgo/build 09:35:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:35:38 INFO - Running post-action listener: _resource_record_post_action 09:35:38 INFO - ##### 09:35:38 INFO - ##### Running read-buildbot-config step. 09:35:38 INFO - ##### 09:35:38 INFO - Running pre-action listener: _resource_record_pre_action 09:35:38 INFO - Running main action method: read_buildbot_config 09:35:38 INFO - Using buildbot properties: 09:35:38 INFO - { 09:35:38 INFO - "properties": { 09:35:38 INFO - "buildnumber": 1271, 09:35:38 INFO - "product": "firefox", 09:35:38 INFO - "script_repo_revision": "production", 09:35:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:35:38 INFO - "repository": "", 09:35:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:35:38 INFO - "buildid": "20151117073331", 09:35:38 INFO - "slavename": "talos-linux64-ix-011", 09:35:38 INFO - "pgo_build": "True", 09:35:38 INFO - "basedir": "/builds/slave/test-pgo", 09:35:38 INFO - "project": "", 09:35:38 INFO - "platform": "ubuntu64_hw", 09:35:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:35:38 INFO - "slavebuilddir": "test", 09:35:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:35:38 INFO - "branch": "mozilla-inbound", 09:35:38 INFO - "repo_path": "integration/mozilla-inbound", 09:35:38 INFO - "stage_platform": "linux64-pgo", 09:35:38 INFO - "builduid": "7b13ee8d34ca46dbb0ba675ecbd95936", 09:35:38 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:38 INFO - }, 09:35:38 INFO - "sourcestamp": { 09:35:38 INFO - "repository": "", 09:35:38 INFO - "hasPatch": false, 09:35:38 INFO - "project": "", 09:35:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:35:38 INFO - "changes": [ 09:35:38 INFO - { 09:35:38 INFO - "category": null, 09:35:38 INFO - "files": [ 09:35:38 INFO - { 09:35:38 INFO - "url": null, 09:35:38 INFO - "name": "https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:35:38 INFO - } 09:35:38 INFO - ], 09:35:38 INFO - "repository": "", 09:35:38 INFO - "rev": "f3eb66d21d1ca1e9b140a3052dda40717358562b", 09:35:38 INFO - "who": "sendchange", 09:35:38 INFO - "when": 1447781708, 09:35:38 INFO - "number": 6672764, 09:35:38 INFO - "comments": "", 09:35:38 INFO - "project": "", 09:35:38 INFO - "at": "Tue 17 Nov 2015 09:35:08", 09:35:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 09:35:38 INFO - "revlink": "", 09:35:38 INFO - "properties": [ 09:35:38 INFO - [ 09:35:38 INFO - "buildid", 09:35:38 INFO - "20151117073331", 09:35:38 INFO - "Change" 09:35:38 INFO - ], 09:35:38 INFO - [ 09:35:38 INFO - "builduid", 09:35:38 INFO - "7b13ee8d34ca46dbb0ba675ecbd95936", 09:35:38 INFO - "Change" 09:35:38 INFO - ], 09:35:38 INFO - [ 09:35:38 INFO - "pgo_build", 09:35:38 INFO - "True", 09:35:38 INFO - "Change" 09:35:38 INFO - ] 09:35:38 INFO - ], 09:35:38 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:38 INFO - } 09:35:38 INFO - ], 09:35:38 INFO - "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b" 09:35:38 INFO - } 09:35:38 INFO - } 09:35:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:35:38 INFO - Running post-action listener: _resource_record_post_action 09:35:38 INFO - ##### 09:35:38 INFO - ##### Running download-and-extract step. 09:35:38 INFO - ##### 09:35:38 INFO - Running pre-action listener: _resource_record_pre_action 09:35:38 INFO - Running main action method: download_and_extract 09:35:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:38 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:35:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json 09:35:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json 09:35:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:35:41 INFO - Downloaded 1302 bytes. 09:35:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:35:41 INFO - Using the following test package requirements: 09:35:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:35:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'jsshell-linux-x86_64.zip'], 09:35:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:35:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:35:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:35:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:35:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:35:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:35:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:35:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:41 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:47 INFO - Downloaded 22461671 bytes. 09:35:47 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 09:35:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:47 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 09:35:48 INFO - Return code: 0 09:35:48 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 09:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:48 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:49 INFO - Downloaded 22461671 bytes. 09:35:49 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 09:35:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:35:49 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 09:35:50 INFO - Return code: 0 09:35:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:50 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:51 INFO - Downloaded 11131693 bytes. 09:35:51 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 09:35:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:35:51 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 09:35:51 INFO - Return code: 0 09:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:51 INFO - https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/i_tV8gIRRvq2cUX8OKqRLw/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 09:35:52 INFO - Downloaded 57187865 bytes. 09:35:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:35:52 INFO - mkdir: /builds/slave/test-pgo/properties 09:35:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:35:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:35:52 INFO - Contents: 09:35:52 INFO - build_url:https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:35:52 INFO - Running post-action listener: _resource_record_post_action 09:35:52 INFO - Running post-action listener: set_extra_try_arguments 09:35:52 INFO - ##### 09:35:52 INFO - ##### Running populate-webroot step. 09:35:52 INFO - ##### 09:35:52 INFO - Running pre-action listener: _resource_record_pre_action 09:35:52 INFO - Running main action method: populate_webroot 09:35:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:35:52 INFO - '../fennec_ids.txt'], 09:35:52 INFO - 'tests': ['tcheck2']}, 09:35:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:52 INFO - '--tppagecycles', 09:35:52 INFO - '7'], 09:35:52 INFO - 'tests': ['tsvgm']}}, 09:35:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:35:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:35:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:35:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:52 INFO - 'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:52 INFO - 'tests': ['damp', 'tps']}, 09:35:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:52 INFO - 'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['damp', 'tps']}, 09:35:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:35:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:52 INFO - 'other': {'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'other_l64': {'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'other_nol64': {'tests': ['a11yr', 09:35:52 INFO - 'ts_paint', 09:35:52 INFO - 'tpaint', 09:35:52 INFO - 'sessionrestore', 09:35:52 INFO - 'sessionrestore_no_auto_restore']}, 09:35:52 INFO - 'svgr': {'tests': ['tsvgx', 09:35:52 INFO - 'tsvgr_opacity', 09:35:52 INFO - 'tart', 09:35:52 INFO - 'tscrollx', 09:35:52 INFO - 'cart']}, 09:35:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:35:52 INFO - 'tests': ['tsvgx', 09:35:52 INFO - 'tsvgr_opacity', 09:35:52 INFO - 'tart', 09:35:52 INFO - 'tscrollx', 09:35:52 INFO - 'cart']}, 09:35:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:52 INFO - 'tests': ['tp5o']}, 09:35:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:53 INFO - 'talos_options': ['--e10s'], 09:35:53 INFO - 'tests': ['tp5o']}, 09:35:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:53 INFO - 'talos_options': ['--xperf_path', 09:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:53 INFO - 'tests': ['tp5n']}, 09:35:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:35:53 INFO - 'talos_options': ['--e10s', 09:35:53 INFO - '--xperf_path', 09:35:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:53 INFO - 'tests': ['tp5n']}}, 09:35:53 INFO - 'talos.zip': {'path': '', 09:35:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:53 INFO - Running post-action listener: _resource_record_post_action 09:35:53 INFO - ##### 09:35:53 INFO - ##### Running create-virtualenv step. 09:35:53 INFO - ##### 09:35:53 INFO - Running pre-action listener: _resource_record_pre_action 09:35:53 INFO - Running main action method: create_virtualenv 09:35:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:35:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:35:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:35:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:53 INFO - Using real prefix '/usr' 09:35:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:55 INFO - Installing pip.................done. 09:35:55 INFO - Return code: 0 09:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:35:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:35:55 INFO - Using env: {'DISPLAY': ':0', 09:35:55 INFO - 'HOME': '/home/cltbld', 09:35:55 INFO - 'LANG': 'en_US.UTF-8', 09:35:55 INFO - 'LANGUAGE': 'en_US:en', 09:35:55 INFO - 'LOGNAME': 'cltbld', 09:35:55 INFO - 'MAIL': '/var/mail/cltbld', 09:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:55 INFO - 'MOZ_NO_REMOTE': '1', 09:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:55 INFO - 'NO_EM_RESTART': '1', 09:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:55 INFO - 'SHELL': '/bin/bash', 09:35:55 INFO - 'SHLVL': '1', 09:35:55 INFO - 'TERM': 'linux', 09:35:55 INFO - 'TMOUT': '86400', 09:35:55 INFO - 'USER': 'cltbld', 09:35:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:55 INFO - '_': '/tools/buildbot/bin/python'} 09:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:35:55 INFO - Cleaning up... 09:35:55 INFO - Return code: 0 09:35:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:35:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:35:55 INFO - Using env: {'DISPLAY': ':0', 09:35:55 INFO - 'HOME': '/home/cltbld', 09:35:55 INFO - 'LANG': 'en_US.UTF-8', 09:35:55 INFO - 'LANGUAGE': 'en_US:en', 09:35:55 INFO - 'LOGNAME': 'cltbld', 09:35:55 INFO - 'MAIL': '/var/mail/cltbld', 09:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:55 INFO - 'MOZ_NO_REMOTE': '1', 09:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:55 INFO - 'NO_EM_RESTART': '1', 09:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:55 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:55 INFO - 'SHELL': '/bin/bash', 09:35:55 INFO - 'SHLVL': '1', 09:35:55 INFO - 'TERM': 'linux', 09:35:55 INFO - 'TMOUT': '86400', 09:35:55 INFO - 'USER': 'cltbld', 09:35:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:55 INFO - '_': '/tools/buildbot/bin/python'} 09:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:55 INFO - Downloading/unpacking psutil>=0.7.1 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:35:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:57 INFO - Installing collected packages: psutil 09:35:57 INFO - Running setup.py install for psutil 09:35:57 INFO - building 'psutil._psutil_linux' extension 09:35:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:35:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:35:58 INFO - building 'psutil._psutil_posix' extension 09:35:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:35:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:58 INFO - Successfully installed psutil 09:35:58 INFO - Cleaning up... 09:35:58 INFO - Return code: 0 09:35:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:35:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 09:35:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:35:58 INFO - Using env: {'DISPLAY': ':0', 09:35:58 INFO - 'HOME': '/home/cltbld', 09:35:58 INFO - 'LANG': 'en_US.UTF-8', 09:35:58 INFO - 'LANGUAGE': 'en_US:en', 09:35:58 INFO - 'LOGNAME': 'cltbld', 09:35:58 INFO - 'MAIL': '/var/mail/cltbld', 09:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:58 INFO - 'MOZ_NO_REMOTE': '1', 09:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:35:58 INFO - 'NO_EM_RESTART': '1', 09:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:35:58 INFO - 'PWD': '/builds/slave/test-pgo', 09:35:58 INFO - 'SHELL': '/bin/bash', 09:35:58 INFO - 'SHLVL': '1', 09:35:58 INFO - 'TERM': 'linux', 09:35:58 INFO - 'TMOUT': '86400', 09:35:58 INFO - 'USER': 'cltbld', 09:35:58 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:58 INFO - '_': '/tools/buildbot/bin/python'} 09:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:36:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:36:00 INFO - Installing collected packages: mozsystemmonitor 09:36:00 INFO - Running setup.py install for mozsystemmonitor 09:36:00 INFO - Successfully installed mozsystemmonitor 09:36:00 INFO - Cleaning up... 09:36:00 INFO - Return code: 0 09:36:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:00 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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 09:36:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:36:00 INFO - Using env: {'DISPLAY': ':0', 09:36:00 INFO - 'HOME': '/home/cltbld', 09:36:00 INFO - 'LANG': 'en_US.UTF-8', 09:36:00 INFO - 'LANGUAGE': 'en_US:en', 09:36:00 INFO - 'LOGNAME': 'cltbld', 09:36:00 INFO - 'MAIL': '/var/mail/cltbld', 09:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:00 INFO - 'MOZ_NO_REMOTE': '1', 09:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:00 INFO - 'NO_EM_RESTART': '1', 09:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:00 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:00 INFO - 'SHELL': '/bin/bash', 09:36:00 INFO - 'SHLVL': '1', 09:36:00 INFO - 'TERM': 'linux', 09:36:00 INFO - 'TMOUT': '86400', 09:36:00 INFO - 'USER': 'cltbld', 09:36:00 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:00 INFO - '_': '/tools/buildbot/bin/python'} 09:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:36:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:02 INFO - Downloading docopt-0.6.1.tar.gz 09:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:02 INFO - Running setup.py install for blobuploader 09:36:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:36:03 INFO - Running setup.py install for requests 09:36:03 INFO - Running setup.py install for docopt 09:36:03 INFO - Successfully installed blobuploader requests docopt 09:36:03 INFO - Cleaning up... 09:36:03 INFO - Return code: 0 09:36:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:03 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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:36:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:03 INFO - Using env: {'DISPLAY': ':0', 09:36:03 INFO - 'HOME': '/home/cltbld', 09:36:03 INFO - 'LANG': 'en_US.UTF-8', 09:36:03 INFO - 'LANGUAGE': 'en_US:en', 09:36:03 INFO - 'LOGNAME': 'cltbld', 09:36:03 INFO - 'MAIL': '/var/mail/cltbld', 09:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:03 INFO - 'MOZ_NO_REMOTE': '1', 09:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:03 INFO - 'NO_EM_RESTART': '1', 09:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:03 INFO - 'SHELL': '/bin/bash', 09:36:03 INFO - 'SHLVL': '1', 09:36:03 INFO - 'TERM': 'linux', 09:36:03 INFO - 'TMOUT': '86400', 09:36:03 INFO - 'USER': 'cltbld', 09:36:03 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:03 INFO - '_': '/tools/buildbot/bin/python'} 09:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:03 INFO - Running setup.py (path:/tmp/pip-PFnOq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:03 INFO - Running setup.py (path:/tmp/pip-DT_Esv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:03 INFO - Running setup.py (path:/tmp/pip-uwDnMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:03 INFO - Running setup.py (path:/tmp/pip-pDp1Dv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:04 INFO - Running setup.py (path:/tmp/pip-Yb672l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:04 INFO - Running setup.py (path:/tmp/pip-lkF0ac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:04 INFO - Running setup.py (path:/tmp/pip-BhQR05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:04 INFO - Running setup.py (path:/tmp/pip-fJq6Pe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:04 INFO - Running setup.py (path:/tmp/pip-fvlcE8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:04 INFO - Running setup.py (path:/tmp/pip-PzX1GM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:04 INFO - Running setup.py (path:/tmp/pip-wFamYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:04 INFO - Running setup.py (path:/tmp/pip-y70HWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:04 INFO - Running setup.py (path:/tmp/pip-ZsWxpr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:04 INFO - Running setup.py (path:/tmp/pip-BN8e8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:04 INFO - Running setup.py (path:/tmp/pip-QaeF5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:04 INFO - Running setup.py (path:/tmp/pip-flQvzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:04 INFO - Running setup.py (path:/tmp/pip-00yAps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:04 INFO - Running setup.py install for manifestparser 09:36:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozcrash 09:36:05 INFO - Running setup.py install for mozdebug 09:36:05 INFO - Running setup.py install for mozdevice 09:36:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozfile 09:36:05 INFO - Running setup.py install for mozhttpd 09:36:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozinfo 09:36:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozInstall 09:36:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for mozleak 09:36:05 INFO - Running setup.py install for mozlog 09:36:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:36:05 INFO - Running setup.py install for moznetwork 09:36:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozprocess 09:36:06 INFO - Running setup.py install for mozprofile 09:36:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozrunner 09:36:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Running setup.py install for mozscreenshot 09:36:06 INFO - Running setup.py install for moztest 09:36:06 INFO - Running setup.py install for mozversion 09:36:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:36:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:06 INFO - Cleaning up... 09:36:06 INFO - Return code: 0 09:36:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 09:36:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:06 INFO - Using env: {'DISPLAY': ':0', 09:36:06 INFO - 'HOME': '/home/cltbld', 09:36:06 INFO - 'LANG': 'en_US.UTF-8', 09:36:06 INFO - 'LANGUAGE': 'en_US:en', 09:36:06 INFO - 'LOGNAME': 'cltbld', 09:36:06 INFO - 'MAIL': '/var/mail/cltbld', 09:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:06 INFO - 'MOZ_NO_REMOTE': '1', 09:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:06 INFO - 'NO_EM_RESTART': '1', 09:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:06 INFO - 'SHELL': '/bin/bash', 09:36:06 INFO - 'SHLVL': '1', 09:36:06 INFO - 'TERM': 'linux', 09:36:06 INFO - 'TMOUT': '86400', 09:36:06 INFO - 'USER': 'cltbld', 09:36:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:06 INFO - '_': '/tools/buildbot/bin/python'} 09:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:06 INFO - Running setup.py (path:/tmp/pip-ZVHRv6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:07 INFO - Running setup.py (path:/tmp/pip-006yBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:07 INFO - Running setup.py (path:/tmp/pip-nzMnUM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:07 INFO - Running setup.py (path:/tmp/pip-px6EH1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:07 INFO - Running setup.py (path:/tmp/pip-P01L73-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:07 INFO - Running setup.py (path:/tmp/pip-Fj9gSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:07 INFO - Running setup.py (path:/tmp/pip-3yaDqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:07 INFO - Running setup.py (path:/tmp/pip-D8dXId-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:07 INFO - Running setup.py (path:/tmp/pip-OuFa15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:07 INFO - Running setup.py (path:/tmp/pip-Msf1vl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:07 INFO - Running setup.py (path:/tmp/pip-SFGNWu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:07 INFO - Running setup.py (path:/tmp/pip-tObEcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:07 INFO - Running setup.py (path:/tmp/pip-aLsfbC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:36:07 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)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:07 INFO - Running setup.py (path:/tmp/pip-f848nF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:36:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:07 INFO - Running setup.py (path:/tmp/pip-fgYJ0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:08 INFO - Running setup.py (path:/tmp/pip-GMnrtJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:08 INFO - Running setup.py (path:/tmp/pip-26PfhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:36:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:09 INFO - Downloading blessings-1.5.1.tar.gz 09:36:09 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:36:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:09 INFO - Installing collected packages: blessings 09:36:09 INFO - Running setup.py install for blessings 09:36:10 INFO - Successfully installed blessings 09:36:10 INFO - Cleaning up... 09:36:10 INFO - Return code: 0 09:36:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:36:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:10 INFO - Reading from file tmpfile_stdout 09:36:10 INFO - Current package versions: 09:36:10 INFO - argparse == 1.2.1 09:36:10 INFO - blessings == 1.5.1 09:36:10 INFO - blobuploader == 1.2.4 09:36:10 INFO - docopt == 0.6.1 09:36:10 INFO - manifestparser == 1.1 09:36:10 INFO - mozInstall == 1.12 09:36:10 INFO - mozcrash == 0.16 09:36:10 INFO - mozdebug == 0.1 09:36:10 INFO - mozdevice == 0.47 09:36:10 INFO - mozfile == 1.2 09:36:10 INFO - mozhttpd == 0.7 09:36:10 INFO - mozinfo == 0.9 09:36:10 INFO - mozleak == 0.1 09:36:10 INFO - mozlog == 3.0 09:36:10 INFO - moznetwork == 0.27 09:36:10 INFO - mozprocess == 0.22 09:36:10 INFO - mozprofile == 0.27 09:36:10 INFO - mozrunner == 6.11 09:36:10 INFO - mozscreenshot == 0.1 09:36:10 INFO - mozsystemmonitor == 0.0 09:36:10 INFO - moztest == 0.7 09:36:10 INFO - mozversion == 1.4 09:36:10 INFO - psutil == 3.1.1 09:36:10 INFO - requests == 1.2.3 09:36:10 INFO - wsgiref == 0.1.2 09:36:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:10 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 0x7fe234af0c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfc6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:36:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 09:36:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:36:10 INFO - Using env: {'DISPLAY': ':0', 09:36:10 INFO - 'HOME': '/home/cltbld', 09:36:10 INFO - 'LANG': 'en_US.UTF-8', 09:36:10 INFO - 'LANGUAGE': 'en_US:en', 09:36:10 INFO - 'LOGNAME': 'cltbld', 09:36:10 INFO - 'MAIL': '/var/mail/cltbld', 09:36:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:10 INFO - 'MOZ_NO_REMOTE': '1', 09:36:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:10 INFO - 'NO_EM_RESTART': '1', 09:36:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:10 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:10 INFO - 'SHELL': '/bin/bash', 09:36:10 INFO - 'SHLVL': '1', 09:36:10 INFO - 'TERM': 'linux', 09:36:10 INFO - 'TMOUT': '86400', 09:36:10 INFO - 'USER': 'cltbld', 09:36:10 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:36:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:10 INFO - '_': '/tools/buildbot/bin/python'} 09:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 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)) 09:36:10 INFO - Cleaning up... 09:36:10 INFO - Return code: 0 09:36:10 INFO - Running post-action listener: _resource_record_post_action 09:36:10 INFO - Running post-action listener: _start_resource_monitoring 09:36:10 INFO - Starting resource monitoring. 09:36:10 INFO - ##### 09:36:10 INFO - ##### Running install step. 09:36:10 INFO - ##### 09:36:10 INFO - Running pre-action listener: _resource_record_pre_action 09:36:10 INFO - Running main action method: install 09:36:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:36:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:36:10 INFO - Reading from file tmpfile_stdout 09:36:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:36:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:36:10 INFO - Reading from file tmpfile_stdout 09:36:10 INFO - Output received: 09:36:10 INFO - Usage: mozinstall [options] installer 09:36:10 INFO - Options: 09:36:10 INFO - -h, --help show this help message and exit 09:36:10 INFO - -d DEST, --destination=DEST 09:36:10 INFO - Directory to install application into. [default: 09:36:10 INFO - "/builds/slave/test-pgo"] 09:36:10 INFO - --app=APP Application being installed. [default: firefox] 09:36:10 INFO - mkdir: /builds/slave/test-pgo/build/application 09:36:10 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'] 09:36:10 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 09:36:25 INFO - Reading from file tmpfile_stdout 09:36:25 INFO - Output received: 09:36:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:36:25 INFO - Running post-action listener: _resource_record_post_action 09:36:25 INFO - ##### 09:36:25 INFO - ##### Running run-tests step. 09:36:25 INFO - ##### 09:36:25 INFO - Running pre-action listener: _resource_record_pre_action 09:36:25 INFO - Running main action method: run_tests 09:36:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:36:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:36:25 INFO - Python 2.7.3 09:36:25 INFO - Return code: 0 09:36:25 INFO - grabbing minidump binary from tooltool 09:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:36:25 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 0x1d468c0>, '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 0x1cf3420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf38b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:36:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:36:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:36:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:25 INFO - Return code: 0 09:36:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:36:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:36:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:36:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:36:25 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:36:25 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 09:36:25 INFO - Using env: {'DISPLAY': ':0', 09:36:25 INFO - 'HOME': '/home/cltbld', 09:36:25 INFO - 'LANG': 'en_US.UTF-8', 09:36:25 INFO - 'LANGUAGE': 'en_US:en', 09:36:25 INFO - 'LOGNAME': 'cltbld', 09:36:25 INFO - 'MAIL': '/var/mail/cltbld', 09:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:25 INFO - 'MOZ_NO_REMOTE': '1', 09:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:36:25 INFO - 'NO_EM_RESTART': '1', 09:36:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:36:25 INFO - 'PWD': '/builds/slave/test-pgo', 09:36:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:36:25 INFO - 'SHELL': '/bin/bash', 09:36:25 INFO - 'SHLVL': '1', 09:36:25 INFO - 'TERM': 'linux', 09:36:25 INFO - 'TMOUT': '86400', 09:36:25 INFO - 'USER': 'cltbld', 09:36:25 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124', 09:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:25 INFO - '_': '/tools/buildbot/bin/python'} 09:36:25 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/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 09:36:25 INFO - mozversion INFO | application_buildid: 20151117073331 09:36:25 INFO - mozversion INFO | application_changeset: f3eb66d21d1ca1e9b140a3052dda40717358562b 09:36:25 INFO - mozversion INFO | application_display_name: Nightly 09:36:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:25 INFO - mozversion INFO | application_name: Firefox 09:36:25 INFO - mozversion INFO | application_remotingname: firefox 09:36:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:25 INFO - mozversion INFO | application_vendor: Mozilla 09:36:25 INFO - mozversion INFO | application_version: 45.0a1 09:36:25 INFO - mozversion INFO | platform_buildid: 20151117073331 09:36:25 INFO - mozversion INFO | platform_changeset: f3eb66d21d1ca1e9b140a3052dda40717358562b 09:36:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:36:25 INFO - mozversion INFO | platform_version: 45.0a1 09:36:25 INFO - 2015-11-17 09:36:25,469 DEBUG : using testdate: 1447781785 09:36:25 INFO - 2015-11-17 09:36:25,469 DEBUG : actual date: 1447781785 09:36:25 INFO - 2015-11-17 09:36:25,558 INFO : starting webserver on 'localhost:33343' 09:36:25 INFO - 2015-11-17 09:36:25,559 INFO : Starting test suite talos-linux64-ix-011 09:36:25 INFO - 2015-11-17 09:36:25,559 INFO : Starting test dromaeo_css 09:36:25 INFO - 2015-11-17 09:36:25,559 DEBUG : operating with platform_type : linux_ 09:36:25 INFO - 2015-11-17 09:36:25,560 INFO : Initialising browser for dromaeo_css test... 09:36:25 INFO - 2015-11-17 09:36:25,572 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6cjm25/profile http://localhost:33343/getInfo.html 09:36:31 INFO - 2015-11-17 09:36:31,096 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:36:31 INFO - 2015-11-17 09:36:31,096 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:36:31 INFO - 2015-11-17 09:36:31,096 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:36:31 INFO - 2015-11-17 09:36:31,097 DEBUG : BROWSER_OUTPUT: __metrics 09:36:31 INFO - 2015-11-17 09:36:31,239 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:32 INFO - 2015-11-17 09:36:32,493 INFO : Browser initialized. 09:36:32 INFO - 2015-11-17 09:36:32,494 INFO : Running cycle 1/1 for dromaeo_css test... 09:36:32 INFO - 2015-11-17 09:36:32,494 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6cjm25/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:36:44 INFO - 2015-11-17 09:36:44,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 139845632 09:36:44 INFO - 2015-11-17 09:36:44,278 DEBUG : BROWSER_OUTPUT: 09:37:34 INFO - 2015-11-17 09:37:34,970 DEBUG : BROWSER_OUTPUT: 1447781854968 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:39:44 INFO - 2015-11-17 09:39:44,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33343/tests/dromaeo/cssquery-ext.html) 09:39:45 INFO - 2015-11-17 09:39:45,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 235122688 09:39:45 INFO - 2015-11-17 09:39:45,580 DEBUG : BROWSER_OUTPUT: 09:42:47 INFO - 2015-11-17 09:42:47,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-ext.html (next: http://localhost:33343/tests/dromaeo/cssquery-jquery.html) 09:42:48 INFO - 2015-11-17 09:42:48,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 219361280 09:42:48 INFO - 2015-11-17 09:42:48,480 DEBUG : BROWSER_OUTPUT: 09:45:50 INFO - 2015-11-17 09:45:50,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33343/tests/dromaeo/cssquery-mootools.html) 09:45:50 INFO - 2015-11-17 09:45:50,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 207175680 09:45:50 INFO - 2015-11-17 09:45:50,901 DEBUG : BROWSER_OUTPUT: 09:48:52 INFO - 2015-11-17 09:48:52,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33343/tests/dromaeo/cssquery-prototype.html) 09:48:53 INFO - 2015-11-17 09:48:53,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 195977216 09:48:53 INFO - 2015-11-17 09:48:53,295 DEBUG : BROWSER_OUTPUT: 09:51:55 INFO - 2015-11-17 09:51:55,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33343/tests/dromaeo/cssquery-yui.html) 09:51:56 INFO - 2015-11-17 09:51:56,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 197906432 09:51:56 INFO - 2015-11-17 09:51:56,437 DEBUG : BROWSER_OUTPUT: 09:54:58 INFO - 2015-11-17 09:54:58,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/dromaeo/cssquery-yui.html (next: http://localhost:33343/tests/dromaeo/cssquery-dojo.html) 09:54:59 INFO - 2015-11-17 09:54:59,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 288645120 09:54:59 INFO - 2015-11-17 09:54:59,160 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,160 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:54:59 INFO - 2015-11-17 09:54:59,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:54:59 INFO - 2015-11-17 09:54:59,161 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:54:59 INFO - 2015-11-17 09:54:59,161 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:54:59 INFO - 2015-11-17 09:54:59,164 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3183.6816318368165;3297.802131872086;3325.467925131978;3336.0825772912463;3351.480520519319;5205.739713014353;5299.788008479666;5461.508464238218;5517.972410137949;5525.336959564847;5348.010618035656;5358.758855851486;5390.6226564140525;5403.78384864606;5404;4985.1774457214515;4994.525520075587;5052.343195384595;5136.58907287418;5147.330846989886;4823.445303790057;5036.7733451994745;5090.669106508065;5123.077845987721;5130.02529519392;4796.208625576775;4881;4896.167651499253;4903.338049363361;4966.503349665023;4977.104121258172;5002.1746411842005;5002.59979201663;5026.321446604735;5042.294078828967;4897.461279259279;4981.37732783402;5005.224190250517;5023.8492845214705;5052.949470505285;5172.793088276464;5309.256704061435;5310.362756469249;5311.814086506954;5318.6542874713405;5823.88352232953;5827.621204621686;5831.446012628793;5833.06670932653;5864.5894787364905;5744.253247077895;5795.971020144872;5902.3507414184405;5904.350521442638;5938.406159384071;5532.336119665666;5534.1975413564805;5534.944650553443;5541.473560011793;5561.888762224733;6000.189974353494;6016.69916504173;6022.036474164201;6022.668753218528;6029.035354343284;5683.602147849693;5727.914081288784;5830.183774271605;5848.853778655568;5855.970720146457;5830.650160990354;5836.474717275466;5849.532037436995;5854.385289544622;5912.704364781744;5850.12248162779;5852.531797456193;5854.7072646367515;5861.824145275648;5869.295684517885;5711.514521265739;5800.9129863052085;5835.037218858925;5896.056630939029;5935.643861368331;4607.976960115178;4612.561806628365;4614.377059097046;4616.099860527165;4652.371929789503;3964.6035396460125;4076.673866090706;4080.8775736727944;4087.509498860156;4110.630043296118;5429.239906413105;5574.470425309589;5598.384177740445;5626.690532020696;5668.659880407189;5970.552208584373;5980.910286345708;5982;5983.222181116427;5984.970075149597;5418.566514678816;5523.199136125239;5623.437656234344;5625.071863142617;5629.7185140742795;5075.847724568269;5124;5148.922766158511;5151.150060240094;5187.118189907725;5890.204822349014;5898.4101589840675;5898.941010589925;5900.940990590125;6094.8171554853425;5730;5773.076307790733;5800.506956908541;5852.326982397079;5853.619514731528;6108.190302030417;6246.3753624637175;6258.43674069336;6262.2172228471445;6262.342454042442;5937.910931335947;5950.16697662319;5953.76184952597;5956.195913551615;6011.6693581853415;5679.6024278301775;5785.074388097884;5905.704714764331;6048.425399587032;6063.423974722395;5828.446297601721;5835.2122463466885;5844.561657875592;5845.736941837713;5889.469947704727;5784.94215057844;5799.971000144972;5830.183774271521;5833.445822646841;5833.708314584169;5542.75057622416;5634.718264086861;5662.433756624305;5699.316082070178;5731.799387021434;5739.684317362418;5744.741486633028;5758.366579676316;5806.187133801355;5809.883802323845;5613.719314034363;5618.943810561842;5624.550035997028;5630.0428927081675;5643.576731745054 09:54:59 INFO - 2015-11-17 09:54:59,164 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.3188446326557;582.7901955296093;591.2402562706919;591.9052951527757;601.2694576090049;31001.534976975363;32330.838345808268;39022.609773902215;39730.801345993226;39750.60249397505;43774.78112609441;44136.117277654426;44149.55850441495;44262.336064959054;44293.33559996603;7552.924470755277;7694.384449244047;8641.481511109354;8807.295416366675;8823.823523529525;10477.738056548571;10792.46037698112;10808.675739727782;10809.83785243222;10825.350478971286;10410.63562775303;10466.947665261663;10505.212109091848;10550.47247637615;10577.894221057768;10400;10405.53175107122;10475.738106547322;10511.526981285822;10534.525946332433;10252.58989640421;10390.168786497137;10392.532336044897;10403.47982600867;10414.947925260325;39785;40264.396034059515;40279.19441611181;40282;40298.395524067164;3178.9364212715845;3184.41088398647;3230.402375560529;3350.995416465944;3999.5000624921886;29983.550246746316;30529;30648.2337941551;30695.232619184477;30735;3205.4710972689713;3366.6969972702327;3373.6088083158656;3376.2572234108457;3548.574171099459;263107;263662;264440;264884;266128;52594.737026315386;60753.39246607477;60959.39040609626;61018.38981610127;61140.694296528236;48664.51335486671;48813.26780098301;48835.267470987965;48941.51058489441;66144.66927665331;15674.843251567567;15902;15967.680646387007;15993.44022959214;16053.19734013318;12129.5148194073;12265.816012759815;12274.877251227374;12275.38623068843;12284.324362159989;17897.19462624185;18318.267269309345;20189.394318170478;20680.276190333265;21521;8222.218889205516;8341.874871876928;8360.916390836013;8393.24460798531;8447.45091569046;911.2026976395654;974.5858010345717;976.1946394224793;983.8671779309844;984.084801134937;28859.855700721782;28992.710072899423;29115.126546203646;29589.26026849346;29728.702712973027;1068.5832525315134;1073.393532654048;1112.2881355932209;1155.942202889852;1218.9817152742717;15030.549083527512;15069.849301506845;15218;15399.769003464957;15454.768178477332;328417;329035;332198;334185;334977;45302.32046519305;54384;54724.179137312974;54846.72576637171;54885.1767223492;1210.038019774264;1329.1028555724847;1337.4315915735967;1342.1812694256496;1343.1269674711516;28047;28943.710562894103;29134.27164320909;29477.410451790416;29789.404211915207;43605.56394436015;44165.337519936584;44860.102797943204;45322;49114.50885491099;257839;261907;262409;263049;263297;33264;33306.500402494465;33497.49753753744;33499.16252093717;33709.83145084259;43962.34056489219;44664.55335446604;44915.32627010663;45219;45337;37374.252514950094;37408.251834963696;38534;38908.80545597254;38961;37605.623943761304;38814.41778373383;38933.80533097316;39974.40038399484;43817.561824382625;38704.80647596744;39150.80424597859;39560.40659390169;39737.40393894036;40393.79803101083;31915.36169276555;32448;33969.49045764365;34775.826120869235;38062.42906356351;25633.933608590854;25770.226893193234;25808.35479112962;26162.476750465266;26245.475090498465 09:54:59 INFO - 2015-11-17 09:54:59,166 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.4190369697393;360.26505927907067;362.7932078715133;363.09408026972693;364.3805530597984;14586.12483251003;14608.707825843503;16797.66404671906;17230.655386892253;17811.64376712465;11540.249883757571;11882.821757673642;16955.406560770374;17368.957862528227;17377.13114344284;4502.4371953505815;4662.953370466286;4666.813327466914;4668.416447944007;4668.692766025519;3559.75081744278;3661.9267614647692;4644.5123262057505;4650.930236046462;4939.654224204307;5040.672356296847;5063.898722025558;5078.923816142761;5087.669301495391;5118.257852611369;4957.479464656213;5080;5085.211792172219;5140.511651393112;5153.871153221162;4449.488308844492;4452.977735111336;4458.8439404621;4460.598546130831;4462.397576327219;14310.356033978496;14381.568552943429;14617.926910365486;14672.413103475848;14697.412103515846;1806.7922188948307;1937.5834195648004;2069.3067822279404;2088.3004193595166;2116.534362440261;10093.495325233709;10095;10358.585656573729;10422.21833362501;10469.738256543571;1921.1738952250528;1963.1754663041413;1979.1786408640396;1997.0813425824138;2019.8283145932467;60431.69784151095;60539.39460605426;60596;60989.695051524905;61450.38549614491;14977.251137443302;15345.769813452807;15946.681066378607;16040.75938860918;16058.197090145446;23717.407064823172;23772.7622723774;23954.442961207813;24134.87932560326;24185.15351962673;8855.468671879707;9497.90502094984;9501.144896959308;9552.331336806357;9592.376495527908;8268.83462330762;8310.792230194173;8346;8379.078301386842;8392.412531122885;7878.369730421553;8019.9198008019175;8024.395120975828;8044.718434854752;8048.798780030429;1188.423614546944;2120.130746393971;3033.8179709217516;3124.9687503125133;3300.5709257796334;466.30287719858353;469.27497017108647;475.34639870178506;509.8757240285236;519.2652396858479;11834.585789497498;12184.268943863397;12490.562830300896;12546.435410406371;12603.117781755189;475.5149747257778;482.8454894433818;488.3529323646112;498.1332481482195;512.9948700513022;6373.617582944946;6646.86706265872;6676.0987266718375;6716.7984960450285;6728.798136055926;469578;474929;485058;485220;568737;78310;78931.21068789353;80269;80586;80784.19215807885;548.4186762032259;548.5556699073763;549.9890002199934;550.8072174738809;552.257214047106;10350.948245258725;10509.842352364874;10558.31370960885;10590.788184236426;10820.675379738306;33873.3225335487;34350.82824585961;34756.82621586977;35111.12222194363;36807.26385472329;48213.276800847314;48741;50967;51060.744696276284;51107;14918.552443426715;14947.925260373628;14975.1014939104;14990.625234368792;15377.846221537642;19039.428817135507;19221;19335.8066419334;19435;19696.60606787885;9794.510274486389;16040.43858464948;16191.67616647684;16381.590460238589;16389.262483188522;10269.537870795682;10467.162626989975;10534.367937923442;10651.786964260826;10855.945720271347;10257.692269231935;10555.419451930218;10711.303765255234;10735.194860385658;10776.191785615953;14537.781933270799;14678.266086695836;14703.3383497745;14969.40122395092;15248.542543723706;14734.705305894036;15025.699486010437;15055.774163387778;15557.611059723598;15610.375584976928 09:54:59 INFO - 2015-11-17 09:54:59,167 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.8610138986096;1747.2050217151198;1781.0649409060243;1813.7460755494228;1815.3918437323487;6700.3299670032975;7403.296686814758;7500;7508.324250817425;7512.361449276818;7710.92289077109;7819.726309579166;7838.25536574026;7842.098158711749;7845.254700803429;1969.1827891425041;2003.5692326149874;2005.5688027074177;2255.1317742669107;2282.3038973113194;2064.9690254646193;2249.336445748508;2291.4385975436044;2292.7821856923565;2292.805111565519;2179.727534058243;2192.572448372568;2203.867767933921;2249.3701763506247;2250.6849041134255;1984.0972357577411;2037.74528183977;2228.008536201391;2250.5948929192737;2252.2454977582447;2259.514204446052;2294.7590502997277;2294.7705229477087;2295.5294164696197;2298.770122987705;7719.228077192236;7853.136155022943;7854.528728276265;7860.803479913048;7861.095973963011;4602.815887364502;4710.976445117787;4712.198926182557;4722.386089808303;4724.220503616899;2951.2326795033446;3118.781685282031;3124.9531257031163;3135.905922822319;3136.07485791692;986.5166068626393;990.9653162139291;996.8803743550748;1014.604304321308;1024.482636268687;11087.445627718582;11089.112870970303;11089.889101109047;11090.057345125673;11109.166812489015;4213.157368526307;4261.722988005769;4290.570942905747;4303.4190384298345;4340.934885976713;9262.259019278441;9278.304127190488;9280;9292;9293.767655808659;4738.1708201064675;4758.3100450434495;4758.714477131383;4758.833440829554;4760.190767569521;4327.891802704895;4337.1976184405985;4337.934930976038;4339.544347843431;4340.370646256339;3727.7017838572847;3733.1227161617;3743.756655817363;3754.685859948996;3800.2969450651717;1219.116140797932;1233.7100781316383;1237.5915947737226;1240.7890658588062;1249.881261280177;982.474376208725;1004.7889943112028;1007.0734923870057;1125.8254970479588;1373.2790285100402;7383.483156179016;7385.409167266714;7408.222136675679;7418.517796343221;7459.515131516434;509.9235114732746;517.6014468858957;521.5254118751917;524.1639584862139;524.6589716684109;5260.158374660036;5337.466253374631;5832.270966129234;5961.463468287789;6127.4485296322655;8584.828303433897;8641.265492433213;8754.606042728092;8762.518061506678;8775.166359195866;9057.592408341641;9062.773430664287;9067.909320906707;9164.6792362267;9217.216536594331;7184.892226616605;7191.244919283505;7203.675834587456;7205.207427183111;7215.783526494213;6999.440044796506;7092.645367731489;7100.254473280438;7101.680424381018;7108.502404831612;7802.063752349754;7901.525908445512;7956.602169891598;8114.472559283864;8142.18578142181;8033.19668033192;8183.754487365389;8870.379073464796;8945.642174312954;8947.239484643878;6622.304658011032;6629.204495460575;6690.83272918181;6709.295523969913;6723.865522689421;7619.466637335555;7659.348955338635;7671.846563068596;7675.04061992251;7677;7045.471589630901;7158.46311526648;7178.856422871618;7186.281371862772;7293.562386256842;6880.518363714492;6890.173179218526;7006.299370062953;7024;7178.533395329287;7114.786556403316;7170.856582868209;7177.7487787927175;7188.101487314086;7226.566406015656;6451.516136289703;6488.221413430229;6490.448311893542;6491;6491.610503369813;6711.0940023096255;6756.966215168893;6774.187097548326;6777.762778302736;6780.830479238059 09:54:59 INFO - 2015-11-17 09:54:59,168 DEBUG : BROWSER_OUTPUT: |4;prototype.html;341.75905986279673;344.3869911557428;353.108401286751;353.6269235956065;357.7442128877852;5835.737391817368;5928.525717942565;5961.672108034057;6025.548083893709;6051.152838602588;5788.102844059177;5903.822885313437;5911.645301281927;5958.165856780054;6010.669413182273;4661.673682842185;4668.25307950728;4674.08855273221;4676;4703.200455922484;4457.1977044132045;4667.06658668266;4675.929861052087;4678.695884767496;4681.953180468203;4542.750148741818;4542.818287268522;4597.08058388322;4600.97699511502;4660.883477913046;4608.262677971508;4610.5850473457385;4626.537346265381;4639.188142075157;4645.210314246586;4106.917861642781;4108.589141085898;4110.383442483621;4112.321466957948;4116.259073366793;5552.888942221173;5665.461781130786;5677.233573467571;5677.914831277534;5683.715814209273;5399.082156033444;5403.2705584746345;5403.4866687665;5404.621676482648;5404.729763511808;6373.139626150503;6378.649174295412;6384;6384.170057892445;6385.96807015962;4534.86395408135;4537.931931021038;4543.204939135638;4550.408446901882;4551.40831691878;6466.515011374118;6496.740130394778;6580.506462015368;6584.86830263392;6589.80230593083;4620.353150558924;4649.790759415834;4651.930221046687;4657.580817726421;4663.27719203524;4687.1328804171335;4728.290756386501;4729.125111854318;4731.810727570927;4733.219018861918;5379.54273886724;5385.892282154335;5387.595930305243;5391.406945236021;5396.082665946798;6265.342139075423;6408.967955160194;6409.647469389229;6414;6414.230292364853;1642.2199455258894;1672.3645014894262;1673.8660907127644;1676.1786724504905;1676.9077700726334;1130.7229728716518;1139.7264656482384;1149.3219000789575;1151.7293436042523;1174.0783484964263;6188.628682279078;6190.783322583778;6198.256209254918;6203.844903877349;6207.81376558704;6353.078803573456;6519.185101862267;6584.8024559263295;6589.538732288694;6593.40659340652;6121.877562448726;6151.907721384183;6266.122742816009;6275.529335299871;6278.6860656966965;3529.0647978285774;3586.444101164324;3589.6769290763955;3590.3537363274863;3593.9281214375565;6634.933650663528;6799.5920244785475;6799.626020568818;6804.489663275175;6806.727730890808;6702.229243636946;6792.864142717217;6799.93200067993;6800.489963252776;6801.965990170116;6799.626020568916;6804.489663275274;6844.691988860513;6846.691898864563;6852.177738671391;6527.02094685801;6548.345165483413;6618.0403841443685;6619.3380661933425;6620.668966551557;6590.340965903371;6593.175853018372;6594.571352862049;6596.142501474777;6596.60420374779;6851.314868513109;6898.413634841095;6902;6908;6909.723611055501;4413.293872980308;4442;4443.955560444354;4445.2887537993765;4446.42196514464;6503.837404064936;6660.034295027097;6681.331866813474;6682.097916781367;6685.966570167118;6483.384078512534;6487.740490380521;6491.415772580491;6497.090407342881;6500.739970401131;6253.530985176221;6476.740930362921;6483.967580162069;6486.124373209556;6487.837804054936;6306.432421082125;6313.43179113882;6330.620162790247;6348.111264423077;6352.587081839665;6497.642629655225;6501.869962600627;6502.544821862424;6505.447037001908;6511.511636627367;6155.599886007395;6274.278457977209;6286.339934307015;6328.177336946167;6344.238691356882 09:54:59 INFO - 2015-11-17 09:54:59,168 DEBUG : BROWSER_OUTPUT: |5;yui.html;830.323286521485;849.4181485682308;856.9571521423927;860.7030574451813;866.4627930682974;13550.932245338772;15844.84155158448;16299.592510187236;16304.103274319938;16344.34622615097;14423.495177668783;14511.274436278196;14516;14527.564173074825;14539.636509087279;679.5277282288811;689.7344522358903;811.5658122904248;817.5299202958294;818.0919179710517;807.4670717326566;823.736404350608;825.7027470110785;825.9050209225956;831.031847897199;861.4056301152216;869.7086476030537;869.7869022089596;869.9130086991313;870.6082262981683;708.7519368221133;715.9319864612879;845.868890321995;860.8278344331128;861.4228466927174;626.8840264551072;628.1425853709699;630.4515071887441;630.6562923206864;631.8767840271149;13069.477220911247;13267.668308292274;13274.004449666314;13279.601611951657;13287.335633218301;9989.350692204984;10334.22493312997;10504.684859454228;10668.893311066868;11068.557257709683;9983.351082179635;10105.89894101057;10145.746356341077;10206.693799186036;10518.211134164892;3215.469447541153;3264.412405766961;3278.1476816027766;3287.4575695010294;3357.0600231935096;45542;45568.3164752529;45578.31632525548;45652.31521527147;45689.31466028012;7337.88993165103;7529.4729368944745;7606.961965190249;7681;7721.189275126143;11973.760524789455;12009.339486328161;12014.098942579341;12023.098267629963;12121.151519393557;6328.557001009885;6413.839654008594;6488.967555162194;6541.247756507967;6608.86782264352;3970.3250447424007;4020.0954785173103;4073.246449406869;4081.10215752534;4100.7334523255895;2736.138116493298;2761.792865535093;2761.9723802761714;2763.6545431821023;2767.4465106978687;430.487719613665;431.58136607490684;434.30944797771065;439.7823077576556;439.83945859760956;638.2691817868607;650.6096342194645;659.3044338223125;668.2649086005355;691.1257259566552;7985.321247694011;8031.718889838828;8120.472169308976;8145.959270203611;8235.711750088718;480.5146801730278;610.5542953643865;627.1470799712388;647.5467172978933;656.3829999800269;3831.8658846940225;3901.297766402075;3920.2747491714126;3978.2839088963688;4150;53693.194602081;53965.73017134889;54421.45578544243;57871.71064144652;60548.39451605516;48363.75818120887;48569.75715121402;50391.49608503941;52062.21906671403;52115.73942130265;50382.244266336034;51169;51890.48109518932;51978.740106299985;52181.217281740806;8332.000639693102;8419.915800841913;8459.61931713062;8794.20852123312;8804.295656347349;34144.48783268203;34558.82720586381;34971;35345.46981795224;35388.82305588559;45096.323555147355;45229.547704522534;45479.31781023354;47571.28643070426;47691;7906.802329941567;8310.418270720991;8322.70870519529;8451.28164106058;8452.492850428995;11183.832242516206;11625.59310424131;11714.121440891797;11823.940880295544;12085.697857553632;10807.407481436161;10840.728981775203;11198.776024479303;11216.158788091088;11691.415429228675;10756.300840445347;11044.392558409043;11061.834072488758;11237.381943992832;11540;10620.89379106199;10750.73123171927;10851.620193293196;11376;11397.373144477133;9120.133587309196;9246.907530924605;9302.813943721223;9399.859002114837;9667.661631842851;8420.5789710513;8828.42615230008;9207.953960230156;9361.906380936103;9743.366681165702 09:54:59 INFO - 2015-11-17 09:54:59,168 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:54:59 INFO - 2015-11-17 09:54:59,168 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:54:59 INFO - 2015-11-17 09:54:59,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,749 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: __startTimestamp1447782899159__endTimestamp 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5467.91 Median:5668.66 stddev:603.98 (10.7%) stddev-sans-first:578.64 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: Values: 3183.7 3297.8 3325.5 3336.1 3351.5 5205.7 5299.8 5461.5 5518.0 5525.3 5348.0 5358.8 5390.6 5403.8 5404.0 4985.2 4994.5 5052.3 5136.6 5147.3 4823.4 5036.8 5090.7 5123.1 5130.0 4796.2 4881.0 4896.2 4903.3 4966.5 4977.1 5002.2 5002.6 5026.3 5042.3 4897.5 4981.4 5005.2 5023.8 5052.9 5172.8 5309.3 5310.4 5311.8 5318.7 5823.9 5827.6 5831.4 5833.1 5864.6 5744.3 5796.0 5902.4 5904.4 5938.4 5532.3 5534.2 5534.9 5541.5 5561.9 6000.2 6016.7 6022.0 6022.7 6029.0 5683.6 5727.9 5830.2 5848.9 5856.0 5830.7 5836.5 5849.5 5854.4 5912.7 5850.1 5852.5 5854.7 5861.8 5869.3 5711.5 5800.9 5835.0 5896.1 5935.6 4608.0 4612.6 4614.4 4616.1 4652.4 3964.6 4076.7 4080.9 4087.5 4110.6 5429.2 5574.5 5598.4 5626.7 5668.7 5970.6 5980.9 5982.0 5983.2 5985.0 5418.6 5523.2 5623.4 5625.1 5629.7 5075.8 5124.0 5148.9 5151.2 5187.1 5890.2 5898.4 5898.9 5900.9 6094.8 5730.0 5773.1 5800.5 5852.3 5853.6 6108.2 6246.4 6258.4 6262.2 6262.3 5937.9 5950.2 5953.8 5956.2 6011.7 5679.6 5785.1 5905.7 6048.4 6063.4 5828.4 5835.2 5844.6 5845.7 5889.5 5784.9 5800.0 5830.2 5833.4 5833.7 5542.8 5634.7 5662.4 5699.3 5731.8 5739.7 5744.7 5758.4 5806.2 5809.9 5613.7 5618.9 5624.6 5630.0 5643.6 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46274.06 Median:182731.00 stddev:74995.16 (41.0%) stddev-sans-first:75126.95 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: Values: 549.3 582.8 591.2 591.9 601.3 31001.5 32330.8 39022.6 39730.8 39750.6 43774.8 44136.1 44149.6 44262.3 44293.3 7552.9 7694.4 8641.5 8807.3 8823.8 10477.7 10792.5 10808.7 10809.8 10825.4 10410.6 10466.9 10505.2 10550.5 10577.9 10400.0 10405.5 10475.7 10511.5 10534.5 10252.6 10390.2 10392.5 10403.5 10414.9 39785.0 40264.4 40279.2 40282.0 40298.4 3178.9 3184.4 3230.4 3351.0 3999.5 29983.6 30529.0 30648.2 30695.2 30735.0 3205.5 3366.7 3373.6 3376.3 3548.6 263107.0 263662.0 264440.0 264884.0 266128.0 52594.7 60753.4 60959.4 61018.4 61140.7 48664.5 48813.3 48835.3 48941.5 66144.7 15674.8 15902.0 15967.7 15993.4 16053.2 12129.5 12265.8 12274.9 12275.4 12284.3 17897.2 18318.3 20189.4 20680.3 21521.0 8222.2 8341.9 8360.9 8393.2 8447.5 911.2 974.6 976.2 983.9 984.1 28859.9 28992.7 29115.1 29589.3 29728.7 1068.6 1073.4 1112.3 1155.9 1219.0 15030.5 15069.8 15218.0 15399.8 15454.8 328417.0 329035.0 332198.0 334185.0 334977.0 45302.3 54384.0 54724.2 54846.7 54885.2 1210.0 1329.1 1337.4 1342.2 1343.1 28047.0 28943.7 29134.3 29477.4 29789.4 43605.6 44165.3 44860.1 45322.0 49114.5 257839.0 261907.0 262409.0 263049.0 263297.0 33264.0 33306.5 33497.5 33499.2 33709.8 43962.3 44664.6 44915.3 45219.0 45337.0 37374.3 37408.3 38534.0 38908.8 38961.0 37605.6 38814.4 38933.8 39974.4 43817.6 38704.8 39150.8 39560.4 39737.4 40393.8 31915.4 32448.0 33969.5 34775.8 38062.4 25633.9 25770.2 25808.4 26162.5 26245.5 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,170 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27937.02 Median:34553.83 stddev:81456.61 (235.7%) stddev-sans-first:81658.79 09:54:59 INFO - 2015-11-17 09:54:59,171 DEBUG : BROWSER_OUTPUT: Values: 356.4 360.3 362.8 363.1 364.4 14586.1 14608.7 16797.7 17230.7 17811.6 11540.2 11882.8 16955.4 17369.0 17377.1 4502.4 4663.0 4666.8 4668.4 4668.7 3559.8 3661.9 4644.5 4650.9 4939.7 5040.7 5063.9 5078.9 5087.7 5118.3 4957.5 5080.0 5085.2 5140.5 5153.9 4449.5 4453.0 4458.8 4460.6 4462.4 14310.4 14381.6 14617.9 14672.4 14697.4 1806.8 1937.6 2069.3 2088.3 2116.5 10093.5 10095.0 10358.6 10422.2 10469.7 1921.2 1963.2 1979.2 1997.1 2019.8 60431.7 60539.4 60596.0 60989.7 61450.4 14977.3 15345.8 15946.7 16040.8 16058.2 23717.4 23772.8 23954.4 24134.9 24185.2 8855.5 9497.9 9501.1 9552.3 9592.4 8268.8 8310.8 8346.0 8379.1 8392.4 7878.4 8019.9 8024.4 8044.7 8048.8 1188.4 2120.1 3033.8 3125.0 3300.6 466.3 469.3 475.3 509.9 519.3 11834.6 12184.3 12490.6 12546.4 12603.1 475.5 482.8 488.4 498.1 513.0 6373.6 6646.9 6676.1 6716.8 6728.8 469578.0 474929.0 485058.0 485220.0 568737.0 78310.0 78931.2 80269.0 80586.0 80784.2 548.4 548.6 550.0 550.8 552.3 10350.9 10509.8 10558.3 10590.8 10820.7 33873.3 34350.8 34756.8 35111.1 36807.3 48213.3 48741.0 50967.0 51060.7 51107.0 14918.6 14947.9 14975.1 14990.6 15377.8 19039.4 19221.0 19335.8 19435.0 19696.6 9794.5 16040.4 16191.7 16381.6 16389.3 10269.5 10467.2 10534.4 10651.8 10855.9 10257.7 10555.4 10711.3 10735.2 10776.2 14537.8 14678.3 14703.3 14969.4 15248.5 14734.7 15025.7 15055.8 15557.6 15610.4 09:54:59 INFO - 2015-11-17 09:54:59,171 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,171 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5431.42 Median:6556.96 stddev:2841.18 (43.3%) stddev-sans-first:2832.91 09:54:59 INFO - 2015-11-17 09:54:59,172 DEBUG : BROWSER_OUTPUT: Values: 1389.9 1747.2 1781.1 1813.7 1815.4 6700.3 7403.3 7500.0 7508.3 7512.4 7710.9 7819.7 7838.3 7842.1 7845.3 1969.2 2003.6 2005.6 2255.1 2282.3 2065.0 2249.3 2291.4 2292.8 2292.8 2179.7 2192.6 2203.9 2249.4 2250.7 1984.1 2037.7 2228.0 2250.6 2252.2 2259.5 2294.8 2294.8 2295.5 2298.8 7719.2 7853.1 7854.5 7860.8 7861.1 4602.8 4711.0 4712.2 4722.4 4724.2 2951.2 3118.8 3125.0 3135.9 3136.1 986.5 991.0 996.9 1014.6 1024.5 11087.4 11089.1 11089.9 11090.1 11109.2 4213.2 4261.7 4290.6 4303.4 4340.9 9262.3 9278.3 9280.0 9292.0 9293.8 4738.2 4758.3 4758.7 4758.8 4760.2 4327.9 4337.2 4337.9 4339.5 4340.4 3727.7 3733.1 3743.8 3754.7 3800.3 1219.1 1233.7 1237.6 1240.8 1249.9 982.5 1004.8 1007.1 1125.8 1373.3 7383.5 7385.4 7408.2 7418.5 7459.5 509.9 517.6 521.5 524.2 524.7 5260.2 5337.5 5832.3 5961.5 6127.4 8584.8 8641.3 8754.6 8762.5 8775.2 9057.6 9062.8 9067.9 9164.7 9217.2 7184.9 7191.2 7203.7 7205.2 7215.8 6999.4 7092.6 7100.3 7101.7 7108.5 7802.1 7901.5 7956.6 8114.5 8142.2 8033.2 8183.8 8870.4 8945.6 8947.2 6622.3 6629.2 6690.8 6709.3 6723.9 7619.5 7659.3 7671.8 7675.0 7677.0 7045.5 7158.5 7178.9 7186.3 7293.6 6880.5 6890.2 7006.3 7024.0 7178.5 7114.8 7170.9 7177.7 7188.1 7226.6 6451.5 6488.2 6490.4 6491.0 6491.6 6711.1 6757.0 6774.2 6777.8 6780.8 09:54:59 INFO - 2015-11-17 09:54:59,172 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,172 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5373.30 Median:6136.89 stddev:1599.49 (26.1%) stddev-sans-first:1558.75 09:54:59 INFO - 2015-11-17 09:54:59,172 DEBUG : BROWSER_OUTPUT: Values: 341.8 344.4 353.1 353.6 357.7 5835.7 5928.5 5961.7 6025.5 6051.2 5788.1 5903.8 5911.6 5958.2 6010.7 4661.7 4668.3 4674.1 4676.0 4703.2 4457.2 4667.1 4675.9 4678.7 4682.0 4542.8 4542.8 4597.1 4601.0 4660.9 4608.3 4610.6 4626.5 4639.2 4645.2 4106.9 4108.6 4110.4 4112.3 4116.3 5552.9 5665.5 5677.2 5677.9 5683.7 5399.1 5403.3 5403.5 5404.6 5404.7 6373.1 6378.6 6384.0 6384.2 6386.0 4534.9 4537.9 4543.2 4550.4 4551.4 6466.5 6496.7 6580.5 6584.9 6589.8 4620.4 4649.8 4651.9 4657.6 4663.3 4687.1 4728.3 4729.1 4731.8 4733.2 5379.5 5385.9 5387.6 5391.4 5396.1 6265.3 6409.0 6409.6 6414.0 6414.2 1642.2 1672.4 1673.9 1676.2 1676.9 1130.7 1139.7 1149.3 1151.7 1174.1 6188.6 6190.8 6198.3 6203.8 6207.8 6353.1 6519.2 6584.8 6589.5 6593.4 6121.9 6151.9 6266.1 6275.5 6278.7 3529.1 3586.4 3589.7 3590.4 3593.9 6634.9 6799.6 6799.6 6804.5 6806.7 6702.2 6792.9 6799.9 6800.5 6802.0 6799.6 6804.5 6844.7 6846.7 6852.2 6527.0 6548.3 6618.0 6619.3 6620.7 6590.3 6593.2 6594.6 6596.1 6596.6 6851.3 6898.4 6902.0 6908.0 6909.7 4413.3 4442.0 4444.0 4445.3 4446.4 6503.8 6660.0 6681.3 6682.1 6686.0 6483.4 6487.7 6491.4 6497.1 6500.7 6253.5 6476.7 6484.0 6486.1 6487.8 6306.4 6313.4 6330.6 6348.1 6352.6 6497.6 6501.9 6502.5 6505.4 6511.5 6155.6 6274.3 6286.3 6328.2 6344.2 09:54:59 INFO - 2015-11-17 09:54:59,173 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,173 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13435.42 Median:49476.00 stddev:16124.59 (32.6%) stddev-sans-first:16142.04 09:54:59 INFO - 2015-11-17 09:54:59,173 DEBUG : BROWSER_OUTPUT: Values: 830.3 849.4 857.0 860.7 866.5 13550.9 15844.8 16299.6 16304.1 16344.3 14423.5 14511.3 14516.0 14527.6 14539.6 679.5 689.7 811.6 817.5 818.1 807.5 823.7 825.7 825.9 831.0 861.4 869.7 869.8 869.9 870.6 708.8 715.9 845.9 860.8 861.4 626.9 628.1 630.5 630.7 631.9 13069.5 13267.7 13274.0 13279.6 13287.3 9989.4 10334.2 10504.7 10668.9 11068.6 9983.4 10105.9 10145.7 10206.7 10518.2 3215.5 3264.4 3278.1 3287.5 3357.1 45542.0 45568.3 45578.3 45652.3 45689.3 7337.9 7529.5 7607.0 7681.0 7721.2 11973.8 12009.3 12014.1 12023.1 12121.2 6328.6 6413.8 6489.0 6541.2 6608.9 3970.3 4020.1 4073.2 4081.1 4100.7 2736.1 2761.8 2762.0 2763.7 2767.4 430.5 431.6 434.3 439.8 439.8 638.3 650.6 659.3 668.3 691.1 7985.3 8031.7 8120.5 8146.0 8235.7 480.5 610.6 627.1 647.5 656.4 3831.9 3901.3 3920.3 3978.3 4150.0 53693.2 53965.7 54421.5 57871.7 60548.4 48363.8 48569.8 50391.5 52062.2 52115.7 50382.2 51169.0 51890.5 51978.7 52181.2 8332.0 8419.9 8459.6 8794.2 8804.3 34144.5 34558.8 34971.0 35345.5 35388.8 45096.3 45229.5 45479.3 47571.3 47691.0 7906.8 8310.4 8322.7 8451.3 8452.5 11183.8 11625.6 11714.1 11823.9 12085.7 10807.4 10840.7 11198.8 11216.2 11691.4 10756.3 11044.4 11061.8 11237.4 11540.0 10620.9 10750.7 10851.6 11376.0 11397.4 9120.1 9246.9 9302.8 9399.9 9667.7 8420.6 8828.4 9208.0 9361.9 9743.4 09:54:59 INFO - 2015-11-17 09:54:59,173 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:54:59 INFO - 2015-11-17 09:54:59,173 DEBUG : BROWSER_OUTPUT: 09:54:59 INFO - 2015-11-17 09:54:59,853 INFO : Browser exited with error code: 0 09:54:59 INFO - 2015-11-17 09:54:59,869 INFO : Completed test dromaeo_css (00:18:34) 09:54:59 INFO - 2015-11-17 09:54:59,869 INFO : Starting test kraken 09:54:59 INFO - 2015-11-17 09:54:59,869 DEBUG : operating with platform_type : linux_ 09:54:59 INFO - 2015-11-17 09:54:59,869 INFO : Initialising browser for kraken test... 09:54:59 INFO - 2015-11-17 09:54:59,875 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnT1r9D/profile http://localhost:33343/getInfo.html 09:55:04 INFO - 2015-11-17 09:55:04,093 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:55:04 INFO - 2015-11-17 09:55:04,093 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:55:04 INFO - 2015-11-17 09:55:04,094 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:55:04 INFO - 2015-11-17 09:55:04,094 DEBUG : BROWSER_OUTPUT: __metrics 09:55:04 INFO - 2015-11-17 09:55:04,210 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:55:05 INFO - 2015-11-17 09:55:05,646 INFO : Browser initialized. 09:55:05 INFO - 2015-11-17 09:55:05,646 INFO : Running cycle 1/1 for kraken test... 09:55:05 INFO - 2015-11-17 09:55:05,646 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnT1r9D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:55:17 INFO - 2015-11-17 09:55:17,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 141635584 09:55:17 INFO - 2015-11-17 09:55:17,424 DEBUG : BROWSER_OUTPUT: 09:55:19 INFO - 2015-11-17 09:55:19,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33343/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:20 INFO - 2015-11-17 09:55:20,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 179130368 09:55:20 INFO - 2015-11-17 09:55:20,492 DEBUG : BROWSER_OUTPUT: 09:55:23 INFO - 2015-11-17 09:55:23,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33343/tests/kraken/driver.html?testName=audio-dft) 09:55:23 INFO - 2015-11-17 09:55:23,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 170385408 09:55:23 INFO - 2015-11-17 09:55:23,681 DEBUG : BROWSER_OUTPUT: 09:55:26 INFO - 2015-11-17 09:55:26,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33343/tests/kraken/driver.html?testName=audio-fft) 09:55:27 INFO - 2015-11-17 09:55:27,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 151412736 09:55:27 INFO - 2015-11-17 09:55:27,051 DEBUG : BROWSER_OUTPUT: 09:55:29 INFO - 2015-11-17 09:55:29,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33343/tests/kraken/driver.html?testName=audio-oscillator) 09:55:29 INFO - 2015-11-17 09:55:29,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 153473024 09:55:29 INFO - 2015-11-17 09:55:29,572 DEBUG : BROWSER_OUTPUT: 09:55:31 INFO - 2015-11-17 09:55:31,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:32 INFO - 2015-11-17 09:55:32,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 154828800 09:55:32 INFO - 2015-11-17 09:55:32,318 DEBUG : BROWSER_OUTPUT: 09:55:35 INFO - 2015-11-17 09:55:35,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33343/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:35 INFO - 2015-11-17 09:55:35,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 154218496 09:55:35 INFO - 2015-11-17 09:55:35,789 DEBUG : BROWSER_OUTPUT: 09:55:39 INFO - 2015-11-17 09:55:39,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33343/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:39 INFO - 2015-11-17 09:55:39,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 155717632 09:55:39 INFO - 2015-11-17 09:55:39,819 DEBUG : BROWSER_OUTPUT: 09:55:42 INFO - 2015-11-17 09:55:42,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33343/tests/kraken/driver.html?testName=json-parse-financial) 09:55:43 INFO - 2015-11-17 09:55:43,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 156434432 09:55:43 INFO - 2015-11-17 09:55:43,137 DEBUG : BROWSER_OUTPUT: 09:55:44 INFO - 2015-11-17 09:55:44,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:45 INFO - 2015-11-17 09:55:45,244 DEBUG : BROWSER_OUTPUT: RSS: Main: 166240256 09:55:45 INFO - 2015-11-17 09:55:45,244 DEBUG : BROWSER_OUTPUT: 09:55:47 INFO - 2015-11-17 09:55:47,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:55:47 INFO - 2015-11-17 09:55:47,634 DEBUG : BROWSER_OUTPUT: RSS: Main: 165367808 09:55:47 INFO - 2015-11-17 09:55:47,635 DEBUG : BROWSER_OUTPUT: 09:55:49 INFO - 2015-11-17 09:55:49,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:55:50 INFO - 2015-11-17 09:55:50,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 171401216 09:55:50 INFO - 2015-11-17 09:55:50,254 DEBUG : BROWSER_OUTPUT: 09:55:52 INFO - 2015-11-17 09:55:52,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:55:53 INFO - 2015-11-17 09:55:53,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 183164928 09:55:53 INFO - 2015-11-17 09:55:53,190 DEBUG : BROWSER_OUTPUT: 09:55:55 INFO - 2015-11-17 09:55:55,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:55:56 INFO - 2015-11-17 09:55:56,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 180555776 09:55:56 INFO - 2015-11-17 09:55:56,340 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,001 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33343/tests/kraken/driver.html?testName=ai-astar) 09:55:58 INFO - 2015-11-17 09:55:58,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 240521216 09:55:58 INFO - 2015-11-17 09:55:58,252 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,253 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:55:58 INFO - 2015-11-17 09:55:58,254 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:55:58 INFO - 2015-11-17 09:55:58,254 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:55:58 INFO - 2015-11-17 09:55:58,254 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:55:58 INFO - 2015-11-17 09:55:58,254 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;104;111;113;112;99;109;114;109 09:55:58 INFO - 2015-11-17 09:55:58,255 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;127;157;163;137;151;152;125;168;122 09:55:58 INFO - 2015-11-17 09:55:58,255 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;159;159;160;160;161;161;163 09:55:58 INFO - 2015-11-17 09:55:58,255 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;86;99;71;72;71;103;89;73 09:55:58 INFO - 2015-11-17 09:55:58,255 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;135;90;90;90;149;90;90;141 09:55:58 INFO - 2015-11-17 09:55:58,255 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;110;109;109;110;110 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;145;146;145;145;146;146;146;146;147 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;96;96;96;96;96 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;58;56;59;57;58;68;54;55 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;70;70;69;69;69 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;84;83;85;85;85;85;95;85 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;114;116;124;116;123;116;117;118 09:55:58 INFO - 2015-11-17 09:55:58,256 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;148;148;149;141;161;149;147;138 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;69;65;66;66;66;69;68 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,944 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: __startTimestamp1447782958253__endTimestamp 09:55:58 INFO - 2015-11-17 09:55:58,257 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,261 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:55:58 INFO - 2015-11-17 09:55:58,261 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:55:58 INFO - 2015-11-17 09:55:58,261 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,262 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.50 stddev:4.52 (4.1%) stddev-sans-first:4.78 09:55:58 INFO - 2015-11-17 09:55:58,262 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 104.0 111.0 113.0 112.0 99.0 109.0 114.0 109.0 09:55:58 INFO - 2015-11-17 09:55:58,262 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,262 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.80 Median:151.50 stddev:16.33 (10.8%) stddev-sans-first:17.31 09:55:58 INFO - 2015-11-17 09:55:58,263 DEBUG : BROWSER_OUTPUT: Values: 146.0 127.0 157.0 163.0 137.0 151.0 152.0 125.0 168.0 122.0 09:55:58 INFO - 2015-11-17 09:55:58,263 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,263 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 09:55:58 INFO - 2015-11-17 09:55:58,263 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 159.0 159.0 160.0 160.0 161.0 161.0 163.0 09:55:58 INFO - 2015-11-17 09:55:58,263 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,264 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:72.50 stddev:12.65 (17.4%) stddev-sans-first:12.93 09:55:58 INFO - 2015-11-17 09:55:58,264 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 86.0 99.0 71.0 72.0 71.0 103.0 89.0 73.0 09:55:58 INFO - 2015-11-17 09:55:58,264 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,264 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:90.00 stddev:25.18 (28.0%) stddev-sans-first:26.07 09:55:58 INFO - 2015-11-17 09:55:58,264 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 135.0 90.0 90.0 90.0 149.0 90.0 90.0 141.0 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.84 (0.6%) stddev-sans-first:0.67 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: Values: 144.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 09:55:58 INFO - 2015-11-17 09:55:58,265 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:3.88 (6.8%) stddev-sans-first:4.06 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 58.0 56.0 59.0 57.0 58.0 68.0 54.0 55.0 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 70.0 70.0 69.0 69.0 69.0 09:55:58 INFO - 2015-11-17 09:55:58,266 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,267 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.37 (4.0%) stddev-sans-first:3.57 09:55:58 INFO - 2015-11-17 09:55:58,267 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 84.0 83.0 85.0 85.0 85.0 85.0 95.0 85.0 09:55:58 INFO - 2015-11-17 09:55:58,267 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,267 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:117.50 stddev:3.57 (3.0%) stddev-sans-first:3.61 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 114.0 116.0 124.0 116.0 123.0 116.0 117.0 118.0 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.40 Median:148.50 stddev:6.20 (4.2%) stddev-sans-first:6.37 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 148.0 148.0 149.0 141.0 161.0 149.0 147.0 138.0 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.45 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 69.0 65.0 66.0 66.0 66.0 69.0 68.0 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:55:58 INFO - 2015-11-17 09:55:58,268 DEBUG : BROWSER_OUTPUT: 09:55:59 INFO - 2015-11-17 09:55:59,113 INFO : Browser exited with error code: 0 09:55:59 INFO - 2015-11-17 09:55:59,161 INFO : Completed test kraken (00:00:59) 09:55:59 INFO - 2015-11-17 09:55:59,161 INFO : Starting test v8_7 09:55:59 INFO - 2015-11-17 09:55:59,161 DEBUG : operating with platform_type : linux_ 09:55:59 INFO - 2015-11-17 09:55:59,161 INFO : Initialising browser for v8_7 test... 09:55:59 INFO - 2015-11-17 09:55:59,167 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9h_eYg/profile http://localhost:33343/getInfo.html 09:56:03 INFO - 2015-11-17 09:56:03,202 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:56:03 INFO - 2015-11-17 09:56:03,203 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:56:03 INFO - 2015-11-17 09:56:03,203 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:56:03 INFO - 2015-11-17 09:56:03,203 DEBUG : BROWSER_OUTPUT: __metrics 09:56:03 INFO - 2015-11-17 09:56:03,327 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:04 INFO - 2015-11-17 09:56:04,637 INFO : Browser initialized. 09:56:04 INFO - 2015-11-17 09:56:04,637 INFO : Running cycle 1/1 for v8_7 test... 09:56:04 INFO - 2015-11-17 09:56:04,638 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9h_eYg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:56:16 INFO - 2015-11-17 09:56:16,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 09:56:16 INFO - 2015-11-17 09:56:16,379 DEBUG : BROWSER_OUTPUT: 09:56:37 INFO - 2015-11-17 09:56:37,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33343/tests/v8_7/run.html (next: http://localhost:33343/tests/v8_7/run.html) 09:56:38 INFO - 2015-11-17 09:56:38,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 634511360 09:56:38 INFO - 2015-11-17 09:56:38,113 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: |0;Richards;162.73393002441009 09:56:38 INFO - 2015-11-17 09:56:38,114 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.9487975174554 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.928390188892 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1109.8779134295228 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 09:56:38 INFO - 2015-11-17 09:56:38,115 DEBUG : BROWSER_OUTPUT: |7;RegExp;25450 09:56:38 INFO - 2015-11-17 09:56:38,116 DEBUG : BROWSER_OUTPUT: |8;Splay;676.1842959117456 09:56:38 INFO - 2015-11-17 09:56:38,116 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 09:56:38 INFO - 2015-11-17 09:56:38,116 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:56:38 INFO - 2015-11-17 09:56:38,116 DEBUG : BROWSER_OUTPUT: __startTimestamp1447782998111__endTimestamp 09:56:38 INFO - 2015-11-17 09:56:38,116 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.73 Median:162.73 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: Values: 162.7 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.95 Median:193.95 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: Values: 193.9 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,117 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: Values: 281.9 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: Values: 5040.2 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1109.88 Median:1109.88 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: Values: 1109.9 09:56:38 INFO - 2015-11-17 09:56:38,118 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: Values: 777.6 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: Values: 11952.4 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: Values: 25450.0 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:676.18 Median:676.18 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: Values: 676.2 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: Values: 4835.7 09:56:38 INFO - 2015-11-17 09:56:38,120 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:56:38 INFO - 2015-11-17 09:56:38,121 DEBUG : BROWSER_OUTPUT: 09:56:38 INFO - 2015-11-17 09:56:38,949 INFO : Browser exited with error code: 0 09:56:38 INFO - 2015-11-17 09:56:38,961 INFO : Completed test v8_7 (00:00:39) 09:56:39 INFO - 2015-11-17 09:56:39,047 INFO : Completed test suite (00:20:13) 09:56:39 INFO - 2015-11-17 09:56:39,047 DEBUG : Working with test: dromaeo_css 09:56:39 INFO - 2015-11-17 09:56:39,047 DEBUG : Generating results file: dromaeo_css 09:56:39 INFO - 2015-11-17 09:56:39,048 DEBUG : Working with test: kraken 09:56:39 INFO - 2015-11-17 09:56:39,048 DEBUG : Generating results file: kraken 09:56:39 INFO - 2015-11-17 09:56:39,049 INFO : javascript benchmark 09:56:39 INFO - 2015-11-17 09:56:39,049 DEBUG : Working with test: v8_7 09:56:39 INFO - 2015-11-17 09:56:39,049 DEBUG : Generating results file: v8_7 09:56:39 INFO - 2015-11-17 09:56:39,049 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:39 INFO - 2015-11-17 09:56:39,198 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 09:56:39 INFO - 2015-11-17 09:56:39,198 DEBUG : process_Request line: dromaeo_css 6951.24 graph.html#tests=[[72,63,35]] 09:56:39 INFO - 2015-11-17 09:56:39,198 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:39 INFO - 2015-11-17 09:56:39,233 DEBUG : process_Request line: kraken 1496.80 graph.html#tests=[[232,63,35]] 09:56:39 INFO - 2015-11-17 09:56:39,233 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:56:39 INFO - 2015-11-17 09:56:39,278 DEBUG : process_Request line: v8_7 20935.70 graph.html#tests=[[230,63,35]] 09:56:39 INFO - 2015-11-17 09:56:39,279 INFO : javascript benchmark 09:56:39 INFO - 2015-11-17 09:56:39,281 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.4190369697393, 360.26505927907067, 362.7932078715133, 363.09408026972693, 364.3805530597984, 14586.12483251003, 14608.707825843503, 16797.66404671906, 17230.655386892253, 17811.64376712465, 11540.249883757571, 11882.821757673642, 16955.406560770374, 17368.957862528227, 17377.13114344284, 4502.4371953505815, 4662.953370466286, 4666.813327466914, 4668.416447944007, 4668.692766025519, 3559.75081744278, 3661.9267614647692, 4644.5123262057505, 4650.930236046462, 4939.654224204307, 5040.672356296847, 5063.898722025558, 5078.923816142761, 5087.669301495391, 5118.257852611369, 4957.479464656213, 5080.0, 5085.211792172219, 5140.511651393112, 5153.871153221162, 4449.488308844492, 4452.977735111336, 4458.8439404621, 4460.598546130831, 4462.397576327219, 14310.356033978496, 14381.568552943429, 14617.926910365486, 14672.413103475848, 14697.412103515846, 1806.7922188948307, 1937.5834195648004, 2069.3067822279404, 2088.3004193595166, 2116.534362440261, 10093.495325233709, 10095.0, 10358.585656573729, 10422.21833362501, 10469.738256543571, 1921.1738952250528, 1963.1754663041413, 1979.1786408640396, 1997.0813425824138, 2019.8283145932467, 60431.69784151095, 60539.39460605426, 60596.0, 60989.695051524905, 61450.38549614491, 14977.251137443302, 15345.769813452807, 15946.681066378607, 16040.75938860918, 16058.197090145446, 23717.407064823172, 23772.7622723774, 23954.442961207813, 24134.87932560326, 24185.15351962673, 8855.468671879707, 9497.90502094984, 9501.144896959308, 9552.331336806357, 9592.376495527908, 8268.83462330762, 8310.792230194173, 8346.0, 8379.078301386842, 8392.412531122885, 7878.369730421553, 8019.9198008019175, 8024.395120975828, 8044.718434854752, 8048.798780030429, 1188.423614546944, 2120.130746393971, 3033.8179709217516, 3124.9687503125133, 3300.5709257796334, 466.30287719858353, 469.27497017108647, 475.34639870178506, 509.8757240285236, 519.2652396858479, 11834.585789497498, 12184.268943863397, 12490.562830300896, 12546.435410406371, 12603.117781755189, 475.5149747257778, 482.8454894433818, 488.3529323646112, 498.1332481482195, 512.9948700513022, 6373.617582944946, 6646.86706265872, 6676.0987266718375, 6716.7984960450285, 6728.798136055926, 469578.0, 474929.0, 485058.0, 485220.0, 568737.0, 78310.0, 78931.21068789353, 80269.0, 80586.0, 80784.19215807885, 548.4186762032259, 548.5556699073763, 549.9890002199934, 550.8072174738809, 552.257214047106, 10350.948245258725, 10509.842352364874, 10558.31370960885, 10590.788184236426, 10820.675379738306, 33873.3225335487, 34350.82824585961, 34756.82621586977, 35111.12222194363, 36807.26385472329, 48213.276800847314, 48741.0, 50967.0, 51060.744696276284, 51107.0, 14918.552443426715, 14947.925260373628, 14975.1014939104, 14990.625234368792, 15377.846221537642, 19039.428817135507, 19221.0, 19335.8066419334, 19435.0, 19696.60606787885, 9794.510274486389, 16040.43858464948, 16191.67616647684, 16381.590460238589, 16389.262483188522, 10269.537870795682, 10467.162626989975, 10534.367937923442, 10651.786964260826, 10855.945720271347, 10257.692269231935, 10555.419451930218, 10711.303765255234, 10735.194860385658, 10776.191785615953, 14537.781933270799, 14678.266086695836, 14703.3383497745, 14969.40122395092, 15248.542543723706, 14734.705305894036, 15025.699486010437, 15055.774163387778, 15557.611059723598, 15610.375584976928], "dojo.html": [3183.6816318368165, 3297.802131872086, 3325.467925131978, 3336.0825772912463, 3351.480520519319, 5205.739713014353, 5299.788008479666, 5461.508464238218, 5517.972410137949, 5525.336959564847, 5348.010618035656, 5358.758855851486, 5390.6226564140525, 5403.78384864606, 5404.0, 4985.1774457214515, 4994.525520075587, 5052.343195384595, 5136.58907287418, 5147.330846989886, 4823.445303790057, 5036.7733451994745, 5090.669106508065, 5123.077845987721, 5130.02529519392, 4796.208625576775, 4881.0, 4896.167651499253, 4903.338049363361, 4966.503349665023, 4977.104121258172, 5002.1746411842005, 5002.59979201663, 5026.321446604735, 5042.294078828967, 4897.461279259279, 4981.37732783402, 5005.224190250517, 5023.8492845214705, 5052.949470505285, 5172.793088276464, 5309.256704061435, 5310.362756469249, 5311.814086506954, 5318.6542874713405, 5823.88352232953, 5827.621204621686, 5831.446012628793, 5833.06670932653, 5864.5894787364905, 5744.253247077895, 5795.971020144872, 5902.3507414184405, 5904.350521442638, 5938.406159384071, 5532.336119665666, 5534.1975413564805, 5534.944650553443, 5541.473560011793, 5561.888762224733, 6000.189974353494, 6016.69916504173, 6022.036474164201, 6022.668753218528, 6029.035354343284, 5683.602147849693, 5727.914081288784, 5830.183774271605, 5848.853778655568, 5855.970720146457, 5830.650160990354, 5836.474717275466, 5849.532037436995, 5854.385289544622, 5912.704364781744, 5850.12248162779, 5852.531797456193, 5854.7072646367515, 5861.824145275648, 5869.295684517885, 5711.514521265739, 5800.9129863052085, 5835.037218858925, 5896.056630939029, 5935.643861368331, 4607.976960115178, 4612.561806628365, 4614.377059097046, 4616.099860527165, 4652.371929789503, 3964.6035396460125, 4076.673866090706, 4080.8775736727944, 4087.509498860156, 4110.630043296118, 5429.239906413105, 5574.470425309589, 5598.384177740445, 5626.690532020696, 5668.659880407189, 5970.552208584373, 5980.910286345708, 5982.0, 5983.222181116427, 5984.970075149597, 5418.566514678816, 5523.199136125239, 5623.437656234344, 5625.071863142617, 5629.7185140742795, 5075.847724568269, 5124.0, 5148.922766158511, 5151.150060240094, 5187.118189907725, 5890.204822349014, 5898.4101589840675, 5898.941010589925, 5900.940990590125, 6094.8171554853425, 5730.0, 5773.076307790733, 5800.506956908541, 5852.326982397079, 5853.619514731528, 6108.190302030417, 6246.3753624637175, 6258.43674069336, 6262.2172228471445, 6262.342454042442, 5937.910931335947, 5950.16697662319, 5953.76184952597, 5956.195913551615, 6011.6693581853415, 5679.6024278301775, 5785.074388097884, 5905.704714764331, 6048.425399587032, 6063.423974722395, 5828.446297601721, 5835.2122463466885, 5844.561657875592, 5845.736941837713, 5889.469947704727, 5784.94215057844, 5799.971000144972, 5830.183774271521, 5833.445822646841, 5833.708314584169, 5542.75057622416, 5634.718264086861, 5662.433756624305, 5699.316082070178, 5731.799387021434, 5739.684317362418, 5744.741486633028, 5758.366579676316, 5806.187133801355, 5809.883802323845, 5613.719314034363, 5618.943810561842, 5624.550035997028, 5630.0428927081675, 5643.576731745054], "mootools.html": [1389.8610138986096, 1747.2050217151198, 1781.0649409060243, 1813.7460755494228, 1815.3918437323487, 6700.3299670032975, 7403.296686814758, 7500.0, 7508.324250817425, 7512.361449276818, 7710.92289077109, 7819.726309579166, 7838.25536574026, 7842.098158711749, 7845.254700803429, 1969.1827891425041, 2003.5692326149874, 2005.5688027074177, 2255.1317742669107, 2282.3038973113194, 2064.9690254646193, 2249.336445748508, 2291.4385975436044, 2292.7821856923565, 2292.805111565519, 2179.727534058243, 2192.572448372568, 2203.867767933921, 2249.3701763506247, 2250.6849041134255, 1984.0972357577411, 2037.74528183977, 2228.008536201391, 2250.5948929192737, 2252.2454977582447, 2259.514204446052, 2294.7590502997277, 2294.7705229477087, 2295.5294164696197, 2298.770122987705, 7719.228077192236, 7853.136155022943, 7854.528728276265, 7860.803479913048, 7861.095973963011, 4602.815887364502, 4710.976445117787, 4712.198926182557, 4722.386089808303, 4724.220503616899, 2951.2326795033446, 3118.781685282031, 3124.9531257031163, 3135.905922822319, 3136.07485791692, 986.5166068626393, 990.9653162139291, 996.8803743550748, 1014.604304321308, 1024.482636268687, 11087.445627718582, 11089.112870970303, 11089.889101109047, 11090.057345125673, 11109.166812489015, 4213.157368526307, 4261.722988005769, 4290.570942905747, 4303.4190384298345, 4340.934885976713, 9262.259019278441, 9278.304127190488, 9280.0, 9292.0, 9293.767655808659, 4738.1708201064675, 4758.3100450434495, 4758.714477131383, 4758.833440829554, 4760.190767569521, 4327.891802704895, 4337.1976184405985, 4337.934930976038, 4339.544347843431, 4340.370646256339, 3727.7017838572847, 3733.1227161617, 3743.756655817363, 3754.685859948996, 3800.2969450651717, 1219.116140797932, 1233.7100781316383, 1237.5915947737226, 1240.7890658588062, 1249.881261280177, 982.474376208725, 1004.7889943112028, 1007.0734923870057, 1125.8254970479588, 1373.2790285100402, 7383.483156179016, 7385.409167266714, 7408.222136675679, 7418.517796343221, 7459.515131516434, 509.9235114732746, 517.6014468858957, 521.5254118751917, 524.1639584862139, 524.6589716684109, 5260.158374660036, 5337.466253374631, 5832.270966129234, 5961.463468287789, 6127.4485296322655, 8584.828303433897, 8641.265492433213, 8754.606042728092, 8762.518061506678, 8775.166359195866, 9057.592408341641, 9062.773430664287, 9067.909320906707, 9164.6792362267, 9217.216536594331, 7184.892226616605, 7191.244919283505, 7203.675834587456, 7205.207427183111, 7215.783526494213, 6999.440044796506, 7092.645367731489, 7100.254473280438, 7101.680424381018, 7108.502404831612, 7802.063752349754, 7901.525908445512, 7956.602169891598, 8114.472559283864, 8142.18578142181, 8033.19668033192, 8183.754487365389, 8870.379073464796, 8945.642174312954, 8947.239484643878, 6622.304658011032, 6629.204495460575, 6690.83272918181, 6709.295523969913, 6723.865522689421, 7619.466637335555, 7659.348955338635, 7671.846563068596, 7675.04061992251, 7677.0, 7045.471589630901, 7158.46311526648, 7178.856422871618, 7186.281371862772, 7293.562386256842, 6880.518363714492, 6890.173179218526, 7006.299370062953, 7024.0, 7178.533395329287, 7114.786556403316, 7170.856582868209, 7177.7487787927175, 7188.101487314086, 7226.566406015656, 6451.516136289703, 6488.221413430229, 6490.448311893542, 6491.0, 6491.610503369813, 6711.0940023096255, 6756.966215168893, 6774.187097548326, 6777.762778302736, 6780.830479238059], "ext.html": [549.3188446326557, 582.7901955296093, 591.2402562706919, 591.9052951527757, 601.2694576090049, 31001.534976975363, 32330.838345808268, 39022.609773902215, 39730.801345993226, 39750.60249397505, 43774.78112609441, 44136.117277654426, 44149.55850441495, 44262.336064959054, 44293.33559996603, 7552.924470755277, 7694.384449244047, 8641.481511109354, 8807.295416366675, 8823.823523529525, 10477.738056548571, 10792.46037698112, 10808.675739727782, 10809.83785243222, 10825.350478971286, 10410.63562775303, 10466.947665261663, 10505.212109091848, 10550.47247637615, 10577.894221057768, 10400.0, 10405.53175107122, 10475.738106547322, 10511.526981285822, 10534.525946332433, 10252.58989640421, 10390.168786497137, 10392.532336044897, 10403.47982600867, 10414.947925260325, 39785.0, 40264.396034059515, 40279.19441611181, 40282.0, 40298.395524067164, 3178.9364212715845, 3184.41088398647, 3230.402375560529, 3350.995416465944, 3999.5000624921886, 29983.550246746316, 30529.0, 30648.2337941551, 30695.232619184477, 30735.0, 3205.4710972689713, 3366.6969972702327, 3373.6088083158656, 3376.2572234108457, 3548.574171099459, 263107.0, 263662.0, 264440.0, 264884.0, 266128.0, 52594.737026315386, 60753.39246607477, 60959.39040609626, 61018.38981610127, 61140.694296528236, 48664.51335486671, 48813.26780098301, 48835.267470987965, 48941.51058489441, 66144.66927665331, 15674.843251567567, 15902.0, 15967.680646387007, 15993.44022959214, 16053.19734013318, 12129.5148194073, 12265.816012759815, 12274.877251227374, 12275.38623068843, 12284.324362159989, 17897.19462624185, 18318.267269309345, 20189.394318170478, 20680.276190333265, 21521.0, 8222.218889205516, 8341.874871876928, 8360.916390836013, 8393.24460798531, 8447.45091569046, 911.2026976395654, 974.5858010345717, 976.1946394224793, 983.8671779309844, 984.084801134937, 28859.855700721782, 28992.710072899423, 29115.126546203646, 29589.26026849346, 29728.702712973027, 1068.5832525315134, 1073.393532654048, 1112.2881355932209, 1155.942202889852, 1218.9817152742717, 15030.549083527512, 15069.849301506845, 15218.0, 15399.769003464957, 15454.768178477332, 328417.0, 329035.0, 332198.0, 334185.0, 334977.0, 45302.32046519305, 54384.0, 54724.179137312974, 54846.72576637171, 54885.1767223492, 1210.038019774264, 1329.1028555724847, 1337.4315915735967, 1342.1812694256496, 1343.1269674711516, 28047.0, 28943.710562894103, 29134.27164320909, 29477.410451790416, 29789.404211915207, 43605.56394436015, 44165.337519936584, 44860.102797943204, 45322.0, 49114.50885491099, 257839.0, 261907.0, 262409.0, 263049.0, 263297.0, 33264.0, 33306.500402494465, 33497.49753753744, 33499.16252093717, 33709.83145084259, 43962.34056489219, 44664.55335446604, 44915.32627010663, 45219.0, 45337.0, 37374.252514950094, 37408.251834963696, 38534.0, 38908.80545597254, 38961.0, 37605.623943761304, 38814.41778373383, 38933.80533097316, 39974.40038399484, 43817.561824382625, 38704.80647596744, 39150.80424597859, 39560.40659390169, 39737.40393894036, 40393.79803101083, 31915.36169276555, 32448.0, 33969.49045764365, 34775.826120869235, 38062.42906356351, 25633.933608590854, 25770.226893193234, 25808.35479112962, 26162.476750465266, 26245.475090498465], "prototype.html": [341.75905986279673, 344.3869911557428, 353.108401286751, 353.6269235956065, 357.7442128877852, 5835.737391817368, 5928.525717942565, 5961.672108034057, 6025.548083893709, 6051.152838602588, 5788.102844059177, 5903.822885313437, 5911.645301281927, 5958.165856780054, 6010.669413182273, 4661.673682842185, 4668.25307950728, 4674.08855273221, 4676.0, 4703.200455922484, 4457.1977044132045, 4667.06658668266, 4675.929861052087, 4678.695884767496, 4681.953180468203, 4542.750148741818, 4542.818287268522, 4597.08058388322, 4600.97699511502, 4660.883477913046, 4608.262677971508, 4610.5850473457385, 4626.537346265381, 4639.188142075157, 4645.210314246586, 4106.917861642781, 4108.589141085898, 4110.383442483621, 4112.321466957948, 4116.259073366793, 5552.888942221173, 5665.461781130786, 5677.233573467571, 5677.914831277534, 5683.715814209273, 5399.082156033444, 5403.2705584746345, 5403.4866687665, 5404.621676482648, 5404.729763511808, 6373.139626150503, 6378.649174295412, 6384.0, 6384.170057892445, 6385.96807015962, 4534.86395408135, 4537.931931021038, 4543.204939135638, 4550.408446901882, 4551.40831691878, 6466.515011374118, 6496.740130394778, 6580.506462015368, 6584.86830263392, 6589.80230593083, 4620.353150558924, 4649.790759415834, 4651.930221046687, 4657.580817726421, 4663.27719203524, 4687.1328804171335, 4728.290756386501, 4729.125111854318, 4731.810727570927, 4733.219018861918, 5379.54273886724, 5385.892282154335, 5387.595930305243, 5391.406945236021, 5396.082665946798, 6265.342139075423, 6408.967955160194, 6409.647469389229, 6414.0, 6414.230292364853, 1642.2199455258894, 1672.3645014894262, 1673.8660907127644, 1676.1786724504905, 1676.9077700726334, 1130.7229728716518, 1139.7264656482384, 1149.3219000789575, 1151.7293436042523, 1174.0783484964263, 6188.628682279078, 6190.783322583778, 6198.256209254918, 6203.844903877349, 6207.81376558704, 6353.078803573456, 6519.185101862267, 6584.8024559263295, 6589.538732288694, 6593.40659340652, 6121.877562448726, 6151.907721384183, 6266.122742816009, 6275.529335299871, 6278.6860656966965, 3529.0647978285774, 3586.444101164324, 3589.6769290763955, 3590.3537363274863, 3593.9281214375565, 6634.933650663528, 6799.5920244785475, 6799.626020568818, 6804.489663275175, 6806.727730890808, 6702.229243636946, 6792.864142717217, 6799.93200067993, 6800.489963252776, 6801.965990170116, 6799.626020568916, 6804.489663275274, 6844.691988860513, 6846.691898864563, 6852.177738671391, 6527.02094685801, 6548.345165483413, 6618.0403841443685, 6619.3380661933425, 6620.668966551557, 6590.340965903371, 6593.175853018372, 6594.571352862049, 6596.142501474777, 6596.60420374779, 6851.314868513109, 6898.413634841095, 6902.0, 6908.0, 6909.723611055501, 4413.293872980308, 4442.0, 4443.955560444354, 4445.2887537993765, 4446.42196514464, 6503.837404064936, 6660.034295027097, 6681.331866813474, 6682.097916781367, 6685.966570167118, 6483.384078512534, 6487.740490380521, 6491.415772580491, 6497.090407342881, 6500.739970401131, 6253.530985176221, 6476.740930362921, 6483.967580162069, 6486.124373209556, 6487.837804054936, 6306.432421082125, 6313.43179113882, 6330.620162790247, 6348.111264423077, 6352.587081839665, 6497.642629655225, 6501.869962600627, 6502.544821862424, 6505.447037001908, 6511.511636627367, 6155.599886007395, 6274.278457977209, 6286.339934307015, 6328.177336946167, 6344.238691356882], "yui.html": [830.323286521485, 849.4181485682308, 856.9571521423927, 860.7030574451813, 866.4627930682974, 13550.932245338772, 15844.84155158448, 16299.592510187236, 16304.103274319938, 16344.34622615097, 14423.495177668783, 14511.274436278196, 14516.0, 14527.564173074825, 14539.636509087279, 679.5277282288811, 689.7344522358903, 811.5658122904248, 817.5299202958294, 818.0919179710517, 807.4670717326566, 823.736404350608, 825.7027470110785, 825.9050209225956, 831.031847897199, 861.4056301152216, 869.7086476030537, 869.7869022089596, 869.9130086991313, 870.6082262981683, 708.7519368221133, 715.9319864612879, 845.868890321995, 860.8278344331128, 861.4228466927174, 626.8840264551072, 628.1425853709699, 630.4515071887441, 630.6562923206864, 631.8767840271149, 13069.477220911247, 13267.668308292274, 13274.004449666314, 13279.601611951657, 13287.335633218301, 9989.350692204984, 10334.22493312997, 10504.684859454228, 10668.893311066868, 11068.557257709683, 9983.351082179635, 10105.89894101057, 10145.746356341077, 10206.693799186036, 10518.211134164892, 3215.469447541153, 3264.412405766961, 3278.1476816027766, 3287.4575695010294, 3357.0600231935096, 45542.0, 45568.3164752529, 45578.31632525548, 45652.31521527147, 45689.31466028012, 7337.88993165103, 7529.4729368944745, 7606.961965190249, 7681.0, 7721.189275126143, 11973.760524789455, 12009.339486328161, 12014.098942579341, 12023.098267629963, 12121.151519393557, 6328.557001009885, 6413.839654008594, 6488.967555162194, 6541.247756507967, 6608.86782264352, 3970.3250447424007, 4020.0954785173103, 4073.246449406869, 4081.10215752534, 4100.7334523255895, 2736.138116493298, 2761.792865535093, 2761.9723802761714, 2763.6545431821023, 2767.4465106978687, 430.487719613665, 431.58136607490684, 434.30944797771065, 439.7823077576556, 439.83945859760956, 638.2691817868607, 650.6096342194645, 659.3044338223125, 668.2649086005355, 691.1257259566552, 7985.321247694011, 8031.718889838828, 8120.472169308976, 8145.959270203611, 8235.711750088718, 480.5146801730278, 610.5542953643865, 627.1470799712388, 647.5467172978933, 656.3829999800269, 3831.8658846940225, 3901.297766402075, 3920.2747491714126, 3978.2839088963688, 4150.0, 53693.194602081, 53965.73017134889, 54421.45578544243, 57871.71064144652, 60548.39451605516, 48363.75818120887, 48569.75715121402, 50391.49608503941, 52062.21906671403, 52115.73942130265, 50382.244266336034, 51169.0, 51890.48109518932, 51978.740106299985, 52181.217281740806, 8332.000639693102, 8419.915800841913, 8459.61931713062, 8794.20852123312, 8804.295656347349, 34144.48783268203, 34558.82720586381, 34971.0, 35345.46981795224, 35388.82305588559, 45096.323555147355, 45229.547704522534, 45479.31781023354, 47571.28643070426, 47691.0, 7906.802329941567, 8310.418270720991, 8322.70870519529, 8451.28164106058, 8452.492850428995, 11183.832242516206, 11625.59310424131, 11714.121440891797, 11823.940880295544, 12085.697857553632, 10807.407481436161, 10840.728981775203, 11198.776024479303, 11216.158788091088, 11691.415429228675, 10756.300840445347, 11044.392558409043, 11061.834072488758, 11237.381943992832, 11540.0, 10620.89379106199, 10750.73123171927, 10851.620193293196, 11376.0, 11397.373144477133, 9120.133587309196, 9246.907530924605, 9302.813943721223, 9399.859002114837, 9667.661631842851, 8420.5789710513, 8828.42615230008, 9207.953960230156, 9361.906380936103, 9743.366681165702]}, "summary": {"lowerIsBetter": false, "suite": 6951.2343777238975, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8566.82033863056, "unit": "ms", "value": 8566.82033863056}, "dojo.html": {"lowerIsBetter": false, "filtered": 5429.158117730155, "unit": "ms", "value": 5429.158117730155}, "mootools.html": {"lowerIsBetter": false, "filtered": 4386.635864096865, "unit": "ms", "value": 4386.635864096865}, "ext.html": {"lowerIsBetter": false, "filtered": 19002.165771469867, "unit": "ms", "value": 19002.165771469867}, "prototype.html": {"lowerIsBetter": false, "filtered": 4861.101662156706, "unit": "ms", "value": 4861.101662156706}, "yui.html": {"lowerIsBetter": false, "filtered": 5985.638475775609, "unit": "ms", "value": 5985.638475775609}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447781785, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 159.0, 160.0, 159.0, 159.0, 160.0, 160.0, 161.0, 161.0, 163.0], "ai-astar": [110.0, 111.0, 104.0, 111.0, 113.0, 112.0, 99.0, 109.0, 114.0, 109.0], "imaging-gaussian-blur": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "audio-beat-detection": [146.0, 127.0, 157.0, 163.0, 137.0, 151.0, 152.0, 125.0, 168.0, 122.0], "json-stringify-tinderbox": [69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [143.0, 150.0, 148.0, 148.0, 149.0, 141.0, 161.0, 149.0, 147.0, 138.0], "json-parse-financial": [56.0, 57.0, 58.0, 56.0, 59.0, 57.0, 58.0, 68.0, 54.0, 55.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 68.0, 69.0, 65.0, 66.0, 66.0, 66.0, 69.0, 68.0], "audio-fft": [71.0, 71.0, 86.0, 99.0, 71.0, 72.0, 71.0, 103.0, 89.0, 73.0], "imaging-darkroom": [144.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0], "stanford-crypto-ccm": [115.0, 122.0, 114.0, 116.0, 124.0, 116.0, 123.0, 116.0, 117.0, 118.0], "audio-oscillator": [90.0, 90.0, 135.0, 90.0, 90.0, 90.0, 149.0, 90.0, 90.0, 141.0], "stanford-crypto-aes": [85.0, 84.0, 84.0, 83.0, 85.0, 85.0, 85.0, 85.0, 95.0, 85.0], "imaging-desaturate": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.6, "unit": "ms", "value": 80.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.4, "unit": "ms", "value": 147.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.8, "unit": "ms", "value": 144.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.1, "unit": "ms", "value": 118.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.6, "unit": "ms", "value": 145.6}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.8, "unit": "ms", "value": 57.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 105.5, "unit": "ms", "value": 105.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 160.3, "unit": "ms", "value": 160.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 67.2, "unit": "ms", "value": 67.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.3, "unit": "ms", "value": 69.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.6, "unit": "ms", "value": 109.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.6, "unit": "ms", "value": 85.6}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.8, "unit": "ms", "value": 95.8}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447781785, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.9487975174554], "Encrypt": [281.928390188892], "NavierStokes": [4835.748792270531], "Decrypt": [5040.201005025126], "Splay": [676.1842959117456], "Richards": [162.73393002441009], "RegExp": [25450.0], "Earley": [777.6049766718507], "Boyer": [11952.380952380952], "RayTrace": [1109.8779134295228]}, "summary": {"lowerIsBetter": false, "suite": 20935.696339329625, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 340.90440800000005, "unit": "score", "value": 340.90440800000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 944.1440070000003, "unit": "score", "value": 944.1440070000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.881118881119, "unit": "score", "value": 306.881118881119}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.81158424725827, "unit": "score", "value": 52.81158424725827}, "Splay": {"lowerIsBetter": false, "filtered": 120.51596065259118, "unit": "score", "value": 120.51596065259118}, "RegExp": {"lowerIsBetter": false, "filtered": 35.79508840864438, "unit": "score", "value": 35.79508840864438}, "Richards": {"lowerIsBetter": false, "filtered": 216.93078999999992, "unit": "score", "value": 216.93078999999992}, "Earley": {"lowerIsBetter": false, "filtered": 857.0714179999998, "unit": "score", "value": 857.0714179999998}, "Boyer": {"lowerIsBetter": false, "filtered": 55.75985258964142, "unit": "score", "value": 55.75985258964142}, "RayTrace": {"lowerIsBetter": false, "filtered": 666.7300889999998, "unit": "score", "value": 666.7300889999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-011"}, "testrun": {"date": 1447781785, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117073331", "branch": "Mozilla-Inbound", "revision": "f3eb66d21d1ca1e9b140a3052dda40717358562b"}}] 09:56:39 INFO - RETURN: dromaeo_css: 6951.24 09:56:39 INFO - RETURN: kraken: 1496.80 09:56:39 INFO - RETURN: v8_7: 20935.70 09:56:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20935.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1496.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6951.24"}}} 09:56:39 INFO - Return code: 0 09:56:39 INFO - # TBPL SUCCESS # 09:56:39 INFO - Running post-action listener: _resource_record_post_action 09:56:39 INFO - Running post-run listener: _resource_record_post_run 09:56:40 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522817536; Read time: 104; Write time: 699884 09:56:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 180244480; Read time: 0; Write time: 339392 09:56:40 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281272320; Read time: 104; Write time: 220664 09:56:40 INFO - Running post-run listener: _upload_blobber_files 09:56:40 INFO - Blob upload gear active. 09:56:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:56:40 INFO - Copying logs to upload dir... 09:56:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.949139 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-17 09:56:40.310093) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:40.313310) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010043 build_url: 'https://queue.taskcluster.net/v1/task/i_tV8gIRRvq2cUX8OKqRLw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:40.363678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:40.364022) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1447778967.42214-435527124 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:40.413393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 09:56:40.413690) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 09:56:40.413959) ========= ========= Total master_lag: 0.21 =========