builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1454422666.42 results: success (0) buildid: 20160202035417 builduid: 78473f32d14a4ebd82e6ad6c6b2526d7 revision: 2a25445490e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.420294) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.420798) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.421114) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006350 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.446802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.447321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.475259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.475877) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.031300 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.525519) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.525861) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.526237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.526511) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-02 06:17:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-02-02 06:17:46 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.714207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.714717) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055028 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:46.783409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 06:17:46.784013) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2a25445490e3 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2a25445490e3 --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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-02 06:17:46,830 Setting DEBUG logging. 2016-02-02 06:17:46,830 attempt 1/10 2016-02-02 06:17:46,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2a25445490e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 06:17:47,878 unpacking tar archive at: mozilla-beta-2a25445490e3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331581 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 06:17:48.129225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:48.129565) ========= echo 2a25445490e3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2a25445490e3'] 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2a25445490e3 program finished with exit code 0 elapsedTime=0.004382 script_repo_revision: '2a25445490e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:48.179701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:48.180022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 06:17:48.191483) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-02-02 06:17:48.192102) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:17:48 INFO - MultiFileLogger online at 20160202 06:17:48 in /builds/slave/test-pgo 06:17:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:17:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:17:48 INFO - {'append_to_log': False, 06:17:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:17:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:17:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:17:48 INFO - 'branch': 'Mozilla-Beta', 06:17:48 INFO - 'buildbot_json_path': 'buildprops.json', 06:17:48 INFO - 'config_files': ('talos/linux_config.py',), 06:17:48 INFO - 'default_actions': ('clobber', 06:17:48 INFO - 'read-buildbot-config', 06:17:48 INFO - 'download-and-extract', 06:17:48 INFO - 'populate-webroot', 06:17:48 INFO - 'create-virtualenv', 06:17:48 INFO - 'install', 06:17:48 INFO - 'run-tests'), 06:17:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:17:48 INFO - 'download_minidump_stackwalk': True, 06:17:48 INFO - 'download_symbols': 'ondemand', 06:17:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:17:48 INFO - 'tooltool.py': '/tools/tooltool.py', 06:17:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:17:48 INFO - '/tools/misc-python/virtualenv.py')}, 06:17:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:17:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:17:48 INFO - 'installer_path': 'installer.exe', 06:17:48 INFO - 'log_level': 'info', 06:17:48 INFO - 'log_name': 'talos', 06:17:48 INFO - 'log_to_console': True, 06:17:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:17:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:17:48 INFO - 'opt_config_files': (), 06:17:48 INFO - 'pip_index': False, 06:17:48 INFO - 'sps_profile': False, 06:17:48 INFO - 'sps_profile_interval': 0, 06:17:48 INFO - 'suite': 'dromaeojs', 06:17:48 INFO - 'system_bits': '32', 06:17:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:17:48 INFO - 'title': 'talos-linux64-ix-028', 06:17:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:17:48 INFO - 'use_talos_json': True, 06:17:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:17:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:17:48 INFO - 'work_dir': 'build'} 06:17:48 INFO - ##### 06:17:48 INFO - ##### Running clobber step. 06:17:48 INFO - ##### 06:17:48 INFO - Running pre-action listener: _resource_record_pre_action 06:17:48 INFO - Running main action method: clobber 06:17:48 INFO - rmtree: /builds/slave/test-pgo/build 06:17:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:17:52 INFO - Running post-action listener: _resource_record_post_action 06:17:52 INFO - ##### 06:17:52 INFO - ##### Running read-buildbot-config step. 06:17:52 INFO - ##### 06:17:52 INFO - Running pre-action listener: _resource_record_pre_action 06:17:52 INFO - Running main action method: read_buildbot_config 06:17:52 INFO - Using buildbot properties: 06:17:52 INFO - { 06:17:52 INFO - "properties": { 06:17:52 INFO - "buildnumber": 98, 06:17:52 INFO - "product": "firefox", 06:17:52 INFO - "script_repo_revision": "production", 06:17:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:17:52 INFO - "repository": "", 06:17:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:17:52 INFO - "buildid": "20160202035417", 06:17:52 INFO - "slavename": "talos-linux64-ix-028", 06:17:52 INFO - "pgo_build": "True", 06:17:52 INFO - "basedir": "/builds/slave/test-pgo", 06:17:52 INFO - "project": "", 06:17:52 INFO - "platform": "ubuntu64_hw", 06:17:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:17:52 INFO - "slavebuilddir": "test", 06:17:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:17:52 INFO - "branch": "mozilla-beta", 06:17:52 INFO - "repo_path": "releases/mozilla-beta", 06:17:52 INFO - "stage_platform": "linux64-pgo", 06:17:52 INFO - "builduid": "78473f32d14a4ebd82e6ad6c6b2526d7", 06:17:52 INFO - "revision": "2a25445490e3" 06:17:52 INFO - }, 06:17:52 INFO - "sourcestamp": { 06:17:52 INFO - "repository": "", 06:17:52 INFO - "hasPatch": false, 06:17:52 INFO - "project": "", 06:17:52 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 06:17:52 INFO - "changes": [ 06:17:52 INFO - { 06:17:52 INFO - "category": null, 06:17:52 INFO - "files": [ 06:17:52 INFO - { 06:17:52 INFO - "url": null, 06:17:52 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2" 06:17:52 INFO - } 06:17:52 INFO - ], 06:17:52 INFO - "repository": "", 06:17:52 INFO - "rev": "2a25445490e3", 06:17:52 INFO - "who": "sendchange", 06:17:52 INFO - "when": 1454422647, 06:17:52 INFO - "number": 7549557, 06:17:52 INFO - "comments": "Backed out changeset 6949f81de839 (bug 1243591) for test bustage", 06:17:52 INFO - "project": "", 06:17:52 INFO - "at": "Tue 02 Feb 2016 06:17:27", 06:17:52 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 06:17:52 INFO - "revlink": "", 06:17:52 INFO - "properties": [ 06:17:52 INFO - [ 06:17:52 INFO - "buildid", 06:17:52 INFO - "20160202035417", 06:17:52 INFO - "Change" 06:17:52 INFO - ], 06:17:52 INFO - [ 06:17:52 INFO - "builduid", 06:17:52 INFO - "78473f32d14a4ebd82e6ad6c6b2526d7", 06:17:52 INFO - "Change" 06:17:52 INFO - ], 06:17:52 INFO - [ 06:17:52 INFO - "pgo_build", 06:17:52 INFO - "True", 06:17:52 INFO - "Change" 06:17:52 INFO - ] 06:17:52 INFO - ], 06:17:52 INFO - "revision": "2a25445490e3" 06:17:52 INFO - } 06:17:52 INFO - ], 06:17:52 INFO - "revision": "2a25445490e3" 06:17:52 INFO - } 06:17:52 INFO - } 06:17:52 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2. 06:17:52 INFO - Running post-action listener: _resource_record_post_action 06:17:52 INFO - ##### 06:17:52 INFO - ##### Running download-and-extract step. 06:17:52 INFO - ##### 06:17:52 INFO - Running pre-action listener: _resource_record_pre_action 06:17:52 INFO - Running main action method: download_and_extract 06:17:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/test_packages.json 06:17:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:17:52 INFO - Downloaded 1270 bytes. 06:17:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:17:52 INFO - Using the following test package requirements: 06:17:52 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:17:52 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:17:52 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'jsshell-linux-x86_64.zip'], 06:17:52 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:17:52 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:17:52 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 06:17:52 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 06:17:52 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:17:52 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 06:17:52 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 06:17:52 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:17:52 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:52 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:52 INFO - Downloaded 21580268 bytes. 06:17:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:17:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:17:54 INFO - Return code: 0 06:17:54 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:54 INFO - Downloaded 21580268 bytes. 06:17:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:17:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 06:17:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:17:55 INFO - Return code: 0 06:17: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')]} 06:17:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:17:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:17:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:18:11 WARNING - URL Error: http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:18:11 INFO - Running command: ['nslookup', u'archive.mozilla.org'] 06:18:11 INFO - Copy/paste: nslookup archive.mozilla.org 06:18:11 INFO - Server: 10.26.75.40 06:18:11 INFO - Address: 10.26.75.40#53 06:18:11 INFO - archive.mozilla.org canonical name = d34chcsvb7ug62.cloudfront.net. 06:18:11 INFO - Name: d34chcsvb7ug62.cloudfront.net 06:18:11 INFO - Address: 54.192.118.43 06:18:11 INFO - Return code: 0 06:18:11 INFO - retry: attempt #1 caught exception: 06:18:11 INFO - retry: Failed, sleeping 30 seconds before retrying 06:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 06:18:48 INFO - Downloaded 11132038 bytes. 06:18:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:18:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 06:18:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:18:48 INFO - Return code: 0 06:18: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')]} 06:18:48 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:18:48 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:18:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:50 INFO - Downloaded 57945805 bytes. 06:18:50 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:18:50 INFO - mkdir: /builds/slave/test-pgo/properties 06:18:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:18:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:18:50 INFO - Contents: 06:18:50 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2 06:18:50 INFO - Running post-action listener: _resource_record_post_action 06:18:50 INFO - Running post-action listener: set_extra_try_arguments 06:18:50 INFO - ##### 06:18:50 INFO - ##### Running populate-webroot step. 06:18:50 INFO - ##### 06:18:50 INFO - Running pre-action listener: _resource_record_pre_action 06:18:50 INFO - Running main action method: populate_webroot 06:18:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:18:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:18:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:18:50 INFO - '--tppagecycles', 06:18:50 INFO - '7'], 06:18:50 INFO - 'tests': ['tsvgm']}}, 06:18:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:18:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:18:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:18:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:18:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:18:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'tests': ['damp', 'tps']}, 06:18:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['damp', 'tps']}, 06:18:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:18:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:18:50 INFO - 'other': {'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'other_l64': {'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'other_nol64': {'tests': ['a11yr', 06:18:50 INFO - 'ts_paint', 06:18:50 INFO - 'tpaint', 06:18:50 INFO - 'sessionrestore', 06:18:50 INFO - 'sessionrestore_no_auto_restore']}, 06:18:50 INFO - 'svgr': {'tests': ['tsvgx', 06:18:50 INFO - 'tsvgr_opacity', 06:18:50 INFO - 'tart', 06:18:50 INFO - 'tscrollx', 06:18:50 INFO - 'cart']}, 06:18:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['tsvgx', 06:18:50 INFO - 'tsvgr_opacity', 06:18:50 INFO - 'tart', 06:18:50 INFO - 'tscrollx', 06:18:50 INFO - 'cart']}, 06:18:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'tests': ['tp5o']}, 06:18:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'talos_options': ['--e10s'], 06:18:50 INFO - 'tests': ['tp5o']}, 06:18:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'talos_options': ['--xperf_path', 06:18:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:50 INFO - 'tests': ['tp5n']}, 06:18:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:18:50 INFO - 'talos_options': ['--e10s', 06:18:50 INFO - '--xperf_path', 06:18:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:18:50 INFO - 'tests': ['tp5n']}}, 06:18:50 INFO - 'talos.zip': {'path': '', 06:18:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:18:50 INFO - Running post-action listener: _resource_record_post_action 06:18:50 INFO - ##### 06:18:50 INFO - ##### Running create-virtualenv step. 06:18:50 INFO - ##### 06:18:50 INFO - Running pre-action listener: _resource_record_pre_action 06:18:50 INFO - Running main action method: create_virtualenv 06:18:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:18:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:18:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:18:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:18:50 INFO - Using real prefix '/usr' 06:18:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:18:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:18:53 INFO - Installing pip.................done. 06:18:53 INFO - Return code: 0 06:18:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:18:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:18:53 INFO - Using env: {'DISPLAY': ':0', 06:18:53 INFO - 'HOME': '/home/cltbld', 06:18:53 INFO - 'LANG': 'en_US.UTF-8', 06:18:53 INFO - 'LANGUAGE': 'en_US:en', 06:18:53 INFO - 'LOGNAME': 'cltbld', 06:18:53 INFO - 'MAIL': '/var/mail/cltbld', 06:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:53 INFO - 'MOZ_NO_REMOTE': '1', 06:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:53 INFO - 'NO_EM_RESTART': '1', 06:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:18:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:18:53 INFO - 'SHELL': '/bin/bash', 06:18:53 INFO - 'SHLVL': '1', 06:18:53 INFO - 'TERM': 'linux', 06:18:53 INFO - 'TMOUT': '86400', 06:18:53 INFO - 'USER': 'cltbld', 06:18:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:53 INFO - '_': '/tools/buildbot/bin/python'} 06:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:18:53 INFO - Cleaning up... 06:18:53 INFO - Return code: 0 06:18:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:18:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:18:53 INFO - Using env: {'DISPLAY': ':0', 06:18:53 INFO - 'HOME': '/home/cltbld', 06:18:53 INFO - 'LANG': 'en_US.UTF-8', 06:18:53 INFO - 'LANGUAGE': 'en_US:en', 06:18:53 INFO - 'LOGNAME': 'cltbld', 06:18:53 INFO - 'MAIL': '/var/mail/cltbld', 06:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:53 INFO - 'MOZ_NO_REMOTE': '1', 06:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:53 INFO - 'NO_EM_RESTART': '1', 06:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:18:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:18:53 INFO - 'SHELL': '/bin/bash', 06:18:53 INFO - 'SHLVL': '1', 06:18:53 INFO - 'TERM': 'linux', 06:18:53 INFO - 'TMOUT': '86400', 06:18:53 INFO - 'USER': 'cltbld', 06:18:53 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:53 INFO - '_': '/tools/buildbot/bin/python'} 06:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:53 INFO - Downloading/unpacking psutil>=0.7.1 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:18:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:55 INFO - Installing collected packages: psutil 06:18:55 INFO - Running setup.py install for psutil 06:18:55 INFO - building 'psutil._psutil_linux' extension 06:18:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:18:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:18:55 INFO - building 'psutil._psutil_posix' extension 06:18:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:18:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:18:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:18:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:18:56 INFO - Successfully installed psutil 06:18:56 INFO - Cleaning up... 06:18:56 INFO - Return code: 0 06:18:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:18:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:18:56 INFO - Using env: {'DISPLAY': ':0', 06:18:56 INFO - 'HOME': '/home/cltbld', 06:18:56 INFO - 'LANG': 'en_US.UTF-8', 06:18:56 INFO - 'LANGUAGE': 'en_US:en', 06:18:56 INFO - 'LOGNAME': 'cltbld', 06:18:56 INFO - 'MAIL': '/var/mail/cltbld', 06:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:56 INFO - 'MOZ_NO_REMOTE': '1', 06:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:56 INFO - 'NO_EM_RESTART': '1', 06:18:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:18:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:18:56 INFO - 'SHELL': '/bin/bash', 06:18:56 INFO - 'SHLVL': '1', 06:18:56 INFO - 'TERM': 'linux', 06:18:56 INFO - 'TMOUT': '86400', 06:18:56 INFO - 'USER': 'cltbld', 06:18:56 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:56 INFO - '_': '/tools/buildbot/bin/python'} 06:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:18:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:18:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:18:58 INFO - Installing collected packages: mozsystemmonitor 06:18:58 INFO - Running setup.py install for mozsystemmonitor 06:18:58 INFO - Successfully installed mozsystemmonitor 06:18:58 INFO - Cleaning up... 06:18:58 INFO - Return code: 0 06:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:18: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')]} 06:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18: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')]} 06:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:18:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:18:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:18:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:18:58 INFO - Using env: {'DISPLAY': ':0', 06:18:58 INFO - 'HOME': '/home/cltbld', 06:18:58 INFO - 'LANG': 'en_US.UTF-8', 06:18:58 INFO - 'LANGUAGE': 'en_US:en', 06:18:58 INFO - 'LOGNAME': 'cltbld', 06:18:58 INFO - 'MAIL': '/var/mail/cltbld', 06:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:18:58 INFO - 'MOZ_NO_REMOTE': '1', 06:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:18:58 INFO - 'NO_EM_RESTART': '1', 06:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:18:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:18:58 INFO - 'SHELL': '/bin/bash', 06:18:58 INFO - 'SHLVL': '1', 06:18:58 INFO - 'TERM': 'linux', 06:18:58 INFO - 'TMOUT': '86400', 06:18:58 INFO - 'USER': 'cltbld', 06:18:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:18:58 INFO - '_': '/tools/buildbot/bin/python'} 06:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:18: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 06:19:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:19:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19: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 06:19:00 INFO - Downloading docopt-0.6.1.tar.gz 06:19:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:01 INFO - Running setup.py install for blobuploader 06:19:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:19:01 INFO - Running setup.py install for requests 06:19:01 INFO - Running setup.py install for docopt 06:19:01 INFO - Successfully installed blobuploader requests docopt 06:19:01 INFO - Cleaning up... 06:19:01 INFO - Return code: 0 06:19:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:19:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:19:01 INFO - Using env: {'DISPLAY': ':0', 06:19:01 INFO - 'HOME': '/home/cltbld', 06:19:01 INFO - 'LANG': 'en_US.UTF-8', 06:19:01 INFO - 'LANGUAGE': 'en_US:en', 06:19:01 INFO - 'LOGNAME': 'cltbld', 06:19:01 INFO - 'MAIL': '/var/mail/cltbld', 06:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:01 INFO - 'MOZ_NO_REMOTE': '1', 06:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:01 INFO - 'NO_EM_RESTART': '1', 06:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:01 INFO - 'SHELL': '/bin/bash', 06:19:01 INFO - 'SHLVL': '1', 06:19:01 INFO - 'TERM': 'linux', 06:19:01 INFO - 'TMOUT': '86400', 06:19:01 INFO - 'USER': 'cltbld', 06:19:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:01 INFO - '_': '/tools/buildbot/bin/python'} 06:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:19:01 INFO - Running setup.py (path:/tmp/pip-ZSEwBq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:19:01 INFO - Running setup.py (path:/tmp/pip-2BajKq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:19:02 INFO - Running setup.py (path:/tmp/pip-LMNdOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:19:02 INFO - Running setup.py (path:/tmp/pip-cGCWoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:19:02 INFO - Running setup.py (path:/tmp/pip-tIj3FD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:19:02 INFO - Running setup.py (path:/tmp/pip-YaaDs_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:19:02 INFO - Running setup.py (path:/tmp/pip-JPGDfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:19:02 INFO - Running setup.py (path:/tmp/pip-jfWcUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:19:02 INFO - Running setup.py (path:/tmp/pip-cS7vlJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:19:02 INFO - Running setup.py (path:/tmp/pip-lntR7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:19:02 INFO - Running setup.py (path:/tmp/pip-q0R3cW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:19:02 INFO - Running setup.py (path:/tmp/pip-ZiFjzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:19:02 INFO - Running setup.py (path:/tmp/pip-E8ZB0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:19:02 INFO - Running setup.py (path:/tmp/pip-eDzd4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:19:02 INFO - Running setup.py (path:/tmp/pip-i3HvZ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:19:02 INFO - Running setup.py (path:/tmp/pip-CuB1Da-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:19:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:19:03 INFO - Running setup.py (path:/tmp/pip-LQ2KMr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:03 INFO - Running setup.py install for manifestparser 06:19:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Running setup.py install for mozcrash 06:19:03 INFO - Running setup.py install for mozdebug 06:19:03 INFO - Running setup.py install for mozdevice 06:19:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Running setup.py install for mozfile 06:19:03 INFO - Running setup.py install for mozhttpd 06:19:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Running setup.py install for mozinfo 06:19:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Running setup.py install for mozInstall 06:19:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:19:03 INFO - Running setup.py install for mozleak 06:19:04 INFO - Running setup.py install for mozlog 06:19:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Running setup.py install for moznetwork 06:19:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Running setup.py install for mozprocess 06:19:04 INFO - Running setup.py install for mozprofile 06:19:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Running setup.py install for mozrunner 06:19:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Running setup.py install for mozscreenshot 06:19:04 INFO - Running setup.py install for moztest 06:19:04 INFO - Running setup.py install for mozversion 06:19:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:19:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:04 INFO - Cleaning up... 06:19:04 INFO - Return code: 0 06:19:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:19:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:19:04 INFO - Using env: {'DISPLAY': ':0', 06:19:04 INFO - 'HOME': '/home/cltbld', 06:19:04 INFO - 'LANG': 'en_US.UTF-8', 06:19:04 INFO - 'LANGUAGE': 'en_US:en', 06:19:04 INFO - 'LOGNAME': 'cltbld', 06:19:04 INFO - 'MAIL': '/var/mail/cltbld', 06:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:04 INFO - 'MOZ_NO_REMOTE': '1', 06:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:04 INFO - 'NO_EM_RESTART': '1', 06:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:04 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:04 INFO - 'SHELL': '/bin/bash', 06:19:04 INFO - 'SHLVL': '1', 06:19:04 INFO - 'TERM': 'linux', 06:19:04 INFO - 'TMOUT': '86400', 06:19:04 INFO - 'USER': 'cltbld', 06:19:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:04 INFO - '_': '/tools/buildbot/bin/python'} 06:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:19:05 INFO - Running setup.py (path:/tmp/pip-L2RvUZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:19:05 INFO - Running setup.py (path:/tmp/pip-agisd0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:19:05 INFO - Running setup.py (path:/tmp/pip-fS8g8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:19:05 INFO - Running setup.py (path:/tmp/pip-Ffb5ky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:19:05 INFO - Running setup.py (path:/tmp/pip-t8OAjJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:19:05 INFO - Running setup.py (path:/tmp/pip-QJR5h6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:19:05 INFO - Running setup.py (path:/tmp/pip-YRAGk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:19:05 INFO - Running setup.py (path:/tmp/pip-fmMiG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:19:05 INFO - Running setup.py (path:/tmp/pip-26gw1J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:19:05 INFO - Running setup.py (path:/tmp/pip-oTWgXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:19:05 INFO - Running setup.py (path:/tmp/pip-xE9nZb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:19:05 INFO - Running setup.py (path:/tmp/pip-qZeIVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 06:19:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:19:05 INFO - Running setup.py (path:/tmp/pip-EZkDOd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:19:06 INFO - Running setup.py (path:/tmp/pip-HCeQ5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 06:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:19:06 INFO - Running setup.py (path:/tmp/pip-xqToPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 06:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:19:06 INFO - Running setup.py (path:/tmp/pip-YlJ7OY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 06:19:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:19:06 INFO - Running setup.py (path:/tmp/pip-RjxsE3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:08 INFO - Downloading blessings-1.6.tar.gz 06:19:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:08 INFO - Installing collected packages: blessings 06:19:08 INFO - Running setup.py install for blessings 06:19:08 INFO - Successfully installed blessings 06:19:08 INFO - Cleaning up... 06:19:08 INFO - Return code: 0 06:19:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:19:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:19:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:19:08 INFO - Reading from file tmpfile_stdout 06:19:08 INFO - Current package versions: 06:19:08 INFO - argparse == 1.2.1 06:19:08 INFO - blessings == 1.6 06:19:08 INFO - blobuploader == 1.2.4 06:19:08 INFO - docopt == 0.6.1 06:19:08 INFO - manifestparser == 1.1 06:19:08 INFO - mozInstall == 1.12 06:19:08 INFO - mozcrash == 0.16 06:19:08 INFO - mozdebug == 0.1 06:19:08 INFO - mozdevice == 0.47 06:19:08 INFO - mozfile == 1.2 06:19:08 INFO - mozhttpd == 0.7 06:19:08 INFO - mozinfo == 0.9 06:19:08 INFO - mozleak == 0.1 06:19:08 INFO - mozlog == 3.1 06:19:08 INFO - moznetwork == 0.27 06:19:08 INFO - mozprocess == 0.22 06:19:08 INFO - mozprofile == 0.27 06:19:08 INFO - mozrunner == 6.11 06:19:08 INFO - mozscreenshot == 0.1 06:19:08 INFO - mozsystemmonitor == 0.0 06:19:08 INFO - moztest == 0.7 06:19:08 INFO - mozversion == 1.4 06:19:08 INFO - psutil == 3.1.1 06:19:08 INFO - requests == 1.2.3 06:19:08 INFO - wsgiref == 0.1.2 06:19:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:19:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:19:08 INFO - Using env: {'DISPLAY': ':0', 06:19:08 INFO - 'HOME': '/home/cltbld', 06:19:08 INFO - 'LANG': 'en_US.UTF-8', 06:19:08 INFO - 'LANGUAGE': 'en_US:en', 06:19:08 INFO - 'LOGNAME': 'cltbld', 06:19:08 INFO - 'MAIL': '/var/mail/cltbld', 06:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:08 INFO - 'MOZ_NO_REMOTE': '1', 06:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:08 INFO - 'NO_EM_RESTART': '1', 06:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:08 INFO - 'SHELL': '/bin/bash', 06:19:08 INFO - 'SHLVL': '1', 06:19:08 INFO - 'TERM': 'linux', 06:19:08 INFO - 'TMOUT': '86400', 06:19:08 INFO - 'USER': 'cltbld', 06:19:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:08 INFO - '_': '/tools/buildbot/bin/python'} 06:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:19: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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:19: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:19:08 INFO - Cleaning up... 06:19:08 INFO - Return code: 0 06:19:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test-pgo/build 06:19:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 jsonschema 06:19:08 INFO - Using env: {'DISPLAY': ':0', 06:19:08 INFO - 'HOME': '/home/cltbld', 06:19:08 INFO - 'LANG': 'en_US.UTF-8', 06:19:08 INFO - 'LANGUAGE': 'en_US:en', 06:19:08 INFO - 'LOGNAME': 'cltbld', 06:19:08 INFO - 'MAIL': '/var/mail/cltbld', 06:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:08 INFO - 'MOZ_NO_REMOTE': '1', 06:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:08 INFO - 'NO_EM_RESTART': '1', 06:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:08 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:08 INFO - 'SHELL': '/bin/bash', 06:19:08 INFO - 'SHLVL': '1', 06:19:08 INFO - 'TERM': 'linux', 06:19:08 INFO - 'TMOUT': '86400', 06:19:08 INFO - 'USER': 'cltbld', 06:19:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:08 INFO - '_': '/tools/buildbot/bin/python'} 06:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:09 INFO - Downloading/unpacking jsonschema 06:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:19:10 INFO - Downloading/unpacking functools32 (from jsonschema) 06:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:11 INFO - Downloading functools32-3.2.3-2.tar.gz 06:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:19:11 INFO - warning: no files found matching '*.txt' 06:19:11 INFO - no previously-included directories found matching 'build' 06:19:11 INFO - no previously-included directories found matching 'dist' 06:19:11 INFO - no previously-included directories found matching '.git*' 06:19:11 INFO - Installing collected packages: jsonschema, functools32 06:19:11 INFO - Running setup.py install for functools32 06:19:11 INFO - warning: no files found matching '*.txt' 06:19:11 INFO - no previously-included directories found matching 'build' 06:19:11 INFO - no previously-included directories found matching 'dist' 06:19:11 INFO - no previously-included directories found matching '.git*' 06:19:11 INFO - Successfully installed jsonschema functools32 06:19:11 INFO - Cleaning up... 06:19:11 INFO - Return code: 0 06:19:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a1719f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x195d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, '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': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:19:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test-pgo/build 06:19:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 flake8 06:19:11 INFO - Using env: {'DISPLAY': ':0', 06:19:11 INFO - 'HOME': '/home/cltbld', 06:19:11 INFO - 'LANG': 'en_US.UTF-8', 06:19:11 INFO - 'LANGUAGE': 'en_US:en', 06:19:11 INFO - 'LOGNAME': 'cltbld', 06:19:11 INFO - 'MAIL': '/var/mail/cltbld', 06:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:11 INFO - 'MOZ_NO_REMOTE': '1', 06:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:11 INFO - 'NO_EM_RESTART': '1', 06:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:11 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:11 INFO - 'SHELL': '/bin/bash', 06:19:11 INFO - 'SHLVL': '1', 06:19:11 INFO - 'TERM': 'linux', 06:19:11 INFO - 'TMOUT': '86400', 06:19:11 INFO - 'USER': 'cltbld', 06:19:11 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:11 INFO - '_': '/tools/buildbot/bin/python'} 06:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:11 INFO - Downloading/unpacking flake8 06:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:19:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:19:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:19:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:19:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:19:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:19:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:19:14 INFO - no previously-included directories found matching 'docs/_build' 06:19:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:19:14 INFO - Running setup.py install for pep8 06:19:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:19:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:19:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:19:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:19:14 INFO - no previously-included directories found matching 'docs/_build' 06:19:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:19:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:19:14 INFO - Cleaning up... 06:19:14 INFO - Return code: 0 06:19:14 INFO - Running post-action listener: _resource_record_post_action 06:19:14 INFO - Running post-action listener: _start_resource_monitoring 06:19:14 INFO - Starting resource monitoring. 06:19:14 INFO - ##### 06:19:14 INFO - ##### Running install step. 06:19:14 INFO - ##### 06:19:14 INFO - Running pre-action listener: _resource_record_pre_action 06:19:14 INFO - Running main action method: install 06:19:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:19:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:19:14 INFO - Reading from file tmpfile_stdout 06:19:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:19:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:19:14 INFO - Reading from file tmpfile_stdout 06:19:14 INFO - Output received: 06:19:14 INFO - Usage: mozinstall [options] installer 06:19:14 INFO - Options: 06:19:14 INFO - -h, --help show this help message and exit 06:19:14 INFO - -d DEST, --destination=DEST 06:19:14 INFO - Directory to install application into. [default: 06:19:14 INFO - "/builds/slave/test-pgo"] 06:19:14 INFO - --app=APP Application being installed. [default: firefox] 06:19:14 INFO - mkdir: /builds/slave/test-pgo/build/application 06:19:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:19:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:19:29 INFO - Reading from file tmpfile_stdout 06:19:29 INFO - Output received: 06:19:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:19:29 INFO - Running post-action listener: _resource_record_post_action 06:19:29 INFO - ##### 06:19:29 INFO - ##### Running run-tests step. 06:19:29 INFO - ##### 06:19:29 INFO - Running pre-action listener: _resource_record_pre_action 06:19:29 INFO - Running main action method: run_tests 06:19:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:19:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:19:29 INFO - Python 2.7.3 06:19:29 INFO - Return code: 0 06:19:29 INFO - grabbing minidump binary from tooltool 06:19:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:29 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 0x19ec350>, '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 0x19ed250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19ed6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:19:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 06:19:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:19:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:19:29 INFO - Return code: 0 06:19:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:19:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:19:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:19:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:19:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:19:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:19:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:19:30 INFO - Return code: 0 06:19:30 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:19:30 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 06:19:30 INFO - Using env: {'DISPLAY': ':0', 06:19:30 INFO - 'HOME': '/home/cltbld', 06:19:30 INFO - 'LANG': 'en_US.UTF-8', 06:19:30 INFO - 'LANGUAGE': 'en_US:en', 06:19:30 INFO - 'LOGNAME': 'cltbld', 06:19:30 INFO - 'MAIL': '/var/mail/cltbld', 06:19:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:19:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:30 INFO - 'MOZ_NO_REMOTE': '1', 06:19:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:30 INFO - 'NO_EM_RESTART': '1', 06:19:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:19:30 INFO - 'PWD': '/builds/slave/test-pgo', 06:19:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:19:30 INFO - 'SHELL': '/bin/bash', 06:19:30 INFO - 'SHLVL': '1', 06:19:30 INFO - 'TERM': 'linux', 06:19:30 INFO - 'TMOUT': '86400', 06:19:30 INFO - 'USER': 'cltbld', 06:19:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334', 06:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:30 INFO - '_': '/tools/buildbot/bin/python'} 06:19:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 06:19:30 INFO - mozversion INFO | application_buildid: 20160202035417 06:19:30 INFO - mozversion INFO | application_changeset: 2a25445490e3fe031e4fb5580fc3472f37bc5c44 06:19:30 INFO - mozversion INFO | application_display_name: Nightly 06:19:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:19:30 INFO - mozversion INFO | application_name: Firefox 06:19:30 INFO - mozversion INFO | application_remotingname: firefox 06:19:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:30 INFO - mozversion INFO | application_vendor: Mozilla 06:19:30 INFO - mozversion INFO | application_version: 45.0 06:19:30 INFO - mozversion INFO | platform_buildid: 20160202035417 06:19:30 INFO - mozversion INFO | platform_changeset: 2a25445490e3fe031e4fb5580fc3472f37bc5c44 06:19:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:19:30 INFO - mozversion INFO | platform_version: 45.0 06:19:30 INFO - 2016-02-02 06:19:30,531 DEBUG : using testdate: 1454422770 06:19:30 INFO - 2016-02-02 06:19:30,531 DEBUG : actual date: 1454422770 06:19:30 INFO - 2016-02-02 06:19:30,579 INFO : starting webserver on 'localhost:43710' 06:19:30 INFO - 2016-02-02 06:19:30,580 INFO : Starting test suite talos-linux64-ix-028 06:19:30 INFO - 2016-02-02 06:19:30,580 INFO : Starting test dromaeo_css 06:19:30 INFO - 2016-02-02 06:19:30,580 DEBUG : operating with platform_type : linux_ 06:19:30 INFO - 2016-02-02 06:19:30,581 INFO : Initialising browser for dromaeo_css test... 06:19:30 INFO - 2016-02-02 06:19:30,597 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwZYs9v/profile http://localhost:43710/getInfo.html 06:19:34 INFO - 2016-02-02 06:19:34,289 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:19:34 INFO - 2016-02-02 06:19:34,289 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:19:34 INFO - 2016-02-02 06:19:34,289 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:19:34 INFO - 2016-02-02 06:19:34,289 DEBUG : BROWSER_OUTPUT: __metrics 06:19:34 INFO - 2016-02-02 06:19:34,446 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:35 INFO - 2016-02-02 06:19:35,417 INFO : Browser initialized. 06:19:35 INFO - 2016-02-02 06:19:35,418 INFO : Running cycle 1/1 for dromaeo_css test... 06:19:35 INFO - 2016-02-02 06:19:35,418 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwZYs9v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:19:47 INFO - 2016-02-02 06:19:47,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 133709824 06:19:47 INFO - 2016-02-02 06:19:47,223 DEBUG : BROWSER_OUTPUT: 06:20:37 INFO - 2016-02-02 06:20:37,963 DEBUG : BROWSER_OUTPUT: 1454422837958 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:22:46 INFO - 2016-02-02 06:22:46,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43710/tests/dromaeo/cssquery-ext.html) 06:22:47 INFO - 2016-02-02 06:22:47,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 230551552 06:22:47 INFO - 2016-02-02 06:22:47,180 DEBUG : BROWSER_OUTPUT: 06:25:49 INFO - 2016-02-02 06:25:49,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-ext.html (next: http://localhost:43710/tests/dromaeo/cssquery-jquery.html) 06:25:49 INFO - 2016-02-02 06:25:49,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 215453696 06:25:49 INFO - 2016-02-02 06:25:49,755 DEBUG : BROWSER_OUTPUT: 06:28:51 INFO - 2016-02-02 06:28:51,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43710/tests/dromaeo/cssquery-mootools.html) 06:28:52 INFO - 2016-02-02 06:28:52,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 214487040 06:28:52 INFO - 2016-02-02 06:28:52,047 DEBUG : BROWSER_OUTPUT: 06:31:53 INFO - 2016-02-02 06:31:53,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43710/tests/dromaeo/cssquery-prototype.html) 06:31:54 INFO - 2016-02-02 06:31:54,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 201478144 06:31:54 INFO - 2016-02-02 06:31:54,333 DEBUG : BROWSER_OUTPUT: 06:34:56 INFO - 2016-02-02 06:34:56,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43710/tests/dromaeo/cssquery-yui.html) 06:34:57 INFO - 2016-02-02 06:34:57,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 199639040 06:34:57 INFO - 2016-02-02 06:34:57,329 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/dromaeo/cssquery-yui.html (next: http://localhost:43710/tests/dromaeo/cssquery-dojo.html) 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 244666368 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3250.2199472126686;3344.214109684225;3373.915652108697;3374.4432168692165;3393.6945674889257;5461.78152873885;5566.777328906839;5574.247476590659;5591.720413979295;5593.608447408688;5548.167774833777;5596.496315331629;5608.775648974036;5618.634788738739;5621.269234999455;4964.578010869081;5045.949540504585;5056.191009438472;5083.288339632454;5159.690418574897;4986.326845875815;4989.476105008976;5005.324281222043;5063.8480845574695;5112.233165025257;5003.974980125113;5041.243813427978;5050.595952323805;5066.06277838601;5087.643864929457;5081.491850814908;5119.667221630582;5133.743312834344;5152.587792976553;5153.994970980661;4889.3643826302705;4903.436104847917;4992.301077849068;5062.265971434122;5071.442141364447;5293.841184764463;5298.682079075229;5362.812301569426;5370.785168593291;5374.838754837361;5887.528997680218;5992.0712289595185;5998.8500287492725;6006.819795406145;6014.6391216527145;5724.570657200727;5824;5967.283925928873;6024.0662697282;6111.786087486961;5600.299962504687;5609.326880774333;5610.719464026783;5612.803551875706;5622.465865742748;6020.518358531307;6031.185789918392;6035.094735789579;6039.094135879654;6040.728167232485;5686.175504551817;5713.514351280104;5789.681567513827;5850.882982340329;5863.120531920246;5973.253343332083;5974.163617093611;5981.282246130492;5981.880362392815;5985.910211346833;5933.762649493972;5937.614055086406;5938.257717785277;5938.317093534299;5941.910871336933;5649.06790379591;5706.686132262683;5724.742386592613;5835.912461313083;5863.589548731633;4558.8632341029825;4579.038401935631;4595.149897269016;4603.516630753789;4627.514111018362;4023.4769479967417;4135.77253251068;4140.171965606891;4148.274052040881;4153.044799696087;5475.835724928259;5536.695481748462;5595.38450770415;5615.6630602164005;5646;5935.109733539917;5982.312034116046;5984.491318237999;5987.730552125165;5995.490383317467;5437.15724062763;5552.167174923794;5658.434156584309;5691.317041954909;5698;5055.292259083732;5137.743112844418;5145;5153.819616313411;5182.5594824439595;5974.970125149346;5983.850403739942;5990.371011043778;5995.250593675791;6067.393260673897;5649.68926709035;5728.398518155534;5797.275340582427;5882.911756323573;5914.4381283777975;6104.9389506106145;6135.515116377874;6136.404534820889;6141.416565426277;6142.6314421134875;5924.851878702894;5963.52291816645;5967.9701601491715;5970.283565971938;5976.850578735392;5759.2512973313205;5804.506616937439;5857.970710146422;5951.672658003851;6042.274927008787;5826;5826.970865145647;5845.590808643354;5852.7658893645485;5874.03078492044;5807.041838096667;5810.680412577349;5813.244278243801;5819.70901454934;5821.243238378984;5578.972105139448;5659.320881494247;5660.349059858169;5750.712464376848;5803.680797556175;5702.230198923258;5864.648121112747;5881.2942446906645;5920.644761314335;5933.347331793586;5696.943030569641;5779.653220806765;5788.102844059177;5790.39200883918;5803.8549036274435 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |1;ext.html;595.8957182493066;635.6853357587995;639.3893831391022;643.1446176585142;645.5545673485296;32811.99999999997;39454.40818387726;39841;39847;39901.60098399015;44648.776756116255;45113.32330015044;45160.77419612905;45189.7740511297;45205.32192017123;7993.840123197561;8115.1073381927945;9026.638934442632;9229.400088994194;9236.6305347786;10611.416372099531;10863.076638485738;10942.835857462105;10952.397618130999;10957.12343012561;10636.840447393295;10660.307080039773;10751.193660475496;10755.462226888663;10764.354138751662;10530.684079477627;10616.628418005372;10626.787464250672;10633.627823026234;10641.308314959502;10484.318519296297;10614.097801686867;10614.363138211655;10619.044286014296;10624.415657138854;41556.58443415588;42072.57927420748;42091;42114.36828447576;42119.57880421218;3543.2382037861985;3546.29074185164;3693.8891833245048;3774.9056273593105;3975.940360894589;31776.364472710415;35928.64071359279;36112.458313125324;36751;37146;4027.416024676435;4046.1705350403095;4127.2570937231285;4165.562615925345;4190.350495673176;289386;295164;296002;296497;296739;61927.690361548805;62892.79875204346;68503.65748171326;76062.23937760551;77438.6128069356;73964;74362;74470.6276468625;74842.25157748461;75093;17237.31050757981;17369.56576085608;17387.391441299493;17407.129643517772;17469.21388537519;11727.530898763955;11939.940300298444;11955.163138580216;11994;12037;23031.424214394774;23158.18946336904;23367.298981030595;23404.882975585013;23426.18008369699;8980.595873185723;9015.819683606422;9123.224525915371;9162.67930622425;9222.123898229658;1041.505284989639;1087.994560027195;1135.761490087091;1149.5574203931546;1169.561414469574;29753.25616859596;29861.701382986328;30656.693433065382;30712.84643576768;31010;1140.1050175612104;1149.1209224942925;1170.4966864248454;1186.976260474803;1203.9645904522104;13674;15754.842451575567;15808.288627011812;16100.597485062966;16212.189390530426;359996;361947;363690;365045;365528;56470.43529564734;56904.71547642318;56998;57090.42909570934;57104;1364.7611667958067;1373.1829561410943;1373.8007988841562;1450.6228380621114;1474.2481334519687;27443.588346175224;27501.72498275072;27538.449231015667;27698.446031079668;27943.301417464725;41933.37099943564;42283.7885810569;42310.78844605757;42367.36448953207;42373.57626423697;193573;195198;195299;195448;196224;33593.32813343768;33976.490352645225;34148.65851341554;36235.637643623224;36364.27271454609;46672;47060.7646961763;47192.528074718815;47325.52674473211;47979.5202047975;39100.217995640494;39472.605273946894;39700;44135;44740.77629611961;39484;40412.59587404088;44722.77638611786;45408.31887521624;47321.76339118282;38936.610633893295;39182.6081739179;39232.607673922896;39663;39701.80149099236;33311;34341.828290858386;34801.12997175091;34854.477182842784;35764.64235357613;26648.333791655365;27064.864675676494;27186;27378.5893211598;27687.832089533233 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.4661294107661;385.6779589043149;391.73557848452293;392.3330338424679;393.22142158526117;14945.103293802353;16512.422065227704;17013.48959531213;18025.639487210246;18030;11379.374134422624;11608.535658573646;11728.706782330424;18415;18599;4596.517365676606;5239.5546378557865;5248.816291429801;5254.763535640886;5259.658122222043;4047.494063242095;4125.2986992211245;5179;5473.534749546293;5666.206731057655;5580.386157522689;5615.859603509924;5651.8304450866535;5661.46216109471;5663.886722265553;5494.780208791643;5629.634073785191;5639.661620302795;5643.576731745115;5646.237757902672;5420.4850539198715;5444.8366549003595;5445.50990410861;5452.972735136339;5454.645448045864;13712.725745485035;14073.788893166611;14146.434142634282;14152.150870947777;19049.333273335367;2360.681308023412;2366.2073205476186;2421.418859473731;2433.6227884677905;2497.725250222474;10176;10360.274780765349;10395.376277423378;11273.887261127447;13350.666233344147;1778.368679118907;1782.1623836796684;1825.7170138628535;1842.5393651587103;1846.5291350705484;65622.67188664073;67502.3249767501;68022.65988670025;69443.65278173577;69472.30527694759;11197.60808371703;11271.887281127083;11294.717632059264;11304.71738206535;11354.886451135382;14018.29908504591;15139.394424223128;15180.240987950558;15185.924070379577;15186.544403667907;6531.640759758164;6677.799666010027;7724.6137693115115;8042.798930026679;8096.676132954616;7674.117476490163;7739.574323412154;7754.1470438251745;7760.107587627383;7775.883361749578;4529.184746745617;4746.738929358849;4848.224284114524;4918.065567542227;4952.777125029383;1710.0523599093858;1899.9620007599772;1945.5719741656812;1946.98053019468;1994.920203191885;906.7007887397143;964.9855252171224;990.2622546203124;1074.7904158689137;1091.901728844408;17304.13479326054;17428.215730291915;17442.65114697699;17479.65040699179;17854.285828566713;999;1007.6674697350004;1008.2639673038723;1010.2221289607108;1032.2774058159318;9033.187013168847;10086.44524551142;10205.38767673927;10233.641822536176;10288;501175;589383;602162;616677;627617;80955;83908.16091839125;85623.5718821402;86411;86693;1144.0904480937675;1151.9884801151882;1153.2503872482953;1190.541641468041;1202.927824330543;15846.12846293465;15980.920095399913;16011.519654410386;16137;16260.593485162966;33858;34648.653513464546;36919;37002.25995480022;38097.04757381088;45298.54701452943;45597.31604025876;46025.53974460346;46480.070398592514;48742.5125748738;9897.257705672248;10405.06354428105;10425.635102771366;10429.895701042893;10431.94784026075;12148.088893333212;13647.522336718168;18359.265629375208;18560.628787424444;18699.23548768682;15348.923255383652;15552.377904883679;15883;15955.920220398824;15995.200239987722;15216.847831521543;15318.080915145127;15318.234088295318;15642.921785391;15987.200639968187;10679.89320106789;10894.564217431214;10900.727481813017;11011.669649910515;11212.775744485229;15425.537233883002;15768.369265229263;15847.762283565986;15973.920130399274;16009.439669611973;16476.83523164753;16719.582010449834;16737.41419050376;17141.57146071358;17285.740713889554 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1492.5596948900074;1770.1060964213073;1807.3945228348507;1829.8627602929776;1847.6581832361014;7296.890546641798;7650.540967541951;7650.622887880179;7653.655585498659;7664.42879209762;6840.863182736355;6972.4422046236305;7278.199398066208;7453.105627324729;7728.343090837286;2269.557436299918;2275.72691277047;2300.068472268734;2301.2520930697506;2302.366849116498;2059.1969132038516;2261.525079733258;2279.794818466338;2312.8843557822124;2321.2688003278913;2061.938141855747;2264.569731750962;2305.296884450242;2307.3193407944696;2307.7576854430295;2196.8242540596716;2229.832762542808;2231.6987206727126;2248.808851247646;2251.4146321956246;2273.465735552144;2289.977100228993;2311.341267738703;2313.9421514462106;2336.158982766203;7688.38492920565;7793.922060779376;7801.765947021599;7804.882926756103;7805.960970195113;4622.375979242793;4693.9765301173275;4722.197226471474;4722.574968252874;4723.504032076617;3101.6122984626923;3108.362785628941;3141;3190.633077196129;3205.3268813549184;1011.0799172752833;1028.5063169678597;1046.5133712823574;1066.642674703975;1077.6766969909074;10265.332753371007;10269.589216431334;10277.486125693686;10282.177425805918;10297.74255643615;4158;4211.831526738957;4297.742135471882;4306.978465107654;4309.245881970705;8812.427192232484;8851.51316677576;8857.291416686778;8884.822303553892;8892.244159246407;4703.435587729495;4704.85885423431;4717;4721.253136339507;4731.148393289241;4272.957270427318;4286.442762440863;4307.870763877088;4316.6546676265825;4317.9136417271475;3794;3811.676007539335;3814.694824414096;3836;3842.7886466244627;1120.8935151160626;1173.8239264110452;1211.1824518450012;1237.4988129807443;1259.250745806244;1086.277625379114;1092.382803715898;1158.7103224193952;1246.8628450870397;1316.2760481735008;7156.069710937649;7186.209516953131;7267.709291628382;7268.600226987461;7290.526115802456;1168.0772189969828;1174.9941250293864;1199.4302706214653;1199.622119032502;1217.9634610961684;5792.623479473821;5878.882422351529;5880.147378630075;5886.6173698709445;5891.057430811135;8727.650893964297;9252.491112988715;9266.351355405191;9352.392094513834;9357.719268421959;9133.680321188727;9135.862962055575;9247.491387973727;9248.815023699488;9258.629654813732;6977.616231107338;7076.22161562238;7130.429565634737;7188.424926005907;7215.783526494213;7461.626918653937;7527.021487206628;7550.8867366990635;7551.207123251979;7554.697812087455;7971;8058.798530036796;8210.178982101981;8219.671213151407;8258.174182581693;8261.669533218605;8294.917050829414;8303;8317.085120636604;8474.788130296793;6916.757913473004;7029.894551581628;7045.718171273092;7047.929520704727;7050.25972272904;7362.116546014512;7402.481826272325;7404.629768511445;7406.851862962602;7408;6824.419924306291;6989.895151572832;7037.472189585699;7045.647717614202;7127.501074924706;6205;6412.583182093149;6662.6335551545135;6730.226024007302;6856.897146542706;6938.098047253825;7008.334208250208;7014.754483593049;7019;7023.789286321418;6508.056331831953;6533.41199292066;6533.869322613426;6540.117084193573;6540.476761858945;6569.080328753883;6624.138861948109;6629.900551491828;6645.867082658417;6657.06801047844 06:37:59 INFO - 2016-02-02 06:37:59,786 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.16067241981347;358.50526273742236;359.90282623691587;363.5836966673159;367.28379659663665;6068.969655151724;6083.54373421994;6121.908171377428;6125.418085281896;6187.35032821554;6056.788012419566;6081.969590152043;6085.208922840025;6093.299270583884;6097.6951152442425;4593.5406459354135;4723.984343366175;4738.573528382445;4758.024604955985;4773.665843390964;4728.2671185966055;4729.55069268419;4730.172219861528;4735.597474214679;4736.3842700448895;4474.597286244238;4699.953000470003;4702.200625893589;4708.952910470903;4715.08055929094;4540.704854184468;4542.09158168366;4610.861674149781;4616.238320677085;4624.283236098377;4037.4145748866545;4053.2298863215897;4058.79706014701;4089.85685501009;4090.7545547266964;5655.575831812631;5732.398098199671;5776.075827867521;5796.50729687977;5802.622829516068;5410.323709536308;5412.512873841334;5435.918461223046;5445.53712934401;5446.91829622556;6515.641639709814;6522.119513865615;6525.575837570543;6527.216733991904;6527.270273377559;4480.708753930984;4517.073999830027;4537.546245375436;4538.069695712371;4554.772261386951;6716.462682985399;6760.42536384408;6779.118714567124;6783.219929708097;6787.151606049244;4696.577308042292;4696.929546056812;4701.036287561042;4701.365315682339;4705.788239529229;4751.4535828379485;4755.144074066701;4763.785629646605;4764.976175119103;4765.571098601143;5330.120530112488;5458.689914420511;5460.235567020621;5465.07093794048;5475.4524547545725;6544.3782840630065;6548.116004339353;6550.3449655035065;6550.967245163839;6556.442702370352;1646.5060481855396;1673.9497815065567;1674.2633241374;1677.2620047179203;1677.5302915183768;1114.9721256968478;1137.6587023892798;1139.4245905817509;1153.7461758413303;1157.1957489544855;6363.649999249993;6372.171617689671;6384.84037899047;6390.297067322591;6391.265004524446;6754.966225168842;6769.356911093439;6769.526133170631;6784.728610855511;6785.762498312535;6306.936930630727;6352.142460767737;6370.203724534434;6372.4583410409705;6373.553851230462;3665.4501824726503;3701.6298370162767;3702.6667599916136;3703.7222208334483;3704.8888533344043;6823.93176068233;7050.25972272904;7055.470839687044;7073.363397294165;7083.397911177504;6893.345132212432;6911.861762764817;7017.789466316019;7020.894686579705;7025;7003.684834182474;7005.929940700527;7022.508424410345;7029.5430796998035;7038.964805176044;6658.900116498353;6831.760888368884;6832.316768323128;6844.589324640538;6851.280615535297;6738.292479289604;6742.494312926452;6745.93254067453;6751.426128779109;6758.256591774999;7017.543859649107;7030.2969703029285;7033.472489563405;7034.5427547209265;7047.718091276497;4575.9771201143785;4664.720116792868;4720.409948756405;4723.811047558059;4731.195696731633;6812.284710105566;6823.1812182538415;6827.385535301847;6835.965820171066;6845.828854278484;6632.336766323329;6633.270340262471;6634.635095069818;6641.302663220486;6641.501887358564;6471.449926756279;6568.408843204134;6612.70242839083;6614.140161779131;6630.138082049302;6487.124238227779;6493.967530162319;6505.479561634963;6509.967450162719;6517.478601711757;6611.768588099586;6626.171728533934;6637.070810086689;6641.9667901662115;6647.867042659216;6375.74497020114;6471.741130354733;6484.773032943825;6484.805455836333;6485.416312531895 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: |5;yui.html;821.6261600971559;846.3948276981953;862.9741107766769;874.0560194989412;949.3449519831318;14015.509457168988;14871.776923346159;14887;14903.329350179241;14903.7019259615;13967.371468283925;14001.92999035006;14003.929980350083;14038.368273427695;14053.437862485489;757.8597959377505;764.6673696941848;871.0505548951642;880.3485420788602;901.445610949268;915.6657819895756;915.8168366326728;921.8386782313102;923.2337160157053;927.0081013315755;940.3605548227202;943.7829299261174;944.3436811416069;945.7588314979671;948.6347756113911;801.442997117001;810.5866008335732;951.6811868024186;953.2374100719466;962.6582563190037;705.4603228530178;706.1279320039747;706.6325510734389;706.8056284521746;707.0878566649017;14079.296035198302;14172.433102675881;14219.217943013131;14231.644208894757;14246.287685615782;11736.53053877844;12333.136680432284;12713.364331783374;12896.35518224085;13433.932830335883;10250.436226007567;10276.177905767521;10504.422256775873;10542.420166890817;10569.471526423647;3768.1144930941205;3837.4627552142724;3843.3082045231845;3844.7116466265143;3847.5190601174854;47506.28740568894;47859;49113;50070;50110.24834627447;10436.781609195403;10569.365838049742;10649.467526623637;10691.35851848876;11007.394593297446;18103.456896293133;18109.7283540747;18132.274709011755;18143.909280453776;18167.545811354557;7542.170361260257;7607.239276072459;8172.713955011546;8296.585170741559;8427.073021967579;4343.19650864591;4480.551944805494;4633.49031606523;4685.0395668887795;4714.4106986626675;3243.205414673373;3255.6581558935973;3273.1326198557404;3274.017794661592;3278.6229583597715;565.7143142712904;570.8002199230236;576.6799426318349;595.1637948682109;596.2517041113375;668.1848145262869;729.4820677319057;732.1726449112468;744.7840126363294;750.2122771090334;8945.105489451133;9042.140996605312;9113.863292050624;9215.677451289173;9239.214666753402;584.5969672785264;714.3356678289241;716.5557354440281;729.0777166883896;733.6075199768098;4129.834806607762;4283.528811830696;4322.092360604308;4337.8143821275235;4403.735775853459;57709;58720.7063964686;58940;59363.438193707654;59429.70285148547;51698.48301517012;51923.22115168275;52001;52896.735516322944;53180.46819531755;47264.05471890612;47736.28395574069;47741.283880741816;48729.269060964114;50212.74893625582;8531.573421328785;8677.783055423664;8866.512341821004;8986.955065224893;9323.533823308671;34855.47716784199;35982.4602630966;37265.25469490541;37295.694650687095;37449.4382584256;44841.327380088675;45610.54389456063;45993;46149;46629.06741865076;11367.261128026652;11404.315741055563;11600.071994240609;11681.123915706186;11967.401629918644;12558.246505209716;12637.494500219887;13029.739405212033;13113.278769667379;13130.671733206746;10066.194704423775;10988.560457581607;11211.887881121085;11380.03269722083;11393.715157121138;10442.269041167045;10509.474526273503;10551.155907527225;10566.788664226826;10686.358818470917;9502.144806967406;9841.163501102486;10042.447665378475;11184;11292.774144517229;9603.615855365986;9716.076972687584;9881.456519891188;10075.596976120873;10212.285140040125;9051.59267832936;9288.953555232181;9325.673601423918;9355.81288374215;9422.199113075465 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,789 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:37:59 INFO - 2016-02-02 06:37:59,787 DEBUG : BROWSER_OUTPUT: __startTimestamp1454423879779__endTimestamp 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5511.19 Median:5702.23 stddev:598.15 (10.5%) stddev-sans-first:573.09 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: Values: 3250.2 3344.2 3373.9 3374.4 3393.7 5461.8 5566.8 5574.2 5591.7 5593.6 5548.2 5596.5 5608.8 5618.6 5621.3 4964.6 5045.9 5056.2 5083.3 5159.7 4986.3 4989.5 5005.3 5063.8 5112.2 5004.0 5041.2 5050.6 5066.1 5087.6 5081.5 5119.7 5133.7 5152.6 5154.0 4889.4 4903.4 4992.3 5062.3 5071.4 5293.8 5298.7 5362.8 5370.8 5374.8 5887.5 5992.1 5998.9 6006.8 6014.6 5724.6 5824.0 5967.3 6024.1 6111.8 5600.3 5609.3 5610.7 5612.8 5622.5 6020.5 6031.2 6035.1 6039.1 6040.7 5686.2 5713.5 5789.7 5850.9 5863.1 5973.3 5974.2 5981.3 5981.9 5985.9 5933.8 5937.6 5938.3 5938.3 5941.9 5649.1 5706.7 5724.7 5835.9 5863.6 4558.9 4579.0 4595.1 4603.5 4627.5 4023.5 4135.8 4140.2 4148.3 4153.0 5475.8 5536.7 5595.4 5615.7 5646.0 5935.1 5982.3 5984.5 5987.7 5995.5 5437.2 5552.2 5658.4 5691.3 5698.0 5055.3 5137.7 5145.0 5153.8 5182.6 5975.0 5983.9 5990.4 5995.3 6067.4 5649.7 5728.4 5797.3 5882.9 5914.4 6104.9 6135.5 6136.4 6141.4 6142.6 5924.9 5963.5 5968.0 5970.3 5976.9 5759.3 5804.5 5858.0 5951.7 6042.3 5826.0 5827.0 5845.6 5852.8 5874.0 5807.0 5810.7 5813.2 5819.7 5821.2 5579.0 5659.3 5660.3 5750.7 5803.7 5702.2 5864.6 5881.3 5920.6 5933.3 5696.9 5779.7 5788.1 5790.4 5803.9 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47894.92 Median:19655.47 stddev:76669.67 (390.1%) stddev-sans-first:76802.49 06:37:59 INFO - 2016-02-02 06:37:59,788 DEBUG : BROWSER_OUTPUT: Values: 595.9 635.7 639.4 643.1 645.6 32812.0 39454.4 39841.0 39847.0 39901.6 44648.8 45113.3 45160.8 45189.8 45205.3 7993.8 8115.1 9026.6 9229.4 9236.6 10611.4 10863.1 10942.8 10952.4 10957.1 10636.8 10660.3 10751.2 10755.5 10764.4 10530.7 10616.6 10626.8 10633.6 10641.3 10484.3 10614.1 10614.4 10619.0 10624.4 41556.6 42072.6 42091.0 42114.4 42119.6 3543.2 3546.3 3693.9 3774.9 3975.9 31776.4 35928.6 36112.5 36751.0 37146.0 4027.4 4046.2 4127.3 4165.6 4190.4 289386.0 295164.0 296002.0 296497.0 296739.0 61927.7 62892.8 68503.7 76062.2 77438.6 73964.0 74362.0 74470.6 74842.3 75093.0 17237.3 17369.6 17387.4 17407.1 17469.2 11727.5 11939.9 11955.2 11994.0 12037.0 23031.4 23158.2 23367.3 23404.9 23426.2 8980.6 9015.8 9123.2 9162.7 9222.1 1041.5 1088.0 1135.8 1149.6 1169.6 29753.3 29861.7 30656.7 30712.8 31010.0 1140.1 1149.1 1170.5 1187.0 1204.0 13674.0 15754.8 15808.3 16100.6 16212.2 359996.0 361947.0 363690.0 365045.0 365528.0 56470.4 56904.7 56998.0 57090.4 57104.0 1364.8 1373.2 1373.8 1450.6 1474.2 27443.6 27501.7 27538.4 27698.4 27943.3 41933.4 42283.8 42310.8 42367.4 42373.6 193573.0 195198.0 195299.0 195448.0 196224.0 33593.3 33976.5 34148.7 36235.6 36364.3 46672.0 47060.8 47192.5 47325.5 47979.5 39100.2 39472.6 39700.0 44135.0 44740.8 39484.0 40412.6 44722.8 45408.3 47321.8 38936.6 39182.6 39232.6 39663.0 39701.8 33311.0 34341.8 34801.1 34854.5 35764.6 26648.3 27064.9 27186.0 27378.6 27687.8 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30767.55 Median:10203.58 stddev:96293.85 (943.7%) stddev-sans-first:96536.96 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: Values: 385.5 385.7 391.7 392.3 393.2 14945.1 16512.4 17013.5 18025.6 18030.0 11379.4 11608.5 11728.7 18415.0 18599.0 4596.5 5239.6 5248.8 5254.8 5259.7 4047.5 4125.3 5179.0 5473.5 5666.2 5580.4 5615.9 5651.8 5661.5 5663.9 5494.8 5629.6 5639.7 5643.6 5646.2 5420.5 5444.8 5445.5 5453.0 5454.6 13712.7 14073.8 14146.4 14152.2 19049.3 2360.7 2366.2 2421.4 2433.6 2497.7 10176.0 10360.3 10395.4 11273.9 13350.7 1778.4 1782.2 1825.7 1842.5 1846.5 65622.7 67502.3 68022.7 69443.7 69472.3 11197.6 11271.9 11294.7 11304.7 11354.9 14018.3 15139.4 15180.2 15185.9 15186.5 6531.6 6677.8 7724.6 8042.8 8096.7 7674.1 7739.6 7754.1 7760.1 7775.9 4529.2 4746.7 4848.2 4918.1 4952.8 1710.1 1900.0 1945.6 1947.0 1994.9 906.7 965.0 990.3 1074.8 1091.9 17304.1 17428.2 17442.7 17479.7 17854.3 999.0 1007.7 1008.3 1010.2 1032.3 9033.2 10086.4 10205.4 10233.6 10288.0 501175.0 589383.0 602162.0 616677.0 627617.0 80955.0 83908.2 85623.6 86411.0 86693.0 1144.1 1152.0 1153.3 1190.5 1202.9 15846.1 15980.9 16011.5 16137.0 16260.6 33858.0 34648.7 36919.0 37002.3 38097.0 45298.5 45597.3 46025.5 46480.1 48742.5 9897.3 10405.1 10425.6 10429.9 10431.9 12148.1 13647.5 18359.3 18560.6 18699.2 15348.9 15552.4 15883.0 15955.9 15995.2 15216.8 15318.1 15318.2 15642.9 15987.2 10679.9 10894.6 10900.7 11011.7 11212.8 15425.5 15768.4 15847.8 15973.9 16009.4 16476.8 16719.6 16737.4 17141.6 17285.7 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5420.89 Median:6308.79 stddev:2733.63 (43.3%) stddev-sans-first:2725.35 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: Values: 1492.6 1770.1 1807.4 1829.9 1847.7 7296.9 7650.5 7650.6 7653.7 7664.4 6840.9 6972.4 7278.2 7453.1 7728.3 2269.6 2275.7 2300.1 2301.3 2302.4 2059.2 2261.5 2279.8 2312.9 2321.3 2061.9 2264.6 2305.3 2307.3 2307.8 2196.8 2229.8 2231.7 2248.8 2251.4 2273.5 2290.0 2311.3 2313.9 2336.2 7688.4 7793.9 7801.8 7804.9 7806.0 4622.4 4694.0 4722.2 4722.6 4723.5 3101.6 3108.4 3141.0 3190.6 3205.3 1011.1 1028.5 1046.5 1066.6 1077.7 10265.3 10269.6 10277.5 10282.2 10297.7 4158.0 4211.8 4297.7 4307.0 4309.2 8812.4 8851.5 8857.3 8884.8 8892.2 4703.4 4704.9 4717.0 4721.3 4731.1 4273.0 4286.4 4307.9 4316.7 4317.9 3794.0 3811.7 3814.7 3836.0 3842.8 1120.9 1173.8 1211.2 1237.5 1259.3 1086.3 1092.4 1158.7 1246.9 1316.3 7156.1 7186.2 7267.7 7268.6 7290.5 1168.1 1175.0 1199.4 1199.6 1218.0 5792.6 5878.9 5880.1 5886.6 5891.1 8727.7 9252.5 9266.4 9352.4 9357.7 9133.7 9135.9 9247.5 9248.8 9258.6 6977.6 7076.2 7130.4 7188.4 7215.8 7461.6 7527.0 7550.9 7551.2 7554.7 7971.0 8058.8 8210.2 8219.7 8258.2 8261.7 8294.9 8303.0 8317.1 8474.8 6916.8 7029.9 7045.7 7047.9 7050.3 7362.1 7402.5 7404.6 7406.9 7408.0 6824.4 6989.9 7037.5 7045.6 7127.5 6205.0 6412.6 6662.6 6730.2 6856.9 6938.1 7008.3 7014.8 7019.0 7023.8 6508.1 6533.4 6533.9 6540.1 6540.5 6569.1 6624.1 6629.9 6645.9 6657.1 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,789 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5491.78 Median:6329.54 stddev:1658.59 (26.2%) stddev-sans-first:1617.85 06:37:59 INFO - 2016-02-02 06:37:59,790 DEBUG : BROWSER_OUTPUT: Values: 357.2 358.5 359.9 363.6 367.3 6069.0 6083.5 6121.9 6125.4 6187.4 6056.8 6082.0 6085.2 6093.3 6097.7 4593.5 4724.0 4738.6 4758.0 4773.7 4728.3 4729.6 4730.2 4735.6 4736.4 4474.6 4700.0 4702.2 4709.0 4715.1 4540.7 4542.1 4610.9 4616.2 4624.3 4037.4 4053.2 4058.8 4089.9 4090.8 5655.6 5732.4 5776.1 5796.5 5802.6 5410.3 5412.5 5435.9 5445.5 5446.9 6515.6 6522.1 6525.6 6527.2 6527.3 4480.7 4517.1 4537.5 4538.1 4554.8 6716.5 6760.4 6779.1 6783.2 6787.2 4696.6 4696.9 4701.0 4701.4 4705.8 4751.5 4755.1 4763.8 4765.0 4765.6 5330.1 5458.7 5460.2 5465.1 5475.5 6544.4 6548.1 6550.3 6551.0 6556.4 1646.5 1673.9 1674.3 1677.3 1677.5 1115.0 1137.7 1139.4 1153.7 1157.2 6363.6 6372.2 6384.8 6390.3 6391.3 6755.0 6769.4 6769.5 6784.7 6785.8 6306.9 6352.1 6370.2 6372.5 6373.6 3665.5 3701.6 3702.7 3703.7 3704.9 6823.9 7050.3 7055.5 7073.4 7083.4 6893.3 6911.9 7017.8 7020.9 7025.0 7003.7 7005.9 7022.5 7029.5 7039.0 6658.9 6831.8 6832.3 6844.6 6851.3 6738.3 6742.5 6745.9 6751.4 6758.3 7017.5 7030.3 7033.5 7034.5 7047.7 4576.0 4664.7 4720.4 4723.8 4731.2 6812.3 6823.2 6827.4 6836.0 6845.8 6632.3 6633.3 6634.6 6641.3 6641.5 6471.4 6568.4 6612.7 6614.1 6630.1 6487.1 6494.0 6505.5 6510.0 6517.5 6611.8 6626.2 6637.1 6642.0 6647.9 6375.7 6471.7 6484.8 6484.8 6485.4 06:37:59 INFO - 2016-02-02 06:37:59,791 DEBUG : BROWSER_OUTPUT: 06:37:59 INFO - 2016-02-02 06:37:59,791 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14177.13 Median:47385.17 stddev:16364.99 (34.5%) stddev-sans-first:16380.16 06:37:59 INFO - 2016-02-02 06:37:59,791 DEBUG : BROWSER_OUTPUT: Values: 821.6 846.4 863.0 874.1 949.3 14015.5 14871.8 14887.0 14903.3 14903.7 13967.4 14001.9 14003.9 14038.4 14053.4 757.9 764.7 871.1 880.3 901.4 915.7 915.8 921.8 923.2 927.0 940.4 943.8 944.3 945.8 948.6 801.4 810.6 951.7 953.2 962.7 705.5 706.1 706.6 706.8 707.1 14079.3 14172.4 14219.2 14231.6 14246.3 11736.5 12333.1 12713.4 12896.4 13433.9 10250.4 10276.2 10504.4 10542.4 10569.5 3768.1 3837.5 3843.3 3844.7 3847.5 47506.3 47859.0 49113.0 50070.0 50110.2 10436.8 10569.4 10649.5 10691.4 11007.4 18103.5 18109.7 18132.3 18143.9 18167.5 7542.2 7607.2 8172.7 8296.6 8427.1 4343.2 4480.6 4633.5 4685.0 4714.4 3243.2 3255.7 3273.1 3274.0 3278.6 565.7 570.8 576.7 595.2 596.3 668.2 729.5 732.2 744.8 750.2 8945.1 9042.1 9113.9 9215.7 9239.2 584.6 714.3 716.6 729.1 733.6 4129.8 4283.5 4322.1 4337.8 4403.7 57709.0 58720.7 58940.0 59363.4 59429.7 51698.5 51923.2 52001.0 52896.7 53180.5 47264.1 47736.3 47741.3 48729.3 50212.7 8531.6 8677.8 8866.5 8987.0 9323.5 34855.5 35982.5 37265.3 37295.7 37449.4 44841.3 45610.5 45993.0 46149.0 46629.1 11367.3 11404.3 11600.1 11681.1 11967.4 12558.2 12637.5 13029.7 13113.3 13130.7 10066.2 10988.6 11211.9 11380.0 11393.7 10442.3 10509.5 10551.2 10566.8 10686.4 9502.1 9841.2 10042.4 11184.0 11292.8 9603.6 9716.1 9881.5 10075.6 10212.3 9051.6 9289.0 9325.7 9355.8 9422.2 06:37:59 INFO - 2016-02-02 06:37:59,791 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:37:59 INFO - 2016-02-02 06:37:59,791 DEBUG : BROWSER_OUTPUT: 06:38:00 INFO - 2016-02-02 06:38:00,389 INFO : Browser exited with error code: 0 06:38:00 INFO - 2016-02-02 06:38:00,408 INFO : Completed test dromaeo_css (00:18:29) 06:38:00 INFO - 2016-02-02 06:38:00,408 INFO : Starting test kraken 06:38:00 INFO - 2016-02-02 06:38:00,408 DEBUG : operating with platform_type : linux_ 06:38:00 INFO - 2016-02-02 06:38:00,408 INFO : Initialising browser for kraken test... 06:38:00 INFO - 2016-02-02 06:38:00,414 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcTR9OI/profile http://localhost:43710/getInfo.html 06:38:04 INFO - 2016-02-02 06:38:04,210 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:38:04 INFO - 2016-02-02 06:38:04,210 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:38:04 INFO - 2016-02-02 06:38:04,210 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:38:04 INFO - 2016-02-02 06:38:04,210 DEBUG : BROWSER_OUTPUT: __metrics 06:38:04 INFO - 2016-02-02 06:38:04,352 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:38:05 INFO - 2016-02-02 06:38:05,285 INFO : Browser initialized. 06:38:05 INFO - 2016-02-02 06:38:05,285 INFO : Running cycle 1/1 for kraken test... 06:38:05 INFO - 2016-02-02 06:38:05,285 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcTR9OI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:38:17 INFO - 2016-02-02 06:38:17,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 134856704 06:38:17 INFO - 2016-02-02 06:38:17,112 DEBUG : BROWSER_OUTPUT: 06:38:19 INFO - 2016-02-02 06:38:19,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43710/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:20 INFO - 2016-02-02 06:38:20,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 166608896 06:38:20 INFO - 2016-02-02 06:38:20,139 DEBUG : BROWSER_OUTPUT: 06:38:22 INFO - 2016-02-02 06:38:22,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43710/tests/kraken/driver.html?testName=audio-dft) 06:38:23 INFO - 2016-02-02 06:38:23,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 163180544 06:38:23 INFO - 2016-02-02 06:38:23,270 DEBUG : BROWSER_OUTPUT: 06:38:26 INFO - 2016-02-02 06:38:26,076 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43710/tests/kraken/driver.html?testName=audio-fft) 06:38:26 INFO - 2016-02-02 06:38:26,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 160628736 06:38:26 INFO - 2016-02-02 06:38:26,642 DEBUG : BROWSER_OUTPUT: 06:38:28 INFO - 2016-02-02 06:38:28,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43710/tests/kraken/driver.html?testName=audio-oscillator) 06:38:29 INFO - 2016-02-02 06:38:29,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 160772096 06:38:29 INFO - 2016-02-02 06:38:29,168 DEBUG : BROWSER_OUTPUT: 06:38:31 INFO - 2016-02-02 06:38:31,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:38:31 INFO - 2016-02-02 06:38:31,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 160538624 06:38:31 INFO - 2016-02-02 06:38:31,919 DEBUG : BROWSER_OUTPUT: 06:38:34 INFO - 2016-02-02 06:38:34,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43710/tests/kraken/driver.html?testName=imaging-darkroom) 06:38:35 INFO - 2016-02-02 06:38:35,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 160169984 06:38:35 INFO - 2016-02-02 06:38:35,379 DEBUG : BROWSER_OUTPUT: 06:38:38 INFO - 2016-02-02 06:38:38,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43710/tests/kraken/driver.html?testName=imaging-desaturate) 06:38:39 INFO - 2016-02-02 06:38:39,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 160157696 06:38:39 INFO - 2016-02-02 06:38:39,315 DEBUG : BROWSER_OUTPUT: 06:38:42 INFO - 2016-02-02 06:38:42,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43710/tests/kraken/driver.html?testName=json-parse-financial) 06:38:42 INFO - 2016-02-02 06:38:42,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 159596544 06:38:42 INFO - 2016-02-02 06:38:42,590 DEBUG : BROWSER_OUTPUT: 06:38:44 INFO - 2016-02-02 06:38:44,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:38:44 INFO - 2016-02-02 06:38:44,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 165220352 06:38:44 INFO - 2016-02-02 06:38:44,649 DEBUG : BROWSER_OUTPUT: 06:38:46 INFO - 2016-02-02 06:38:46,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:38:46 INFO - 2016-02-02 06:38:46,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 162459648 06:38:46 INFO - 2016-02-02 06:38:46,981 DEBUG : BROWSER_OUTPUT: 06:38:48 INFO - 2016-02-02 06:38:48,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:38:49 INFO - 2016-02-02 06:38:49,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 168652800 06:38:49 INFO - 2016-02-02 06:38:49,519 DEBUG : BROWSER_OUTPUT: 06:38:51 INFO - 2016-02-02 06:38:51,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:38:52 INFO - 2016-02-02 06:38:52,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 175058944 06:38:52 INFO - 2016-02-02 06:38:52,420 DEBUG : BROWSER_OUTPUT: 06:38:54 INFO - 2016-02-02 06:38:54,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:38:55 INFO - 2016-02-02 06:38:55,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 174473216 06:38:55 INFO - 2016-02-02 06:38:55,461 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43710/tests/kraken/driver.html?testName=ai-astar) 06:38:57 INFO - 2016-02-02 06:38:57,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 233529344 06:38:57 INFO - 2016-02-02 06:38:57,355 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,358 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;110;110;110;99;110;110;109 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;120;147;162;122;141;170;120;160;122 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;161;159;159;162;167;160;160;158 06:38:57 INFO - 2016-02-02 06:38:57,359 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;70;151;71;70;70;70;150;71 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;136;93;93;92;137;92;92;130 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;108;109;110;109;109;108;110;109 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;145;145;146;145;145;145;146;147 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;95;96;96;96 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;56;56;58;55;55;56;53;54 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;63;64;64;64;63;64;64 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;76;77;78;85;77;76;77;77;76 06:38:57 INFO - 2016-02-02 06:38:57,360 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;116;115;107;110;113;112;120;115;116 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;129;143;139;140;141;139;138;140;130 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;66;63;62;63;62;64;63;63;62 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,888 06:38:57 INFO - 2016-02-02 06:38:57,361 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:38:57 INFO - 2016-02-02 06:38:57,362 DEBUG : BROWSER_OUTPUT: __startTimestamp1454423937356__endTimestamp 06:38:57 INFO - 2016-02-02 06:38:57,362 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.74 (3.4%) stddev-sans-first:3.91 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 110.0 110.0 110.0 99.0 110.0 110.0 109.0 06:38:57 INFO - 2016-02-02 06:38:57,365 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.90 Median:146.00 stddev:19.15 (13.1%) stddev-sans-first:20.25 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: Values: 145.0 120.0 147.0 162.0 122.0 141.0 170.0 120.0 160.0 122.0 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:2.55 (1.6%) stddev-sans-first:2.64 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 161.0 159.0 159.0 162.0 167.0 160.0 160.0 158.0 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.70 Median:70.50 stddev:33.64 (47.7%) stddev-sans-first:35.31 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 70.0 151.0 71.0 70.0 70.0 70.0 150.0 71.0 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:20.39 (22.2%) stddev-sans-first:21.09 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 136.0 93.0 93.0 92.0 137.0 92.0 92.0 130.0 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 108.0 109.0 110.0 109.0 109.0 108.0 110.0 109.0 06:38:57 INFO - 2016-02-02 06:38:57,366 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 147.0 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.42 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 56.0 56.0 58.0 55.0 55.0 56.0 53.0 54.0 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.00 stddev:3.16 (4.1%) stddev-sans-first:2.83 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: Values: 83.0 76.0 77.0 78.0 85.0 77.0 76.0 77.0 77.0 76.0 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,367 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.20 Median:115.00 stddev:4.02 (3.5%) stddev-sans-first:3.80 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: Values: 108.0 116.0 115.0 107.0 110.0 113.0 112.0 120.0 115.0 116.0 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:139.50 stddev:4.91 (3.5%) stddev-sans-first:4.85 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: Values: 132.0 129.0 143.0 139.0 140.0 141.0 139.0 138.0 140.0 130.0 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 63.0 62.0 63.0 62.0 64.0 63.0 63.0 62.0 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:38:57 INFO - 2016-02-02 06:38:57,368 DEBUG : BROWSER_OUTPUT: 06:38:58 INFO - 2016-02-02 06:38:58,037 INFO : Browser exited with error code: 0 06:38:58 INFO - 2016-02-02 06:38:58,087 INFO : Completed test kraken (00:00:57) 06:38:58 INFO - 2016-02-02 06:38:58,087 INFO : Starting test v8_7 06:38:58 INFO - 2016-02-02 06:38:58,087 DEBUG : operating with platform_type : linux_ 06:38:58 INFO - 2016-02-02 06:38:58,087 INFO : Initialising browser for v8_7 test... 06:38:58 INFO - 2016-02-02 06:38:58,093 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kmlFr/profile http://localhost:43710/getInfo.html 06:39:02 INFO - 2016-02-02 06:39:02,010 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:39:02 INFO - 2016-02-02 06:39:02,010 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:39:02 INFO - 2016-02-02 06:39:02,010 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:39:02 INFO - 2016-02-02 06:39:02,010 DEBUG : BROWSER_OUTPUT: __metrics 06:39:02 INFO - 2016-02-02 06:39:02,155 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:03 INFO - 2016-02-02 06:39:03,106 INFO : Browser initialized. 06:39:03 INFO - 2016-02-02 06:39:03,107 INFO : Running cycle 1/1 for v8_7 test... 06:39:03 INFO - 2016-02-02 06:39:03,107 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6kmlFr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:39:14 INFO - 2016-02-02 06:39:14,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 134598656 06:39:14 INFO - 2016-02-02 06:39:14,866 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43710/tests/v8_7/run.html (next: http://localhost:43710/tests/v8_7/run.html) 06:39:36 INFO - 2016-02-02 06:39:36,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 430452736 06:39:36 INFO - 2016-02-02 06:39:36,476 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:39:36 INFO - 2016-02-02 06:39:36,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:39:36 INFO - 2016-02-02 06:39:36,477 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:39:36 INFO - 2016-02-02 06:39:36,477 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:39:36 INFO - 2016-02-02 06:39:36,477 DEBUG : BROWSER_OUTPUT: |0;Richards;166.66666666666666 06:39:36 INFO - 2016-02-02 06:39:36,478 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.16017316017317 06:39:36 INFO - 2016-02-02 06:39:36,478 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 06:39:36 INFO - 2016-02-02 06:39:36,478 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 06:39:36 INFO - 2016-02-02 06:39:36,478 DEBUG : BROWSER_OUTPUT: |4;RayTrace;943.3962264150944 06:39:36 INFO - 2016-02-02 06:39:36,479 DEBUG : BROWSER_OUTPUT: |5;Earley;541.4185165132648 06:39:36 INFO - 2016-02-02 06:39:36,479 DEBUG : BROWSER_OUTPUT: |6;Boyer;10562.5 06:39:36 INFO - 2016-02-02 06:39:36,479 DEBUG : BROWSER_OUTPUT: |7;RegExp;24560.975609756097 06:39:36 INFO - 2016-02-02 06:39:36,480 DEBUG : BROWSER_OUTPUT: |8;Splay;511.2474437627812 06:39:36 INFO - 2016-02-02 06:39:36,480 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 06:39:36 INFO - 2016-02-02 06:39:36,480 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:39:36 INFO - 2016-02-02 06:39:36,481 DEBUG : BROWSER_OUTPUT: __startTimestamp1454423976475__endTimestamp 06:39:36 INFO - 2016-02-02 06:39:36,481 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,481 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:39:36 INFO - 2016-02-02 06:39:36,481 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:39:36 INFO - 2016-02-02 06:39:36,482 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,482 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.67 Median:166.67 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,482 DEBUG : BROWSER_OUTPUT: Values: 166.7 06:39:36 INFO - 2016-02-02 06:39:36,483 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,483 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.16 Median:173.16 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,483 DEBUG : BROWSER_OUTPUT: Values: 173.2 06:39:36 INFO - 2016-02-02 06:39:36,483 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,484 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,484 DEBUG : BROWSER_OUTPUT: Values: 278.2 06:39:36 INFO - 2016-02-02 06:39:36,484 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: Values: 5208.3 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:943.40 Median:943.40 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: Values: 943.4 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,485 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.42 Median:541.42 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: Values: 541.4 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10562.50 Median:10562.50 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: Values: 10562.5 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24560.98 Median:24560.98 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: Values: 24561.0 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:511.25 Median:511.25 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: Values: 511.2 06:39:36 INFO - 2016-02-02 06:39:36,486 DEBUG : BROWSER_OUTPUT: 06:39:36 INFO - 2016-02-02 06:39:36,487 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 06:39:36 INFO - 2016-02-02 06:39:36,487 DEBUG : BROWSER_OUTPUT: Values: 4845.4 06:39:36 INFO - 2016-02-02 06:39:36,487 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:39:36 INFO - 2016-02-02 06:39:36,487 DEBUG : BROWSER_OUTPUT: 06:39:37 INFO - 2016-02-02 06:39:37,129 INFO : Browser exited with error code: 0 06:39:37 INFO - 2016-02-02 06:39:37,147 INFO : Completed test v8_7 (00:00:39) 06:39:37 INFO - 2016-02-02 06:39:37,555 INFO : Completed test suite (00:20:06) 06:39:37 INFO - 2016-02-02 06:39:37,555 DEBUG : Working with test: dromaeo_css 06:39:37 INFO - 2016-02-02 06:39:37,555 DEBUG : Generating results file: dromaeo_css 06:39:37 INFO - 2016-02-02 06:39:37,556 DEBUG : Working with test: kraken 06:39:37 INFO - 2016-02-02 06:39:37,556 DEBUG : Generating results file: kraken 06:39:37 INFO - 2016-02-02 06:39:37,557 INFO : javascript benchmark 06:39:37 INFO - 2016-02-02 06:39:37,557 DEBUG : Working with test: v8_7 06:39:37 INFO - 2016-02-02 06:39:37,557 DEBUG : Generating results file: v8_7 06:39:37 INFO - 2016-02-02 06:39:37,557 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:37 INFO - 2016-02-02 06:39:37,611 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 06:39:37 INFO - 2016-02-02 06:39:37,611 DEBUG : process_Request line: dromaeo_css 7285.87 graph.html#tests=[[72,53,35]] 06:39:37 INFO - 2016-02-02 06:39:37,611 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:37 INFO - 2016-02-02 06:39:37,642 DEBUG : process_Request line: kraken 1462.20 graph.html#tests=[[232,53,35]] 06:39:37 INFO - 2016-02-02 06:39:37,642 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:39:37 INFO - 2016-02-02 06:39:37,683 DEBUG : process_Request line: v8_7 23209.23 graph.html#tests=[[230,53,35]] 06:39:37 INFO - 2016-02-02 06:39:37,684 INFO : javascript benchmark 06:39:37 INFO - 2016-02-02 06:39:37,688 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3250.2199472126686, 3344.214109684225, 3373.915652108697, 3374.4432168692165, 3393.6945674889257, 5461.78152873885, 5566.777328906839, 5574.247476590659, 5591.720413979295, 5593.608447408688, 5548.167774833777, 5596.496315331629, 5608.775648974036, 5618.634788738739, 5621.269234999455, 4964.578010869081, 5045.949540504585, 5056.191009438472, 5083.288339632454, 5159.690418574897, 4986.326845875815, 4989.476105008976, 5005.324281222043, 5063.8480845574695, 5112.233165025257, 5003.974980125113, 5041.243813427978, 5050.595952323805, 5066.06277838601, 5087.643864929457, 5081.491850814908, 5119.667221630582, 5133.743312834344, 5152.587792976553, 5153.994970980661, 4889.3643826302705, 4903.436104847917, 4992.301077849068, 5062.265971434122, 5071.442141364447, 5293.841184764463, 5298.682079075229, 5362.812301569426, 5370.785168593291, 5374.838754837361, 5887.528997680218, 5992.0712289595185, 5998.8500287492725, 6006.819795406145, 6014.6391216527145, 5724.570657200727, 5824.0, 5967.283925928873, 6024.0662697282, 6111.786087486961, 5600.299962504687, 5609.326880774333, 5610.719464026783, 5612.803551875706, 5622.465865742748, 6020.518358531307, 6031.185789918392, 6035.094735789579, 6039.094135879654, 6040.728167232485, 5686.175504551817, 5713.514351280104, 5789.681567513827, 5850.882982340329, 5863.120531920246, 5973.253343332083, 5974.163617093611, 5981.282246130492, 5981.880362392815, 5985.910211346833, 5933.762649493972, 5937.614055086406, 5938.257717785277, 5938.317093534299, 5941.910871336933, 5649.06790379591, 5706.686132262683, 5724.742386592613, 5835.912461313083, 5863.589548731633, 4558.8632341029825, 4579.038401935631, 4595.149897269016, 4603.516630753789, 4627.514111018362, 4023.4769479967417, 4135.77253251068, 4140.171965606891, 4148.274052040881, 4153.044799696087, 5475.835724928259, 5536.695481748462, 5595.38450770415, 5615.6630602164005, 5646.0, 5935.109733539917, 5982.312034116046, 5984.491318237999, 5987.730552125165, 5995.490383317467, 5437.15724062763, 5552.167174923794, 5658.434156584309, 5691.317041954909, 5698.0, 5055.292259083732, 5137.743112844418, 5145.0, 5153.819616313411, 5182.5594824439595, 5974.970125149346, 5983.850403739942, 5990.371011043778, 5995.250593675791, 6067.393260673897, 5649.68926709035, 5728.398518155534, 5797.275340582427, 5882.911756323573, 5914.4381283777975, 6104.9389506106145, 6135.515116377874, 6136.404534820889, 6141.416565426277, 6142.6314421134875, 5924.851878702894, 5963.52291816645, 5967.9701601491715, 5970.283565971938, 5976.850578735392, 5759.2512973313205, 5804.506616937439, 5857.970710146422, 5951.672658003851, 6042.274927008787, 5826.0, 5826.970865145647, 5845.590808643354, 5852.7658893645485, 5874.03078492044, 5807.041838096667, 5810.680412577349, 5813.244278243801, 5819.70901454934, 5821.243238378984, 5578.972105139448, 5659.320881494247, 5660.349059858169, 5750.712464376848, 5803.680797556175, 5702.230198923258, 5864.648121112747, 5881.2942446906645, 5920.644761314335, 5933.347331793586, 5696.943030569641, 5779.653220806765, 5788.102844059177, 5790.39200883918, 5803.8549036274435], "unit": "ms", "name": "dojo.html", "value": 5473.339773446163}, {"lowerIsBetter": false, "replicates": [595.8957182493066, 635.6853357587995, 639.3893831391022, 643.1446176585142, 645.5545673485296, 32811.99999999997, 39454.40818387726, 39841.0, 39847.0, 39901.60098399015, 44648.776756116255, 45113.32330015044, 45160.77419612905, 45189.7740511297, 45205.32192017123, 7993.840123197561, 8115.1073381927945, 9026.638934442632, 9229.400088994194, 9236.6305347786, 10611.416372099531, 10863.076638485738, 10942.835857462105, 10952.397618130999, 10957.12343012561, 10636.840447393295, 10660.307080039773, 10751.193660475496, 10755.462226888663, 10764.354138751662, 10530.684079477627, 10616.628418005372, 10626.787464250672, 10633.627823026234, 10641.308314959502, 10484.318519296297, 10614.097801686867, 10614.363138211655, 10619.044286014296, 10624.415657138854, 41556.58443415588, 42072.57927420748, 42091.0, 42114.36828447576, 42119.57880421218, 3543.2382037861985, 3546.29074185164, 3693.8891833245048, 3774.9056273593105, 3975.940360894589, 31776.364472710415, 35928.64071359279, 36112.458313125324, 36751.0, 37146.0, 4027.416024676435, 4046.1705350403095, 4127.2570937231285, 4165.562615925345, 4190.350495673176, 289386.0, 295164.0, 296002.0, 296497.0, 296739.0, 61927.690361548805, 62892.79875204346, 68503.65748171326, 76062.23937760551, 77438.6128069356, 73964.0, 74362.0, 74470.6276468625, 74842.25157748461, 75093.0, 17237.31050757981, 17369.56576085608, 17387.391441299493, 17407.129643517772, 17469.21388537519, 11727.530898763955, 11939.940300298444, 11955.163138580216, 11994.0, 12037.0, 23031.424214394774, 23158.18946336904, 23367.298981030595, 23404.882975585013, 23426.18008369699, 8980.595873185723, 9015.819683606422, 9123.224525915371, 9162.67930622425, 9222.123898229658, 1041.505284989639, 1087.994560027195, 1135.761490087091, 1149.5574203931546, 1169.561414469574, 29753.25616859596, 29861.701382986328, 30656.693433065382, 30712.84643576768, 31010.0, 1140.1050175612104, 1149.1209224942925, 1170.4966864248454, 1186.976260474803, 1203.9645904522104, 13674.0, 15754.842451575567, 15808.288627011812, 16100.597485062966, 16212.189390530426, 359996.0, 361947.0, 363690.0, 365045.0, 365528.0, 56470.43529564734, 56904.71547642318, 56998.0, 57090.42909570934, 57104.0, 1364.7611667958067, 1373.1829561410943, 1373.8007988841562, 1450.6228380621114, 1474.2481334519687, 27443.588346175224, 27501.72498275072, 27538.449231015667, 27698.446031079668, 27943.301417464725, 41933.37099943564, 42283.7885810569, 42310.78844605757, 42367.36448953207, 42373.57626423697, 193573.0, 195198.0, 195299.0, 195448.0, 196224.0, 33593.32813343768, 33976.490352645225, 34148.65851341554, 36235.637643623224, 36364.27271454609, 46672.0, 47060.7646961763, 47192.528074718815, 47325.52674473211, 47979.5202047975, 39100.217995640494, 39472.605273946894, 39700.0, 44135.0, 44740.77629611961, 39484.0, 40412.59587404088, 44722.77638611786, 45408.31887521624, 47321.76339118282, 38936.610633893295, 39182.6081739179, 39232.607673922896, 39663.0, 39701.80149099236, 33311.0, 34341.828290858386, 34801.12997175091, 34854.477182842784, 35764.64235357613, 26648.333791655365, 27064.864675676494, 27186.0, 27378.5893211598, 27687.832089533233], "unit": "ms", "name": "ext.html", "value": 20121.57109041579}, {"lowerIsBetter": false, "replicates": [385.4661294107661, 385.6779589043149, 391.73557848452293, 392.3330338424679, 393.22142158526117, 14945.103293802353, 16512.422065227704, 17013.48959531213, 18025.639487210246, 18030.0, 11379.374134422624, 11608.535658573646, 11728.706782330424, 18415.0, 18599.0, 4596.517365676606, 5239.5546378557865, 5248.816291429801, 5254.763535640886, 5259.658122222043, 4047.494063242095, 4125.2986992211245, 5179.0, 5473.534749546293, 5666.206731057655, 5580.386157522689, 5615.859603509924, 5651.8304450866535, 5661.46216109471, 5663.886722265553, 5494.780208791643, 5629.634073785191, 5639.661620302795, 5643.576731745115, 5646.237757902672, 5420.4850539198715, 5444.8366549003595, 5445.50990410861, 5452.972735136339, 5454.645448045864, 13712.725745485035, 14073.788893166611, 14146.434142634282, 14152.150870947777, 19049.333273335367, 2360.681308023412, 2366.2073205476186, 2421.418859473731, 2433.6227884677905, 2497.725250222474, 10176.0, 10360.274780765349, 10395.376277423378, 11273.887261127447, 13350.666233344147, 1778.368679118907, 1782.1623836796684, 1825.7170138628535, 1842.5393651587103, 1846.5291350705484, 65622.67188664073, 67502.3249767501, 68022.65988670025, 69443.65278173577, 69472.30527694759, 11197.60808371703, 11271.887281127083, 11294.717632059264, 11304.71738206535, 11354.886451135382, 14018.29908504591, 15139.394424223128, 15180.240987950558, 15185.924070379577, 15186.544403667907, 6531.640759758164, 6677.799666010027, 7724.6137693115115, 8042.798930026679, 8096.676132954616, 7674.117476490163, 7739.574323412154, 7754.1470438251745, 7760.107587627383, 7775.883361749578, 4529.184746745617, 4746.738929358849, 4848.224284114524, 4918.065567542227, 4952.777125029383, 1710.0523599093858, 1899.9620007599772, 1945.5719741656812, 1946.98053019468, 1994.920203191885, 906.7007887397143, 964.9855252171224, 990.2622546203124, 1074.7904158689137, 1091.901728844408, 17304.13479326054, 17428.215730291915, 17442.65114697699, 17479.65040699179, 17854.285828566713, 999.0, 1007.6674697350004, 1008.2639673038723, 1010.2221289607108, 1032.2774058159318, 9033.187013168847, 10086.44524551142, 10205.38767673927, 10233.641822536176, 10288.0, 501175.0, 589383.0, 602162.0, 616677.0, 627617.0, 80955.0, 83908.16091839125, 85623.5718821402, 86411.0, 86693.0, 1144.0904480937675, 1151.9884801151882, 1153.2503872482953, 1190.541641468041, 1202.927824330543, 15846.12846293465, 15980.920095399913, 16011.519654410386, 16137.0, 16260.593485162966, 33858.0, 34648.653513464546, 36919.0, 37002.25995480022, 38097.04757381088, 45298.54701452943, 45597.31604025876, 46025.53974460346, 46480.070398592514, 48742.5125748738, 9897.257705672248, 10405.06354428105, 10425.635102771366, 10429.895701042893, 10431.94784026075, 12148.088893333212, 13647.522336718168, 18359.265629375208, 18560.628787424444, 18699.23548768682, 15348.923255383652, 15552.377904883679, 15883.0, 15955.920220398824, 15995.200239987722, 15216.847831521543, 15318.080915145127, 15318.234088295318, 15642.921785391, 15987.200639968187, 10679.89320106789, 10894.564217431214, 10900.727481813017, 11011.669649910515, 11212.775744485229, 15425.537233883002, 15768.369265229263, 15847.762283565986, 15973.920130399274, 16009.439669611973, 16476.83523164753, 16719.582010449834, 16737.41419050376, 17141.57146071358, 17285.740713889554], "unit": "ms", "name": "jquery.html", "value": 9247.596741616077}, {"lowerIsBetter": false, "replicates": [1492.5596948900074, 1770.1060964213073, 1807.3945228348507, 1829.8627602929776, 1847.6581832361014, 7296.890546641798, 7650.540967541951, 7650.622887880179, 7653.655585498659, 7664.42879209762, 6840.863182736355, 6972.4422046236305, 7278.199398066208, 7453.105627324729, 7728.343090837286, 2269.557436299918, 2275.72691277047, 2300.068472268734, 2301.2520930697506, 2302.366849116498, 2059.1969132038516, 2261.525079733258, 2279.794818466338, 2312.8843557822124, 2321.2688003278913, 2061.938141855747, 2264.569731750962, 2305.296884450242, 2307.3193407944696, 2307.7576854430295, 2196.8242540596716, 2229.832762542808, 2231.6987206727126, 2248.808851247646, 2251.4146321956246, 2273.465735552144, 2289.977100228993, 2311.341267738703, 2313.9421514462106, 2336.158982766203, 7688.38492920565, 7793.922060779376, 7801.765947021599, 7804.882926756103, 7805.960970195113, 4622.375979242793, 4693.9765301173275, 4722.197226471474, 4722.574968252874, 4723.504032076617, 3101.6122984626923, 3108.362785628941, 3141.0, 3190.633077196129, 3205.3268813549184, 1011.0799172752833, 1028.5063169678597, 1046.5133712823574, 1066.642674703975, 1077.6766969909074, 10265.332753371007, 10269.589216431334, 10277.486125693686, 10282.177425805918, 10297.74255643615, 4158.0, 4211.831526738957, 4297.742135471882, 4306.978465107654, 4309.245881970705, 8812.427192232484, 8851.51316677576, 8857.291416686778, 8884.822303553892, 8892.244159246407, 4703.435587729495, 4704.85885423431, 4717.0, 4721.253136339507, 4731.148393289241, 4272.957270427318, 4286.442762440863, 4307.870763877088, 4316.6546676265825, 4317.9136417271475, 3794.0, 3811.676007539335, 3814.694824414096, 3836.0, 3842.7886466244627, 1120.8935151160626, 1173.8239264110452, 1211.1824518450012, 1237.4988129807443, 1259.250745806244, 1086.277625379114, 1092.382803715898, 1158.7103224193952, 1246.8628450870397, 1316.2760481735008, 7156.069710937649, 7186.209516953131, 7267.709291628382, 7268.600226987461, 7290.526115802456, 1168.0772189969828, 1174.9941250293864, 1199.4302706214653, 1199.622119032502, 1217.9634610961684, 5792.623479473821, 5878.882422351529, 5880.147378630075, 5886.6173698709445, 5891.057430811135, 8727.650893964297, 9252.491112988715, 9266.351355405191, 9352.392094513834, 9357.719268421959, 9133.680321188727, 9135.862962055575, 9247.491387973727, 9248.815023699488, 9258.629654813732, 6977.616231107338, 7076.22161562238, 7130.429565634737, 7188.424926005907, 7215.783526494213, 7461.626918653937, 7527.021487206628, 7550.8867366990635, 7551.207123251979, 7554.697812087455, 7971.0, 8058.798530036796, 8210.178982101981, 8219.671213151407, 8258.174182581693, 8261.669533218605, 8294.917050829414, 8303.0, 8317.085120636604, 8474.788130296793, 6916.757913473004, 7029.894551581628, 7045.718171273092, 7047.929520704727, 7050.25972272904, 7362.116546014512, 7402.481826272325, 7404.629768511445, 7406.851862962602, 7408.0, 6824.419924306291, 6989.895151572832, 7037.472189585699, 7045.647717614202, 7127.501074924706, 6205.0, 6412.583182093149, 6662.6335551545135, 6730.226024007302, 6856.897146542706, 6938.098047253825, 7008.334208250208, 7014.754483593049, 7019.0, 7023.789286321418, 6508.056331831953, 6533.41199292066, 6533.869322613426, 6540.117084193573, 6540.476761858945, 6569.080328753883, 6624.138861948109, 6629.900551491828, 6645.867082658417, 6657.06801047844], "unit": "ms", "name": "mootools.html", "value": 4501.324047577154}, {"lowerIsBetter": false, "replicates": [357.16067241981347, 358.50526273742236, 359.90282623691587, 363.5836966673159, 367.28379659663665, 6068.969655151724, 6083.54373421994, 6121.908171377428, 6125.418085281896, 6187.35032821554, 6056.788012419566, 6081.969590152043, 6085.208922840025, 6093.299270583884, 6097.6951152442425, 4593.5406459354135, 4723.984343366175, 4738.573528382445, 4758.024604955985, 4773.665843390964, 4728.2671185966055, 4729.55069268419, 4730.172219861528, 4735.597474214679, 4736.3842700448895, 4474.597286244238, 4699.953000470003, 4702.200625893589, 4708.952910470903, 4715.08055929094, 4540.704854184468, 4542.09158168366, 4610.861674149781, 4616.238320677085, 4624.283236098377, 4037.4145748866545, 4053.2298863215897, 4058.79706014701, 4089.85685501009, 4090.7545547266964, 5655.575831812631, 5732.398098199671, 5776.075827867521, 5796.50729687977, 5802.622829516068, 5410.323709536308, 5412.512873841334, 5435.918461223046, 5445.53712934401, 5446.91829622556, 6515.641639709814, 6522.119513865615, 6525.575837570543, 6527.216733991904, 6527.270273377559, 4480.708753930984, 4517.073999830027, 4537.546245375436, 4538.069695712371, 4554.772261386951, 6716.462682985399, 6760.42536384408, 6779.118714567124, 6783.219929708097, 6787.151606049244, 4696.577308042292, 4696.929546056812, 4701.036287561042, 4701.365315682339, 4705.788239529229, 4751.4535828379485, 4755.144074066701, 4763.785629646605, 4764.976175119103, 4765.571098601143, 5330.120530112488, 5458.689914420511, 5460.235567020621, 5465.07093794048, 5475.4524547545725, 6544.3782840630065, 6548.116004339353, 6550.3449655035065, 6550.967245163839, 6556.442702370352, 1646.5060481855396, 1673.9497815065567, 1674.2633241374, 1677.2620047179203, 1677.5302915183768, 1114.9721256968478, 1137.6587023892798, 1139.4245905817509, 1153.7461758413303, 1157.1957489544855, 6363.649999249993, 6372.171617689671, 6384.84037899047, 6390.297067322591, 6391.265004524446, 6754.966225168842, 6769.356911093439, 6769.526133170631, 6784.728610855511, 6785.762498312535, 6306.936930630727, 6352.142460767737, 6370.203724534434, 6372.4583410409705, 6373.553851230462, 3665.4501824726503, 3701.6298370162767, 3702.6667599916136, 3703.7222208334483, 3704.8888533344043, 6823.93176068233, 7050.25972272904, 7055.470839687044, 7073.363397294165, 7083.397911177504, 6893.345132212432, 6911.861762764817, 7017.789466316019, 7020.894686579705, 7025.0, 7003.684834182474, 7005.929940700527, 7022.508424410345, 7029.5430796998035, 7038.964805176044, 6658.900116498353, 6831.760888368884, 6832.316768323128, 6844.589324640538, 6851.280615535297, 6738.292479289604, 6742.494312926452, 6745.93254067453, 6751.426128779109, 6758.256591774999, 7017.543859649107, 7030.2969703029285, 7033.472489563405, 7034.5427547209265, 7047.718091276497, 4575.9771201143785, 4664.720116792868, 4720.409948756405, 4723.811047558059, 4731.195696731633, 6812.284710105566, 6823.1812182538415, 6827.385535301847, 6835.965820171066, 6845.828854278484, 6632.336766323329, 6633.270340262471, 6634.635095069818, 6641.302663220486, 6641.501887358564, 6471.449926756279, 6568.408843204134, 6612.70242839083, 6614.140161779131, 6630.138082049302, 6487.124238227779, 6493.967530162319, 6505.479561634963, 6509.967450162719, 6517.478601711757, 6611.768588099586, 6626.171728533934, 6637.070810086689, 6641.9667901662115, 6647.867042659216, 6375.74497020114, 6471.741130354733, 6484.773032943825, 6484.805455836333, 6485.416312531895], "unit": "ms", "name": "prototype.html", "value": 4959.415755881586}, {"lowerIsBetter": false, "replicates": [821.6261600971559, 846.3948276981953, 862.9741107766769, 874.0560194989412, 949.3449519831318, 14015.509457168988, 14871.776923346159, 14887.0, 14903.329350179241, 14903.7019259615, 13967.371468283925, 14001.92999035006, 14003.929980350083, 14038.368273427695, 14053.437862485489, 757.8597959377505, 764.6673696941848, 871.0505548951642, 880.3485420788602, 901.445610949268, 915.6657819895756, 915.8168366326728, 921.8386782313102, 923.2337160157053, 927.0081013315755, 940.3605548227202, 943.7829299261174, 944.3436811416069, 945.7588314979671, 948.6347756113911, 801.442997117001, 810.5866008335732, 951.6811868024186, 953.2374100719466, 962.6582563190037, 705.4603228530178, 706.1279320039747, 706.6325510734389, 706.8056284521746, 707.0878566649017, 14079.296035198302, 14172.433102675881, 14219.217943013131, 14231.644208894757, 14246.287685615782, 11736.53053877844, 12333.136680432284, 12713.364331783374, 12896.35518224085, 13433.932830335883, 10250.436226007567, 10276.177905767521, 10504.422256775873, 10542.420166890817, 10569.471526423647, 3768.1144930941205, 3837.4627552142724, 3843.3082045231845, 3844.7116466265143, 3847.5190601174854, 47506.28740568894, 47859.0, 49113.0, 50070.0, 50110.24834627447, 10436.781609195403, 10569.365838049742, 10649.467526623637, 10691.35851848876, 11007.394593297446, 18103.456896293133, 18109.7283540747, 18132.274709011755, 18143.909280453776, 18167.545811354557, 7542.170361260257, 7607.239276072459, 8172.713955011546, 8296.585170741559, 8427.073021967579, 4343.19650864591, 4480.551944805494, 4633.49031606523, 4685.0395668887795, 4714.4106986626675, 3243.205414673373, 3255.6581558935973, 3273.1326198557404, 3274.017794661592, 3278.6229583597715, 565.7143142712904, 570.8002199230236, 576.6799426318349, 595.1637948682109, 596.2517041113375, 668.1848145262869, 729.4820677319057, 732.1726449112468, 744.7840126363294, 750.2122771090334, 8945.105489451133, 9042.140996605312, 9113.863292050624, 9215.677451289173, 9239.214666753402, 584.5969672785264, 714.3356678289241, 716.5557354440281, 729.0777166883896, 733.6075199768098, 4129.834806607762, 4283.528811830696, 4322.092360604308, 4337.8143821275235, 4403.735775853459, 57709.0, 58720.7063964686, 58940.0, 59363.438193707654, 59429.70285148547, 51698.48301517012, 51923.22115168275, 52001.0, 52896.735516322944, 53180.46819531755, 47264.05471890612, 47736.28395574069, 47741.283880741816, 48729.269060964114, 50212.74893625582, 8531.573421328785, 8677.783055423664, 8866.512341821004, 8986.955065224893, 9323.533823308671, 34855.47716784199, 35982.4602630966, 37265.25469490541, 37295.694650687095, 37449.4382584256, 44841.327380088675, 45610.54389456063, 45993.0, 46149.0, 46629.06741865076, 11367.261128026652, 11404.315741055563, 11600.071994240609, 11681.123915706186, 11967.401629918644, 12558.246505209716, 12637.494500219887, 13029.739405212033, 13113.278769667379, 13130.671733206746, 10066.194704423775, 10988.560457581607, 11211.887881121085, 11380.03269722083, 11393.715157121138, 10442.269041167045, 10509.474526273503, 10551.155907527225, 10566.788664226826, 10686.358818470917, 9502.144806967406, 9841.163501102486, 10042.447665378475, 11184.0, 11292.774144517229, 9603.615855365986, 9716.076972687584, 9881.456519891188, 10075.596976120873, 10212.285140040125, 9051.59267832936, 9288.953555232181, 9325.673601423918, 9355.81288374215, 9422.199113075465], "unit": "ms", "name": "yui.html", "value": 6578.59438592751}], "name": "dromaeo_css", "value": 7285.866874597288}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 110.0, 110.0, 99.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [145.0, 120.0, 147.0, 162.0, 122.0, 141.0, 170.0, 120.0, 160.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 161.0, 159.0, 159.0, 162.0, 167.0, 160.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 70.0, 151.0, 71.0, 70.0, 70.0, 70.0, 150.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 86.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 136.0, 93.0, 93.0, 92.0, 137.0, 92.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 108.0, 109.0, 110.0, 109.0, 109.0, 108.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 58.0, 55.0, 55.0, 56.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [83.0, 76.0, 77.0, 78.0, 85.0, 77.0, 76.0, 77.0, 77.0, 76.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [108.0, 116.0, 115.0, 107.0, 110.0, 113.0, 112.0, 120.0, 115.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.2}, {"lowerIsBetter": true, "replicates": [132.0, 129.0, 143.0, 139.0, 140.0, 141.0, 139.0, 138.0, 140.0, 130.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 63.0, 62.0, 63.0, 62.0, 64.0, 63.0, 63.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.1}], "name": "kraken", "value": 1462.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.66666666666666], "unit": "score", "name": "Richards", "value": 211.81200000000004}, {"lowerIsBetter": false, "replicates": [173.16017316017317], "unit": "score", "name": "DeltaBlue", "value": 381.83144999999985}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [943.3962264150944], "unit": "score", "name": "RayTrace", "value": 784.3883400000002}, {"lowerIsBetter": false, "replicates": [541.4185165132648], "unit": "score", "name": "Earley", "value": 1230.9571610000005}, {"lowerIsBetter": false, "replicates": [10562.5], "unit": "score", "name": "Boyer", "value": 63.09708875739642}, {"lowerIsBetter": false, "replicates": [24560.975609756097], "unit": "score", "name": "RegExp", "value": 37.09074975173787}, {"lowerIsBetter": false, "replicates": [511.2474437627812], "unit": "score", "name": "Splay", "value": 159.39639600000004}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 23209.227393038436}]} 06:39:37 INFO - RETURN: dromaeo_css: 7285.87 06:39:37 INFO - RETURN: kraken: 1462.20 06:39:37 INFO - RETURN: v8_7: 23209.23 06:39:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23209.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1462.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7285.87"}}} 06:39:37 INFO - Return code: 0 06:39:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:39:37 INFO - # TBPL SUCCESS # 06:39:37 INFO - Running post-action listener: _resource_record_post_action 06:39:37 INFO - Running post-run listener: _resource_record_post_run 06:39:38 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 430080; Write bytes: 358383616; Read time: 312; Write time: 295120 06:39:38 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98279424; Read time: 212; Write time: 124812 06:39:38 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 425984; Write bytes: 260104192; Read time: 100; Write time: 170308 06:39:38 INFO - Running post-run listener: _upload_blobber_files 06:39:38 INFO - Blob upload gear active. 06:39:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:39:38 INFO - Copying logs to upload dir... 06:39:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1310.758320 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2016-02-02 06:39:38.964307) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-02 06:39:38.968234) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009952 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454414057/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-02 06:39:39.020098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:39:39.020435) ========= 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=836cfdc75598d54cb747368e000001a9-1454421590.799190-832458334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 06:39:39.069580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 06:39:39.069902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 06:39:39.070202) ========= ========= Total master_lag: 0.22 =========