builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1453800422.53 results: success (0) buildid: 20160125070233 builduid: eb2ea0af6ac2494ca810680a4890723f revision: 3bc504ea394f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.534597) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.535005) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.535286) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004319 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.552376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.552664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.564225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.564522) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.613174) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.613456) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.613789) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.614055) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-26 01:27:02-- 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.2M=0s 2016-01-26 01:27:02 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.777007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.777315) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.826987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:02.827292) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3bc504ea394f --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 3bc504ea394f --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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-26 01:27:02,909 Setting DEBUG logging. 2016-01-26 01:27:02,909 attempt 1/10 2016-01-26 01:27:02,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3bc504ea394f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-26 01:27:03,301 unpacking tar archive at: mozilla-beta-3bc504ea394f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671605 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:03.511756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:03.512151) ========= echo 3bc504ea394f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bc504ea394f'] 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bc504ea394f program finished with exit code 0 elapsedTime=0.004618 script_repo_revision: '3bc504ea394f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:03.566357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:03.566671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-26 01:27:03.577871) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-01-26 01:27:03.578154) ========= /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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:27:03 INFO - MultiFileLogger online at 20160126 01:27:03 in /builds/slave/test-pgo 01:27:03 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 01:27:03 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:27:03 INFO - {'append_to_log': False, 01:27:03 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:27:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:27:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:27:03 INFO - 'branch': 'Mozilla-Beta', 01:27:03 INFO - 'buildbot_json_path': 'buildprops.json', 01:27:03 INFO - 'config_files': ('talos/linux_config.py',), 01:27:03 INFO - 'default_actions': ('clobber', 01:27:03 INFO - 'read-buildbot-config', 01:27:03 INFO - 'download-and-extract', 01:27:03 INFO - 'populate-webroot', 01:27:03 INFO - 'create-virtualenv', 01:27:03 INFO - 'install', 01:27:03 INFO - 'run-tests'), 01:27:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:27:03 INFO - 'download_minidump_stackwalk': True, 01:27:03 INFO - 'download_symbols': 'ondemand', 01:27:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:27:03 INFO - 'tooltool.py': '/tools/tooltool.py', 01:27:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:27:03 INFO - '/tools/misc-python/virtualenv.py')}, 01:27:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:27:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:27:03 INFO - 'installer_path': 'installer.exe', 01:27:03 INFO - 'log_level': 'info', 01:27:03 INFO - 'log_name': 'talos', 01:27:03 INFO - 'log_to_console': True, 01:27:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:27:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:27:03 INFO - 'opt_config_files': (), 01:27:03 INFO - 'pip_index': False, 01:27:03 INFO - 'sps_profile': False, 01:27:03 INFO - 'sps_profile_interval': 0, 01:27:03 INFO - 'suite': 'dromaeojs', 01:27:03 INFO - 'system_bits': '32', 01:27:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:27:03 INFO - 'title': 'talos-linux64-ix-060', 01:27:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:27:03 INFO - 'use_talos_json': True, 01:27:03 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:27:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:27:03 INFO - 'work_dir': 'build'} 01:27:03 INFO - ##### 01:27:03 INFO - ##### Running clobber step. 01:27:03 INFO - ##### 01:27:03 INFO - Running pre-action listener: _resource_record_pre_action 01:27:03 INFO - Running main action method: clobber 01:27:03 INFO - rmtree: /builds/slave/test-pgo/build 01:27:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:27:04 INFO - Running post-action listener: _resource_record_post_action 01:27:04 INFO - ##### 01:27:04 INFO - ##### Running read-buildbot-config step. 01:27:04 INFO - ##### 01:27:04 INFO - Running pre-action listener: _resource_record_pre_action 01:27:04 INFO - Running main action method: read_buildbot_config 01:27:04 INFO - Using buildbot properties: 01:27:04 INFO - { 01:27:04 INFO - "properties": { 01:27:04 INFO - "buildnumber": 95, 01:27:04 INFO - "product": "firefox", 01:27:04 INFO - "script_repo_revision": "production", 01:27:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 01:27:04 INFO - "repository": "", 01:27:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 01:27:04 INFO - "buildid": "20160125070233", 01:27:04 INFO - "slavename": "talos-linux64-ix-060", 01:27:04 INFO - "pgo_build": "True", 01:27:04 INFO - "basedir": "/builds/slave/test-pgo", 01:27:04 INFO - "project": "", 01:27:04 INFO - "platform": "ubuntu64_hw", 01:27:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:27:04 INFO - "slavebuilddir": "test", 01:27:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 01:27:04 INFO - "branch": "mozilla-beta", 01:27:04 INFO - "repo_path": "releases/mozilla-beta", 01:27:04 INFO - "stage_platform": "linux64-pgo", 01:27:04 INFO - "builduid": "eb2ea0af6ac2494ca810680a4890723f", 01:27:04 INFO - "revision": "3bc504ea394f" 01:27:04 INFO - }, 01:27:04 INFO - "sourcestamp": { 01:27:04 INFO - "repository": "", 01:27:04 INFO - "hasPatch": false, 01:27:04 INFO - "project": "", 01:27:04 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:27:04 INFO - "changes": [ 01:27:04 INFO - { 01:27:04 INFO - "category": null, 01:27:04 INFO - "files": [ 01:27:04 INFO - { 01:27:04 INFO - "url": null, 01:27:04 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2" 01:27:04 INFO - } 01:27:04 INFO - ], 01:27:04 INFO - "repository": "", 01:27:04 INFO - "rev": "3bc504ea394f", 01:27:04 INFO - "who": "sendchange", 01:27:04 INFO - "when": 1453769833, 01:27:04 INFO - "number": 7514634, 01:27:04 INFO - "comments": "Bug 1241916 - Adds gn locale to browser/locales/shipped-locales. r=delphine a=sylvestre", 01:27:04 INFO - "project": "", 01:27:04 INFO - "at": "Mon 25 Jan 2016 16:57:13", 01:27:04 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 01:27:04 INFO - "revlink": "", 01:27:04 INFO - "properties": [ 01:27:04 INFO - [ 01:27:04 INFO - "buildid", 01:27:04 INFO - "20160125070233", 01:27:04 INFO - "Change" 01:27:04 INFO - ], 01:27:04 INFO - [ 01:27:04 INFO - "builduid", 01:27:04 INFO - "eb2ea0af6ac2494ca810680a4890723f", 01:27:04 INFO - "Change" 01:27:04 INFO - ], 01:27:04 INFO - [ 01:27:04 INFO - "pgo_build", 01:27:04 INFO - "True", 01:27:04 INFO - "Change" 01:27:04 INFO - ] 01:27:04 INFO - ], 01:27:04 INFO - "revision": "3bc504ea394f" 01:27:04 INFO - } 01:27:04 INFO - ], 01:27:04 INFO - "revision": "3bc504ea394f" 01:27:04 INFO - } 01:27:04 INFO - } 01:27:04 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2. 01:27:04 INFO - Running post-action listener: _resource_record_post_action 01:27:04 INFO - ##### 01:27:04 INFO - ##### Running download-and-extract step. 01:27:04 INFO - ##### 01:27:04 INFO - Running pre-action listener: _resource_record_pre_action 01:27:04 INFO - Running main action method: download_and_extract 01:27:04 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:27: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')]} 01:27:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json 01:27:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:27:04 INFO - Downloaded 1270 bytes. 01:27:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:27:04 INFO - Using the following test package requirements: 01:27:04 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:27:04 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 01:27:04 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'jsshell-linux-x86_64.zip'], 01:27:04 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 01:27:04 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:27:04 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 01:27:04 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 01:27:04 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 01:27:04 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 01:27:04 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 01:27:04 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 01:27:04 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:27: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')]} 01:27:04 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:27:04 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:04 INFO - Downloaded 21580477 bytes. 01:27:04 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 01:27:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:27:04 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 01:27:05 INFO - Return code: 0 01:27:05 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 01:27:05 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')]} 01:27:05 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:27:05 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:06 INFO - Downloaded 21580477 bytes. 01:27:06 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 01:27:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 01:27:06 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 01:27:08 INFO - Return code: 0 01:27: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')]} 01:27:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:27:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:08 INFO - Downloaded 11132038 bytes. 01:27:08 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 01:27:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 01:27:08 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 01:27:08 INFO - Return code: 0 01:27: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')]} 01:27:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:27:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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 01:27:09 INFO - Downloaded 57947831 bytes. 01:27:09 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:27:09 INFO - mkdir: /builds/slave/test-pgo/properties 01:27:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:27:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:27:09 INFO - Contents: 01:27:09 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 01:27:09 INFO - Running post-action listener: _resource_record_post_action 01:27:09 INFO - Running post-action listener: set_extra_try_arguments 01:27:09 INFO - ##### 01:27:09 INFO - ##### Running populate-webroot step. 01:27:09 INFO - ##### 01:27:09 INFO - Running pre-action listener: _resource_record_pre_action 01:27:09 INFO - Running main action method: populate_webroot 01:27:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:27:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:27:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:27:09 INFO - '--tppagecycles', 01:27:09 INFO - '7'], 01:27:09 INFO - 'tests': ['tsvgm']}}, 01:27:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:27:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:27:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'tests': ['damp', 'tps']}, 01:27:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['damp', 'tps']}, 01:27:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:27:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:27:09 INFO - 'other': {'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'other_l64': {'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'other_nol64': {'tests': ['a11yr', 01:27:09 INFO - 'ts_paint', 01:27:09 INFO - 'tpaint', 01:27:09 INFO - 'sessionrestore', 01:27:09 INFO - 'sessionrestore_no_auto_restore']}, 01:27:09 INFO - 'svgr': {'tests': ['tsvgx', 01:27:09 INFO - 'tsvgr_opacity', 01:27:09 INFO - 'tart', 01:27:09 INFO - 'tscrollx', 01:27:09 INFO - 'cart']}, 01:27:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['tsvgx', 01:27:09 INFO - 'tsvgr_opacity', 01:27:09 INFO - 'tart', 01:27:09 INFO - 'tscrollx', 01:27:09 INFO - 'cart']}, 01:27:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'tests': ['tp5o']}, 01:27:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'talos_options': ['--e10s'], 01:27:09 INFO - 'tests': ['tp5o']}, 01:27:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'talos_options': ['--xperf_path', 01:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:09 INFO - 'tests': ['tp5n']}, 01:27:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:09 INFO - 'talos_options': ['--e10s', 01:27:09 INFO - '--xperf_path', 01:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:09 INFO - 'tests': ['tp5n']}}, 01:27:09 INFO - 'talos.zip': {'path': '', 01:27:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:27:09 INFO - Running post-action listener: _resource_record_post_action 01:27:09 INFO - ##### 01:27:09 INFO - ##### Running create-virtualenv step. 01:27:09 INFO - ##### 01:27:09 INFO - Running pre-action listener: _resource_record_pre_action 01:27:09 INFO - Running main action method: create_virtualenv 01:27:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:27:09 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 01:27:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:27:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:27:09 INFO - Using real prefix '/usr' 01:27:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:27:10 INFO - Installing distribute.............................................................................................................................................................................................done. 01:27:12 INFO - Installing pip.................done. 01:27:12 INFO - Return code: 0 01:27:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:12 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 01:27:12 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 01:27:12 INFO - Using env: {'DISPLAY': ':0', 01:27:12 INFO - 'HOME': '/home/cltbld', 01:27:12 INFO - 'LANG': 'en_US.UTF-8', 01:27:12 INFO - 'LANGUAGE': 'en_US:en', 01:27:12 INFO - 'LOGNAME': 'cltbld', 01:27:12 INFO - 'MAIL': '/var/mail/cltbld', 01:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:12 INFO - 'MOZ_NO_REMOTE': '1', 01:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:12 INFO - 'NO_EM_RESTART': '1', 01:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:12 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:12 INFO - 'SHELL': '/bin/bash', 01:27:12 INFO - 'SHLVL': '1', 01:27:12 INFO - 'TERM': 'linux', 01:27:12 INFO - 'TMOUT': '86400', 01:27:12 INFO - 'USER': 'cltbld', 01:27:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:12 INFO - '_': '/tools/buildbot/bin/python'} 01:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:12 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 01:27:12 INFO - Cleaning up... 01:27:12 INFO - Return code: 0 01:27:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:12 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:12 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 01:27:12 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 01:27:12 INFO - Using env: {'DISPLAY': ':0', 01:27:12 INFO - 'HOME': '/home/cltbld', 01:27:12 INFO - 'LANG': 'en_US.UTF-8', 01:27:12 INFO - 'LANGUAGE': 'en_US:en', 01:27:12 INFO - 'LOGNAME': 'cltbld', 01:27:12 INFO - 'MAIL': '/var/mail/cltbld', 01:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:12 INFO - 'MOZ_NO_REMOTE': '1', 01:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:12 INFO - 'NO_EM_RESTART': '1', 01:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:12 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:12 INFO - 'SHELL': '/bin/bash', 01:27:12 INFO - 'SHLVL': '1', 01:27:12 INFO - 'TERM': 'linux', 01:27:12 INFO - 'TMOUT': '86400', 01:27:12 INFO - 'USER': 'cltbld', 01:27:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:12 INFO - '_': '/tools/buildbot/bin/python'} 01:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:12 INFO - Downloading/unpacking psutil>=0.7.1 01:27:12 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 01:27:12 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 01:27:12 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 01:27:12 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 01:27:12 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 01:27:12 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 01:27:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:27:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:14 INFO - Installing collected packages: psutil 01:27:14 INFO - Running setup.py install for psutil 01:27:14 INFO - building 'psutil._psutil_linux' extension 01:27:14 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 01:27:14 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 01:27:14 INFO - building 'psutil._psutil_posix' extension 01:27:14 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 01:27:14 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 01:27:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:14 INFO - Successfully installed psutil 01:27:14 INFO - Cleaning up... 01:27:14 INFO - Return code: 0 01:27:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:27:14 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')]} 01:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:14 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')]} 01:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:14 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:14 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 01:27:14 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 01:27:14 INFO - Using env: {'DISPLAY': ':0', 01:27:14 INFO - 'HOME': '/home/cltbld', 01:27:14 INFO - 'LANG': 'en_US.UTF-8', 01:27:14 INFO - 'LANGUAGE': 'en_US:en', 01:27:14 INFO - 'LOGNAME': 'cltbld', 01:27:14 INFO - 'MAIL': '/var/mail/cltbld', 01:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:14 INFO - 'MOZ_NO_REMOTE': '1', 01:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:14 INFO - 'NO_EM_RESTART': '1', 01:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:14 INFO - 'SHELL': '/bin/bash', 01:27:14 INFO - 'SHLVL': '1', 01:27:14 INFO - 'TERM': 'linux', 01:27:14 INFO - 'TMOUT': '86400', 01:27:14 INFO - 'USER': 'cltbld', 01:27:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:14 INFO - '_': '/tools/buildbot/bin/python'} 01:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:27:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:27:17 INFO - Installing collected packages: mozsystemmonitor 01:27:17 INFO - Running setup.py install for mozsystemmonitor 01:27:17 INFO - Successfully installed mozsystemmonitor 01:27:17 INFO - Cleaning up... 01:27:18 INFO - Return code: 0 01:27:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:27:18 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')]} 01:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:18 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')]} 01:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:18 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:18 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 01:27:18 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 01:27:18 INFO - Using env: {'DISPLAY': ':0', 01:27:18 INFO - 'HOME': '/home/cltbld', 01:27:18 INFO - 'LANG': 'en_US.UTF-8', 01:27:18 INFO - 'LANGUAGE': 'en_US:en', 01:27:18 INFO - 'LOGNAME': 'cltbld', 01:27:18 INFO - 'MAIL': '/var/mail/cltbld', 01:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:18 INFO - 'MOZ_NO_REMOTE': '1', 01:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:18 INFO - 'NO_EM_RESTART': '1', 01:27:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:18 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:18 INFO - 'SHELL': '/bin/bash', 01:27:18 INFO - 'SHLVL': '1', 01:27:18 INFO - 'TERM': 'linux', 01:27:18 INFO - 'TMOUT': '86400', 01:27:18 INFO - 'USER': 'cltbld', 01:27:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:18 INFO - '_': '/tools/buildbot/bin/python'} 01:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:27:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:27:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:27:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:27:20 INFO - Downloading docopt-0.6.1.tar.gz 01:27:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:27:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:27:20 INFO - Running setup.py install for blobuploader 01:27:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:27:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:27:20 INFO - Running setup.py install for requests 01:27:21 INFO - Running setup.py install for docopt 01:27:21 INFO - Successfully installed blobuploader requests docopt 01:27:21 INFO - Cleaning up... 01:27:21 INFO - Return code: 0 01:27:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:27:21 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')]} 01:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:21 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')]} 01:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:21 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:21 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 01:27:21 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 01:27:21 INFO - Using env: {'DISPLAY': ':0', 01:27:21 INFO - 'HOME': '/home/cltbld', 01:27:21 INFO - 'LANG': 'en_US.UTF-8', 01:27:21 INFO - 'LANGUAGE': 'en_US:en', 01:27:21 INFO - 'LOGNAME': 'cltbld', 01:27:21 INFO - 'MAIL': '/var/mail/cltbld', 01:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:21 INFO - 'MOZ_NO_REMOTE': '1', 01:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:21 INFO - 'NO_EM_RESTART': '1', 01:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:21 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:21 INFO - 'SHELL': '/bin/bash', 01:27:21 INFO - 'SHLVL': '1', 01:27:21 INFO - 'TERM': 'linux', 01:27:21 INFO - 'TMOUT': '86400', 01:27:21 INFO - 'USER': 'cltbld', 01:27:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:21 INFO - '_': '/tools/buildbot/bin/python'} 01:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:27:21 INFO - Running setup.py (path:/tmp/pip-ZXZB9f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:27:21 INFO - Running setup.py (path:/tmp/pip-ucuIsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:27:21 INFO - Running setup.py (path:/tmp/pip-DVMLGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:27:21 INFO - Running setup.py (path:/tmp/pip-qotlxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:27:21 INFO - Running setup.py (path:/tmp/pip-S6OZQz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:27:21 INFO - Running setup.py (path:/tmp/pip-DdAjpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:27:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:27:21 INFO - Running setup.py (path:/tmp/pip-sRK1PG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:27:22 INFO - Running setup.py (path:/tmp/pip-LKZM_s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:27:22 INFO - Running setup.py (path:/tmp/pip-8FGJeV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:27:22 INFO - Running setup.py (path:/tmp/pip-4W8bWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:27:22 INFO - Running setup.py (path:/tmp/pip-S1rs43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:27:22 INFO - Running setup.py (path:/tmp/pip-dF1Mpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:27:22 INFO - Running setup.py (path:/tmp/pip-aB1Sft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:27:22 INFO - Running setup.py (path:/tmp/pip-vlCbth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:27:22 INFO - Running setup.py (path:/tmp/pip-gP_Q4N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:27:22 INFO - Running setup.py (path:/tmp/pip-DX8JfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:27:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:27:22 INFO - Running setup.py (path:/tmp/pip-UUGHHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:27:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:27:22 INFO - Running setup.py install for manifestparser 01:27:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:27:22 INFO - Running setup.py install for mozcrash 01:27:22 INFO - Running setup.py install for mozdebug 01:27:23 INFO - Running setup.py install for mozdevice 01:27:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for mozfile 01:27:23 INFO - Running setup.py install for mozhttpd 01:27:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for mozinfo 01:27:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for mozInstall 01:27:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for mozleak 01:27:23 INFO - Running setup.py install for mozlog 01:27:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for moznetwork 01:27:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:27:23 INFO - Running setup.py install for mozprocess 01:27:24 INFO - Running setup.py install for mozprofile 01:27:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:27:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:27:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:27:24 INFO - Running setup.py install for mozrunner 01:27:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:27:24 INFO - Running setup.py install for mozscreenshot 01:27:24 INFO - Running setup.py install for moztest 01:27:24 INFO - Running setup.py install for mozversion 01:27:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:27:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:27:24 INFO - Cleaning up... 01:27:24 INFO - Return code: 0 01:27:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:27:24 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')]} 01:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:24 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')]} 01:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:24 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:24 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 01:27:24 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 01:27:24 INFO - Using env: {'DISPLAY': ':0', 01:27:24 INFO - 'HOME': '/home/cltbld', 01:27:24 INFO - 'LANG': 'en_US.UTF-8', 01:27:24 INFO - 'LANGUAGE': 'en_US:en', 01:27:24 INFO - 'LOGNAME': 'cltbld', 01:27:24 INFO - 'MAIL': '/var/mail/cltbld', 01:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:24 INFO - 'MOZ_NO_REMOTE': '1', 01:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:24 INFO - 'NO_EM_RESTART': '1', 01:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:24 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:24 INFO - 'SHELL': '/bin/bash', 01:27:24 INFO - 'SHLVL': '1', 01:27:24 INFO - 'TERM': 'linux', 01:27:24 INFO - 'TMOUT': '86400', 01:27:24 INFO - 'USER': 'cltbld', 01:27:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:24 INFO - '_': '/tools/buildbot/bin/python'} 01:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:27:24 INFO - Running setup.py (path:/tmp/pip-1Ju4uG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:27:24 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)) 01:27:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:27:24 INFO - Running setup.py (path:/tmp/pip-H6vbZj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:27:24 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)) 01:27:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:27:24 INFO - Running setup.py (path:/tmp/pip-7S1Qia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:27:24 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)) 01:27:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:27:25 INFO - Running setup.py (path:/tmp/pip-aVHvjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:27:25 INFO - Running setup.py (path:/tmp/pip-GxJ3zm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:27:25 INFO - Running setup.py (path:/tmp/pip-LEFHLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:27:25 INFO - Running setup.py (path:/tmp/pip-fFPJ2M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:27:25 INFO - Running setup.py (path:/tmp/pip-rqaC8J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:27:25 INFO - Running setup.py (path:/tmp/pip-OdwXnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:27:25 INFO - Running setup.py (path:/tmp/pip-eH3mfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:27:25 INFO - Running setup.py (path:/tmp/pip-7I9kuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:27:25 INFO - Running setup.py (path:/tmp/pip-jfE_mA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:27:25 INFO - Running setup.py (path:/tmp/pip-FSbnx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:27:25 INFO - Running setup.py (path:/tmp/pip-spMyRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:27:25 INFO - Running setup.py (path:/tmp/pip-Ao6IXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:27:25 INFO - Running setup.py (path:/tmp/pip-_3L3yR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:27:25 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)) 01:27:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:27:25 INFO - Running setup.py (path:/tmp/pip-vjZyhU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:27:26 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)) 01:27:26 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)) 01:27:26 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)) 01:27:26 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)) 01:27:26 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)) 01:27:26 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)) 01:27:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:27:26 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 01:27:26 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 01:27:26 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 01:27:26 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 01:27:26 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 01:27:26 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 01:27:27 INFO - Downloading blessings-1.6.tar.gz 01:27:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:27:27 INFO - Installing collected packages: blessings 01:27:27 INFO - Running setup.py install for blessings 01:27:27 INFO - Successfully installed blessings 01:27:27 INFO - Cleaning up... 01:27:28 INFO - Return code: 0 01:27:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:27:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:27:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:27:28 INFO - Reading from file tmpfile_stdout 01:27:28 INFO - Current package versions: 01:27:28 INFO - argparse == 1.2.1 01:27:28 INFO - blessings == 1.6 01:27:28 INFO - blobuploader == 1.2.4 01:27:28 INFO - docopt == 0.6.1 01:27:28 INFO - manifestparser == 1.1 01:27:28 INFO - mozInstall == 1.12 01:27:28 INFO - mozcrash == 0.16 01:27:28 INFO - mozdebug == 0.1 01:27:28 INFO - mozdevice == 0.47 01:27:28 INFO - mozfile == 1.2 01:27:28 INFO - mozhttpd == 0.7 01:27:28 INFO - mozinfo == 0.9 01:27:28 INFO - mozleak == 0.1 01:27:28 INFO - mozlog == 3.1 01:27:28 INFO - moznetwork == 0.27 01:27:28 INFO - mozprocess == 0.22 01:27:28 INFO - mozprofile == 0.27 01:27:28 INFO - mozrunner == 6.11 01:27:28 INFO - mozscreenshot == 0.1 01:27:28 INFO - mozsystemmonitor == 0.0 01:27:28 INFO - moztest == 0.7 01:27:28 INFO - mozversion == 1.4 01:27:28 INFO - psutil == 3.1.1 01:27:28 INFO - requests == 1.2.3 01:27:28 INFO - wsgiref == 0.1.2 01:27:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:27:28 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')]} 01:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:28 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')]} 01:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:28 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:28 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 01:27:28 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 01:27:28 INFO - Using env: {'DISPLAY': ':0', 01:27:28 INFO - 'HOME': '/home/cltbld', 01:27:28 INFO - 'LANG': 'en_US.UTF-8', 01:27:28 INFO - 'LANGUAGE': 'en_US:en', 01:27:28 INFO - 'LOGNAME': 'cltbld', 01:27:28 INFO - 'MAIL': '/var/mail/cltbld', 01:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:28 INFO - 'MOZ_NO_REMOTE': '1', 01:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:28 INFO - 'NO_EM_RESTART': '1', 01:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:28 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:28 INFO - 'SHELL': '/bin/bash', 01:27:28 INFO - 'SHLVL': '1', 01:27:28 INFO - 'TERM': 'linux', 01:27:28 INFO - 'TMOUT': '86400', 01:27:28 INFO - 'USER': 'cltbld', 01:27:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:28 INFO - '_': '/tools/buildbot/bin/python'} 01:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 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)) 01:27:28 INFO - Cleaning up... 01:27:28 INFO - Return code: 0 01:27:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:27:28 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')]} 01:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:28 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')]} 01:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:28 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:28 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 01:27:28 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 01:27:28 INFO - Using env: {'DISPLAY': ':0', 01:27:28 INFO - 'HOME': '/home/cltbld', 01:27:28 INFO - 'LANG': 'en_US.UTF-8', 01:27:28 INFO - 'LANGUAGE': 'en_US:en', 01:27:28 INFO - 'LOGNAME': 'cltbld', 01:27:28 INFO - 'MAIL': '/var/mail/cltbld', 01:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:28 INFO - 'MOZ_NO_REMOTE': '1', 01:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:28 INFO - 'NO_EM_RESTART': '1', 01:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:28 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:28 INFO - 'SHELL': '/bin/bash', 01:27:28 INFO - 'SHLVL': '1', 01:27:28 INFO - 'TERM': 'linux', 01:27:28 INFO - 'TMOUT': '86400', 01:27:28 INFO - 'USER': 'cltbld', 01:27:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:28 INFO - '_': '/tools/buildbot/bin/python'} 01:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:28 INFO - Downloading/unpacking jsonschema 01:27:28 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 01:27:28 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 01:27:28 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 01:27:28 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 01:27:28 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 01:27:28 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 01:27:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:27:30 INFO - Downloading/unpacking functools32 (from jsonschema) 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 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 01:27:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:27:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:27:30 INFO - warning: no files found matching '*.txt' 01:27:30 INFO - no previously-included directories found matching 'build' 01:27:30 INFO - no previously-included directories found matching 'dist' 01:27:30 INFO - no previously-included directories found matching '.git*' 01:27:30 INFO - Installing collected packages: jsonschema, functools32 01:27:30 INFO - Running setup.py install for functools32 01:27:30 INFO - warning: no files found matching '*.txt' 01:27:30 INFO - no previously-included directories found matching 'build' 01:27:30 INFO - no previously-included directories found matching 'dist' 01:27:30 INFO - no previously-included directories found matching '.git*' 01:27:30 INFO - Successfully installed jsonschema functools32 01:27:30 INFO - Cleaning up... 01:27:30 INFO - Return code: 0 01:27:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:30 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 0x7fa2fa689f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, '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': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', '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 01:27:30 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 01:27:30 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 01:27:30 INFO - Using env: {'DISPLAY': ':0', 01:27:30 INFO - 'HOME': '/home/cltbld', 01:27:30 INFO - 'LANG': 'en_US.UTF-8', 01:27:30 INFO - 'LANGUAGE': 'en_US:en', 01:27:30 INFO - 'LOGNAME': 'cltbld', 01:27:30 INFO - 'MAIL': '/var/mail/cltbld', 01:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:30 INFO - 'MOZ_NO_REMOTE': '1', 01:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:30 INFO - 'NO_EM_RESTART': '1', 01:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:30 INFO - 'SHELL': '/bin/bash', 01:27:30 INFO - 'SHLVL': '1', 01:27:30 INFO - 'TERM': 'linux', 01:27:30 INFO - 'TMOUT': '86400', 01:27:30 INFO - 'USER': 'cltbld', 01:27:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:30 INFO - '_': '/tools/buildbot/bin/python'} 01:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:31 INFO - Downloading/unpacking flake8 01:27:31 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 01:27:31 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 01:27:31 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 01:27:31 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 01:27:31 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 01:27:31 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 01:27:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:27:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:27:32 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 01:27:32 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 01:27:32 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 01:27:32 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 01:27:32 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 01:27:32 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 01:27:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:27:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 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 01:27:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:27:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:33 INFO - no previously-included directories found matching 'docs/_build' 01:27:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:27:33 INFO - Running setup.py install for pep8 01:27:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:27:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:27:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:27:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:27:33 INFO - no previously-included directories found matching 'docs/_build' 01:27:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:27:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:27:33 INFO - Cleaning up... 01:27:33 INFO - Return code: 0 01:27:33 INFO - Running post-action listener: _resource_record_post_action 01:27:33 INFO - Running post-action listener: _start_resource_monitoring 01:27:33 INFO - Starting resource monitoring. 01:27:33 INFO - ##### 01:27:33 INFO - ##### Running install step. 01:27:33 INFO - ##### 01:27:33 INFO - Running pre-action listener: _resource_record_pre_action 01:27:33 INFO - Running main action method: install 01:27:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:27:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:27:34 INFO - Reading from file tmpfile_stdout 01:27:34 INFO - Detecting whether we're running mozinstall >=1.0... 01:27:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:27:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:27:34 INFO - Reading from file tmpfile_stdout 01:27:34 INFO - Output received: 01:27:34 INFO - Usage: mozinstall [options] installer 01:27:34 INFO - Options: 01:27:34 INFO - -h, --help show this help message and exit 01:27:34 INFO - -d DEST, --destination=DEST 01:27:34 INFO - Directory to install application into. [default: 01:27:34 INFO - "/builds/slave/test-pgo"] 01:27:34 INFO - --app=APP Application being installed. [default: firefox] 01:27:34 INFO - mkdir: /builds/slave/test-pgo/build/application 01:27:34 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'] 01:27:34 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 01:27:48 INFO - Reading from file tmpfile_stdout 01:27:48 INFO - Output received: 01:27:48 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:27:48 INFO - Running post-action listener: _resource_record_post_action 01:27:48 INFO - ##### 01:27:48 INFO - ##### Running run-tests step. 01:27:48 INFO - ##### 01:27:48 INFO - Running pre-action listener: _resource_record_pre_action 01:27:48 INFO - Running main action method: run_tests 01:27:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:27:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:27:48 INFO - Python 2.7.3 01:27:48 INFO - Return code: 0 01:27:48 INFO - grabbing minidump binary from tooltool 01:27: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')]} 01:27:48 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 0x286f350>, '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 0x2870250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28706e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:27:48 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 01:27:48 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 01:27:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:27:48 INFO - Return code: 0 01:27:48 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:27:48 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:27:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:27:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:27:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:27:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:27:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:27:49 INFO - Return code: 0 01:27:49 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 01:27:49 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost 01:27:49 INFO - Using env: {'DISPLAY': ':0', 01:27:49 INFO - 'HOME': '/home/cltbld', 01:27:49 INFO - 'LANG': 'en_US.UTF-8', 01:27:49 INFO - 'LANGUAGE': 'en_US:en', 01:27:49 INFO - 'LOGNAME': 'cltbld', 01:27:49 INFO - 'MAIL': '/var/mail/cltbld', 01:27:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:27:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:49 INFO - 'MOZ_NO_REMOTE': '1', 01:27:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:49 INFO - 'NO_EM_RESTART': '1', 01:27:49 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:27:49 INFO - 'PWD': '/builds/slave/test-pgo', 01:27:49 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:27:49 INFO - 'SHELL': '/bin/bash', 01:27:49 INFO - 'SHLVL': '1', 01:27:49 INFO - 'TERM': 'linux', 01:27:49 INFO - 'TMOUT': '86400', 01:27:49 INFO - 'USER': 'cltbld', 01:27:49 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555', 01:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:49 INFO - '_': '/tools/buildbot/bin/python'} 01:27:49 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/1453734153/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost'] with output_timeout 3600 01:27:49 INFO - mozversion INFO | application_buildid: 20160125070233 01:27:49 INFO - mozversion INFO | application_changeset: 3bc504ea394fe54d1dbb3afc86534b25c36432bd 01:27:49 INFO - mozversion INFO | application_display_name: Nightly 01:27:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:27:49 INFO - mozversion INFO | application_name: Firefox 01:27:49 INFO - mozversion INFO | application_remotingname: firefox 01:27:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:49 INFO - mozversion INFO | application_vendor: Mozilla 01:27:49 INFO - mozversion INFO | application_version: 45.0 01:27:49 INFO - mozversion INFO | platform_buildid: 20160125070233 01:27:49 INFO - mozversion INFO | platform_changeset: 3bc504ea394fe54d1dbb3afc86534b25c36432bd 01:27:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:27:49 INFO - mozversion INFO | platform_version: 45.0 01:27:49 INFO - 2016-01-26 01:27:49,936 DEBUG : using testdate: 1453800469 01:27:49 INFO - 2016-01-26 01:27:49,936 DEBUG : actual date: 1453800469 01:27:49 INFO - 2016-01-26 01:27:49,984 INFO : starting webserver on 'localhost:37175' 01:27:49 INFO - 2016-01-26 01:27:49,985 INFO : Starting test suite talos-linux64-ix-060 01:27:49 INFO - 2016-01-26 01:27:49,985 INFO : Starting test dromaeo_css 01:27:49 INFO - 2016-01-26 01:27:49,985 DEBUG : operating with platform_type : linux_ 01:27:49 INFO - 2016-01-26 01:27:49,986 INFO : Initialising browser for dromaeo_css test... 01:27:50 INFO - 2016-01-26 01:27:50,002 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0FJC_3/profile http://localhost:37175/getInfo.html 01:27:54 INFO - 2016-01-26 01:27:54,462 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:27:54 INFO - 2016-01-26 01:27:54,462 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:27:54 INFO - 2016-01-26 01:27:54,462 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:27:54 INFO - 2016-01-26 01:27:54,462 DEBUG : BROWSER_OUTPUT: __metrics 01:27:54 INFO - 2016-01-26 01:27:54,612 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] 01:27:55 INFO - 2016-01-26 01:27:55,371 INFO : Browser initialized. 01:27:55 INFO - 2016-01-26 01:27:55,372 INFO : Running cycle 1/1 for dromaeo_css test... 01:27:55 INFO - 2016-01-26 01:27:55,372 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0FJC_3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:28:07 INFO - 2016-01-26 01:28:07,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 134217728 01:28:07 INFO - 2016-01-26 01:28:07,109 DEBUG : BROWSER_OUTPUT: 01:28:58 INFO - 2016-01-26 01:28:58,137 DEBUG : BROWSER_OUTPUT: 1453800538133 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] 01:31:06 INFO - 2016-01-26 01:31:06,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37175/tests/dromaeo/cssquery-ext.html) 01:31:07 INFO - 2016-01-26 01:31:07,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 244772864 01:31:07 INFO - 2016-01-26 01:31:07,305 DEBUG : BROWSER_OUTPUT: 01:34:09 INFO - 2016-01-26 01:34:09,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-ext.html (next: http://localhost:37175/tests/dromaeo/cssquery-jquery.html) 01:34:09 INFO - 2016-01-26 01:34:09,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 209682432 01:34:09 INFO - 2016-01-26 01:34:09,972 DEBUG : BROWSER_OUTPUT: 01:37:11 INFO - 2016-01-26 01:37:11,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37175/tests/dromaeo/cssquery-mootools.html) 01:37:12 INFO - 2016-01-26 01:37:12,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 213004288 01:37:12 INFO - 2016-01-26 01:37:12,227 DEBUG : BROWSER_OUTPUT: 01:40:13 INFO - 2016-01-26 01:40:13,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37175/tests/dromaeo/cssquery-prototype.html) 01:40:14 INFO - 2016-01-26 01:40:14,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 196608000 01:40:14 INFO - 2016-01-26 01:40:14,432 DEBUG : BROWSER_OUTPUT: 01:43:16 INFO - 2016-01-26 01:43:16,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37175/tests/dromaeo/cssquery-yui.html) 01:43:17 INFO - 2016-01-26 01:43:17,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 198959104 01:43:17 INFO - 2016-01-26 01:43:17,370 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-yui.html (next: http://localhost:37175/tests/dromaeo/cssquery-dojo.html) 01:46:19 INFO - 2016-01-26 01:46:19,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 242692096 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3343.4149023920813;3396.0660818274987;3417.0773891049416;3420.3843308204546;3440.845161967711;5594.608377413582;5606.971965140168;5614.382417934024;5618.662880227184;5645.60480766346;5626.184203290521;5662.320521537421;5679.375268720448;5679.5740319476;5692.686902220376;4870.586000189988;5157.53582177603;5183.326167598207;5245.527902488775;5275.894482110375;5027.195648696209;5047.545720885119;5108.64239503235;5145.459726728677;5153.768080436371;5140.997505486432;5175.146100893367;5198.142306519419;5207.921881171786;5225.399079105894;5035.899282014376;5102.9489705103215;5119.872003199913;5178.119719647669;5210.869728256786;4939.506049395068;5059.3422855028975;5064.442911279756;5074.162763144077;5076.466970968032;5426.077566813612;5430.3755068167275;5447.782088716446;5449.6730196187955;5464.666214436801;5872.236609240814;6027.758889644453;6094.024956007018;6096.4903529599715;6097.3292937776805;5990.730417131196;6065.5450841187085;6094.5329332676565;6096.268447786294;6109.5723299369065;5646.265985421869;5649.359018847718;5724.370319264877;5729.713514324267;5729.885402291972;6080.75012245472;6182.969085154546;6192.442680158717;6213.96893015532;6219.502439804895;5856.297244330707;5927.318358388754;5929.762809487658;5931.169636250928;5969.074793407029;6103.23709536308;6103.786367477206;6104.053871649901;6108.3280839107665;6110.450059494667;5837.270341207349;5969.283685957626;5971.671558064349;6057.757689692451;6074.696265186723;6057.545684073712;6084.543659225487;6087.969560152171;6088.086786981989;6109.205803245639;4645.419322584677;4649.790759415834;4651.813927442864;4654.720716757005;4678.578927896506;4061.5126184857413;4097.467329247179;4139.399787030864;4146.274401979642;4193;5754.079347304411;5795.1886735857015;5797.652140871562;5798.971005145032;5800.477956983892;6068.271807383142;6106.938930610637;6119.112728654321;6124.724387402578;6135.754569817246;5624.971875140598;5648.491635752802;5735.340435849931;5747.3103227612955;5762.279715035621;5337.386200586904;5344.412114667383;5345.037893179265;5347.732613369316;5352.19717042439;6274.937250627435;6286.4342209201395;6294.213223347173;6297.086922396227;6297.338779428185;5837.270341207349;5968.552358573038;6072.574919755575;6164.7842325518395;6185.226846644169;6290.685465726604;6344.460720838596;6346.873062538631;6349;6356.3325850785;5798.188253644409;6103.908441373294;6103.908441373472;6105.633661980118;6111.205543279345;5934.554908381975;6003.339632640494;6029.51763858899;6070.453659170696;6103.664298463627;5915.668974480879;5964.5526585505395;5968.224130863134;5973.940260597338;5994.760209591567;5798.942010580009;5912.467877890838;5946.524278057832;5949.2266005419015;5967.194428752063;5785.681787501728;5830.708464576839;5859.794907178229;5862.7654893805475;5899.705014749331;5973.223480947449;5999.370066142992;6001.639901605918;6020.608660437058;6024.487918526975;5618.073017951992;5669.971650141723;5750.7987220447085;5856;5863.149843272787 01:46:19 INFO - 2016-01-26 01:46:19,854 DEBUG : BROWSER_OUTPUT: |1;ext.html;581.9505342045926;639.6194264412675;661.5203977116589;662.4600950225569;664.8204984654144;32680.67319326806;34071.82964085176;34082.318353632945;34083.14792130192;34091.14772130698;42257.57742422575;42942.570574294245;43015;43031;43128.568714312845;9120.954395228015;9308.534573271343;9316.58075386606;9321.300902432346;9322.347435679505;8272.793180170484;8463;8478.915210847905;9061.365704400694;9195.126462986005;8205.343572514214;10978.396188209645;11187.608433704821;11203.04774094203;11223.775524489505;10763.515641796137;10847.511861966192;10866.891331086666;10871.945640271828;10878.292910960841;10621.681349559525;10696.78606427875;10746.408947507884;10764.300320479144;10768.084712799422;42680;43066.35400468996;43142;43216.351754723706;43274.56725432768;3372.15696075981;3389.5932488101585;3433;3540.7698499597445;3621.4386770050683;32044.6795532044;32353.867614633375;32388.514172287436;32553.348933021443;32625;4042.8382864685377;4200.494877324095;4279.315309550457;4299.548547402509;4339.479262488521;312584;313212;313417;313689;314317;56273.718631406584;57206.7139664299;59196;59244;59467.10799338014;72610.2738972614;73381;73395;73789.26210737931;73802.26197737954;17541;17683.646327073388;17694.11529423524;17846;17884.731729024075;13608.115472494255;13678.247696376795;13680.31598420075;13692.31538423075;13697.041207115406;20109.19563217455;20389;20452.795472045385;20477;20600.793992060186;8129.796755081052;8314.916850831536;8319.459235149696;8334.62494187763;8398.286145677564;991.2367477042637;1023.744063984004;1083.268793564341;1135.6195674448986;1135.6706555098929;28706.13881583556;29303.706962930522;29835.552466713016;30176.84911575472;30256.84871575628;1081.210716177195;1132.4847194526471;1137.4312843578211;1137.6757624077263;1214.7509760499076;13245.470181192837;13436.462541498426;13664.93167534156;13959.232242226775;14859.2570371481;350972;351197;354764;356115;358178;55134.72432637811;55257.447425526036;55308.44691553033;55850;55914;1305.8824705776526;1321.3723481346476;1335.252258735092;1351.074513957942;1446.2262689461297;26465.206043818715;26538;26727.86636066807;26891.596626050232;27008.864955675097;41614.791926040176;41661;41788.164236715704;41816;45807.77096114498;201381;328271;333949;333974;334011;30521.542176866922;30883;31045;31099.067027989197;31148;41081.79459102685;41623.13740583919;41796.75055750316;42272.788636056626;42734.57265427306;35800.64199357973;36000.639993599725;36053.27893442169;36120.638793611724;39632.60367396405;37458.812705936296;38326.61673383231;38750.80624596972;39089;39176.608233918436;35224.471632925015;35615.643843561236;35654.643453565135;38533.22933541257;39258.60741392549;29945.850270748506;31172;33366;33449.33101337911;33457.49813752844;26169;26532.734672653027;26544.469110618065;26858.462830742887;27310.317242069108 01:46:19 INFO - 2016-01-26 01:46:19,855 DEBUG : BROWSER_OUTPUT: |2;jquery.html;392.05905826017556;394.79076089672463;397.5944536572696;397.9960200397997;399.45075521158407;14299.571012869605;16635.66728665429;17129.914350428247;18457.81542184578;18502.907485462572;11538.423078846066;11811.70470738232;11813.527458901655;18664.16011279492;19116.42650720477;5067.518585734359;5182.196759502283;5185.455527169649;5186.948130518703;5189.870253243661;3984.482017337742;4087.7751723655188;4088.4276201331836;5066.923996140061;5478.534324582415;5576;5576.5817563682685;5606.523445507137;5616.85957851055;5625.46558076982;5460.399356070829;5549.306336707911;5549.916751248735;5556.583256255797;5557.833265002077;5340.54605358545;5350.812721554766;5354.9196762048605;5361.383440904268;5365.248865158881;18085.36701215451;19494.025298735007;20279.188832446685;21111.26110586122;21144.5771084579;2191.5288213034114;2253.1325439705834;2255.3459496745922;2262.7284725833006;2284.3717977556307;9183.265338772882;9536.952315238379;9637.662681806174;9653.324267301292;9889.258305627034;1854.935077272289;1901.6291823094502;1910.837578805803;1955.9804401955942;2076.1591555419927;54727.72636136834;56093.55070153079;63835;63971.680141599456;65174.674126629536;11211.215214935039;11230.831537526943;11235.382053986945;11334.263272887236;11336.886631133748;15039.774403383957;15110.54668359951;15138.621534461727;15144.621384465256;15172.620684482976;8536.957315213509;8576.485410875368;8589.65641374338;8592.5703714814;8601.741947741577;8324.334053275723;8341.24928756415;8354.331653467709;8402.915970840213;8406.495610263404;4648.5119062498625;4658.579133364288;4876.926846097312;4901.289313049588;4913;1763.951864393801;1834.367143335547;1884.1427150646423;1911.7132430135591;1914.3778272061636;930.4510338900081;961.110972350573;970.088117169858;1046.0062940206833;1064.1539975719322;14469.204193769443;15856.841431585768;16039.358425663077;16191.676166476604;16618.916905415397;997.0706682569107;997.2620261006803;1006.1548299428515;1023.534291897185;1061.77702682436;9664.90335096654;9881.505924703735;10033.899661003297;10056.145227655585;10071.647492337734;574364;580554;581492;598066;603223;78014;79221.60389198133;80365.65739361654;83617;85595.14404855996;1121.7884684540677;1128.841962125303;1135.1713249328036;1145.7823013627385;1156.7628636129741;15670.529884103495;15712.371505140123;15790;15861.444849430214;16179.352825886832;35471;36215.637843621225;36474.8176259117;37114.62885371112;37205;47509.287360688926;48474.75762621305;49681;51947.74026129845;52202;10039;10106.747331316776;10172.287939844437;10719.678409647722;10749.89250107489;17918.641627167122;18231.817681823544;18252.543686407946;18260.26958921628;18853.434396968114;15196.620084497976;15198.392064317304;15401.229938503255;15686.372545098067;15838;14904.105753654816;15136.621584460476;15182.924085379502;15203.77194342108;15327.77008344898;15318.770218446954;15468.226588670297;15898.841011589737;15996.600084997968;16009.679806403574;9493.76265593338;9988.300818942604;10077.395356278646;10516.842247366449;10667.413292269;13810.585682429542;13997.46154845523;14737.410503579737;15226.46707365237;15272.618184545476 01:46:19 INFO - 2016-01-26 01:46:19,855 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.2619316534901;1516.1282262698944;1637.1568642149289;1777.85777137829;1810.2849374497073;7763.922360776391;8367.623456944437;8369.665213391472;8372.83254334913;8381.036180839204;6865.897011544818;7218;7821.100573434057;7978.561179135145;7978.720744773934;2309.734380546238;2331.3239160643393;2355.046206286448;2356.5404746074437;2357.8938947747306;1967.0263219706264;2362.2086600988605;2393.581123303415;2407.1574948767966;2412.95174096518;1994.5512259741588;2301.539692061586;2336.7312759032757;2338.6258198688215;2339;2260.2880092770724;2285.73714022887;2297.3452566018686;2298.8735619541003;2328.871912044837;2298.7241531016216;2299.494111295512;2323.7560056194193;2324.8837558122195;2325.7906788388955;7990.081140668839;8037.276645101911;8064.879026814602;8069;8077.838443231161;4793.089313030513;4870.0746858096845;4880.951190488086;4889.608831293488;4901.852944411673;3116.844157792101;3132.201288671374;3132.2795756975797;3174.539691744684;3179.2210908327606;1006.2905651515664;1011.281989787252;1036.813373592753;1045.2839804733783;1049.21833234241;11174.720631984266;11196.776064478665;11199.328040317607;11201.383923884183;11219.831702524469;4266.4240327556;4273.636740876998;4284.978575107105;4300.397944287803;4309.439772829513;9584.37701549397;9601;9607.039296070338;9609.423434593948;9616.855747163798;4838.298446725275;4874.268859671007;4875.731834749123;4876.195427754452;4878.731669758197;4439.778011099432;4458.464984201852;4458.866234012985;4463.4420697412825;4464.196444639931;3796;3834.079820842978;3842.193139440693;3863.9034024149623;3867.57456679765;1146.4038699876185;1253.9373031348396;1256.9308688022247;1257.9748405031849;1262.8800263974908;1042.525650828871;1112.076976109827;1173.5951096871565;1325.2379881568138;1423.3737155651688;7673.769786906401;7709.498882572615;7730.420218483636;7737.3036426721865;7781.377489800802;1165.1086918507349;1165.976680466386;1179.598936361624;1183.059467723145;1190.2501424102759;6066.696665166724;6123.479504242189;6126.663033533109;6129.35641757609;6133.907991380132;9389.436633801994;9768.951155244178;9771.951140244395;9903.60385584583;9976.102150806462;9610.90389096114;9670.806583868283;9786.314957953018;9847.359921605073;9851.162651174587;7379.963100184465;7657.770266892002;7728.690852365842;7729.343005844454;7732.265434783687;7504.362129219077;7591.4685971983645;7608.01095857535;7622.199669034671;7622.428317876071;8750.82498350042;8773;8803.295736341206;8863.423877447945;8950.567909134506;8865.601047952987;8921.776955575902;9090.727278181665;9106.134917182857;9174.266058715153;7220.819479513054;7230.855382892208;7248.238934911969;7259.891101633585;7263.564186148848;7803.609819508888;7868.921310786819;7884.369250459835;7899.921000789918;7997.320227780704;7398.3341499265325;7496.062992125984;7504.437167212372;7544.396448284234;7614.695412183451;6150.60021098645;6931.480138989697;6965;7025.121859767529;7299.9270007301375;7477.626118693935;7524.699012039676;7557.05536807899;7564.167941526318;7575.772726818204;6864.24493305746;6894.827629309308;6898.344657257552;6899.689513971984;6901.482388820959;7041.119860017498;7090.858182836211;7093.680784364613;7094.148702155568;7095.8935615964765 01:46:19 INFO - 2016-01-26 01:46:19,857 DEBUG : BROWSER_OUTPUT: |4;prototype.html;349.5682831702848;352.68787123395794;356.59882632038955;359.9496070550123;361.4253337193861;6015.21802165719;6080.2399700037495;6114.602550834193;6142.570020098589;6150.231221097357;5899.380565040673;5993.520518358532;6060.515158787298;6064.211652485182;6066.454019138277;4747.240441529356;4748.335233067373;4749.76251187441;4751.453582837966;4761.047790441909;4542.341360502742;4641.373414589021;4667.626589872819;4732.810687572493;4750.382450281459;4673.135469938073;4686.437627484706;4694.201985662446;4697.953020469786;4707.882302942419;4692.671512994092;4693.084848454553;4695.060987802453;4697.78859951303;4706.294055891643;4157.251694694954;4158.126793373395;4162.708610397273;4162.812673429703;4168.979155104235;5678.716064196774;5777.046787280094;5778.162166485878;5785.971070144622;5787.276590426197;5461.290032295776;5475.342958844924;5476.726163691799;5480.342358916916;5480.369757477902;6201.596896201732;6415.101885736;6423.100765892778;6429.5177861660095;6430;4501.549845015472;4529.547045295477;4594.494605593382;4597.356370108188;4597.448306203277;6615.4707623390495;6632.966835165793;6633.86732265352;6637.1703537057865;6639.668016599199;4714.905701885943;4718.528147185254;4721;4721.740304283228;4724.622030237572;4700.55344742249;4779.976100119477;4787.880302992453;4789.4971028041555;4803.879903002383;5457.590680698963;5461.098918678374;5461.836144915659;5462;5465.371482279589;6480.125183100316;6480.902786458207;6483.481321494363;6494.447971922439;6494.837629059311;1676.245689439757;1699.192883380409;1701.0899168944554;1703.7870266216723;1704.5568152280248;1147.5696613769837;1162.9069674426025;1170.789257933563;1181.9468123934444;1186.8694443611196;6339.492840572743;6347.206599175103;6349.46029587481;6355.459785918156;6357.459615932605;6638.502112341594;6670.299618539983;6681.532292739462;6689.331066893272;6689.732410703615;6241.78153764616;6325.65208913505;6338.334474880164;6338.524610654219;6344.968275158594;3588.2644057968055;3621.7464777465852;3624.1664417184197;3626.9818650907105;3631.6368363164;6861.691223894937;6861.725530978705;6864.691088901011;6873.415759660485;6876.553024053421;6711.563748356341;6802.897956530557;6812.761553345609;6817.239018197638;6822.692978815965;6812.080369150201;6845.247022827485;6847.007183958298;6849.726010959605;6857.382835544825;6460.676966151767;6565.934340656532;6628.701708423229;6667.299933507106;6674.499412544175;6592.868142637216;6603.075569420381;6614.801555953329;6632.83417914556;6663.300353463011;6899.827504312432;6900.102986611709;6906;6906.551074180162;6906.723731050903;4544.7045942013665;4662.463816660992;4667.066586682745;4759.524047595212;4767.6424268179335;6698.497612678971;6702.698378572878;6712.060311556484;6712.160979877515;6721.1598550181225;6508.121403610452;6521.576097553644;6523.7716679915975;6525.477961762953;6525.543211975116;6382.968085159545;6460.095586617783;6477.838054048687;6563.212414510289;6603.372679595431;6447.4197322241225;6464.159659244268;6464.806055818333;6467.838304042437;6471.191101112361;6568.507361947969;6598.274189839018;6599.967000164968;6605.306442823435;6607.96696016536;6281.59169653971;6416.615003099829;6421.903671444838;6424.421802037839;6455.838604034937 01:46:19 INFO - 2016-01-26 01:46:19,858 DEBUG : BROWSER_OUTPUT: |5;yui.html;857.3184318466818;864.9178328058836;866.5623859950724;900.6667533012786;923.9538023098847;14470;14491.492797752067;14964.700705985873;14977.251137443138;15003.949723519345;13133.080684352099;13141.211527308344;13141.93429032856;13179;13191.6702082448;741.1291732214653;764.2319468933741;885.3536918049796;907.6505545365048;911.2755359489189;903.0969030969031;913.8994710581864;919.3105171121625;919.8114386550741;919.8482250428705;799.8080460689422;813.8413009463158;968.8692026576392;972.9562169702381;975.2685485885586;936.1434287626847;961.543266948201;966.709987003896;967.1199208720101;967.2987084363815;709.5742554467279;715.4526787007943;716.2443621978811;716.4232792601954;717.1430140981529;14159.575212743634;14353.138811671228;14363.138211707332;14456.349464274133;14463.13221206731;11910.880891191064;12629.87370126296;13017;13146.276954767483;13336.999725020565;10324.277300588961;10458.163346932228;10487.528061237263;10582.470876456146;10628.309159904658;3806.7525610835205;3841.9039524011846;3845.769253844778;3852.3451013327804;3854.633809788094;46407;46976;47422.28866567004;47482.28776568389;47493.28760068602;9653.662121825702;9720.465374404475;9822.607095716234;9863.556139973718;9921.652742154134;17879.28482860697;18091;18097.819021809875;18098.27606895736;18119.45641630753;7368;7592.202818703957;7613.276738709814;7757.635064630344;7759.456838021284;4417.138657961731;4470.552944705503;4496.437945256843;4528.750918699503;4650.395448591729;3117.1583672408324;3141.4659507883716;3143.8742450301734;3144.6698096699974;3145.968540314613;553.8227767114485;557.2978047659977;558.9580781441408;574.348114889595;587.3744462147799;640.8348709402233;685.396850771328;687.7420967137324;693.0920494152575;697.9895301570481;8080.191980801873;8772.605232764541;8912.55437228136;9008.056269174196;9082.22801061904;549.5246611680867;573.377884994777;599.9670018149044;651.6188030002406;733.1898252431093;4036.737612055207;4244.87265382039;4348.695591308578;4389.4732632083715;4516.277395616686;53895.19157212645;53986.46013539893;53996.46003539993;54135;54329.72835135799;49137.754311228215;52978;53087.203691944655;53100;53319;46477;47104.5289547107;47503.52496474991;47616.7619161902;48198.759006204746;9135.77160570991;9404.576794044147;9517.048295170427;9528.761780955532;9573;34713.479297811056;35082.47376289307;35312;35482.11294717653;35927.28145437024;41800;44289.557104428546;44463;44721.552784471736;44800;11070.612528561462;11554.48004839801;11927.582534611247;12012;12063.457144428698;11619.302841829518;11684.941575292069;12406.441710122886;12421.254724716546;12533.561325353568;11231.101511879193;11231.606893758679;11313.886861131283;11419.714507137056;11464.197506174487;11780.882191178322;11838;12031.398430078287;12038.337891416057;12335.876641233473;10507.94746026265;11492.827607585725;11578.363190024293;11637.592684256011;11695.005924496512;8868.512231827312;9069.319801014819;9888.604455821687;9981.351212171186;10181.89818101839;9249.630014799333;9707.951460242653;9723.9027609723;9734;9737.221022318055 01:46:19 INFO - 2016-01-26 01:46:19,858 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:46:19 INFO - 2016-01-26 01:46:19,858 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:46:19 INFO - 2016-01-26 01:46:19,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,799 01:46:19 INFO - 2016-01-26 01:46:19,858 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801579848__endTimestamp 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5629.57 Median:5837.27 stddev:632.11 (10.8%) stddev-sans-first:608.08 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: Values: 3343.4 3396.1 3417.1 3420.4 3440.8 5594.6 5607.0 5614.4 5618.7 5645.6 5626.2 5662.3 5679.4 5679.6 5692.7 4870.6 5157.5 5183.3 5245.5 5275.9 5027.2 5047.5 5108.6 5145.5 5153.8 5141.0 5175.1 5198.1 5207.9 5225.4 5035.9 5102.9 5119.9 5178.1 5210.9 4939.5 5059.3 5064.4 5074.2 5076.5 5426.1 5430.4 5447.8 5449.7 5464.7 5872.2 6027.8 6094.0 6096.5 6097.3 5990.7 6065.5 6094.5 6096.3 6109.6 5646.3 5649.4 5724.4 5729.7 5729.9 6080.8 6183.0 6192.4 6214.0 6219.5 5856.3 5927.3 5929.8 5931.2 5969.1 6103.2 6103.8 6104.1 6108.3 6110.5 5837.3 5969.3 5971.7 6057.8 6074.7 6057.5 6084.5 6088.0 6088.1 6109.2 4645.4 4649.8 4651.8 4654.7 4678.6 4061.5 4097.5 4139.4 4146.3 4193.0 5754.1 5795.2 5797.7 5799.0 5800.5 6068.3 6106.9 6119.1 6124.7 6135.8 5625.0 5648.5 5735.3 5747.3 5762.3 5337.4 5344.4 5345.0 5347.7 5352.2 6274.9 6286.4 6294.2 6297.1 6297.3 5837.3 5968.6 6072.6 6164.8 6185.2 6290.7 6344.5 6346.9 6349.0 6356.3 5798.2 6103.9 6103.9 6105.6 6111.2 5934.6 6003.3 6029.5 6070.5 6103.7 5915.7 5964.6 5968.2 5973.9 5994.8 5798.9 5912.5 5946.5 5949.2 5967.2 5785.7 5830.7 5859.8 5862.8 5899.7 5973.2 5999.4 6001.6 6020.6 6024.5 5618.1 5670.0 5750.8 5856.0 5863.1 01:46:19 INFO - 2016-01-26 01:46:19,859 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,860 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49781.33 Median:18730.71 stddev:85656.24 (457.3%) stddev-sans-first:85816.87 01:46:19 INFO - 2016-01-26 01:46:19,860 DEBUG : BROWSER_OUTPUT: Values: 582.0 639.6 661.5 662.5 664.8 32680.7 34071.8 34082.3 34083.1 34091.1 42257.6 42942.6 43015.0 43031.0 43128.6 9121.0 9308.5 9316.6 9321.3 9322.3 8272.8 8463.0 8478.9 9061.4 9195.1 8205.3 10978.4 11187.6 11203.0 11223.8 10763.5 10847.5 10866.9 10871.9 10878.3 10621.7 10696.8 10746.4 10764.3 10768.1 42680.0 43066.4 43142.0 43216.4 43274.6 3372.2 3389.6 3433.0 3540.8 3621.4 32044.7 32353.9 32388.5 32553.3 32625.0 4042.8 4200.5 4279.3 4299.5 4339.5 312584.0 313212.0 313417.0 313689.0 314317.0 56273.7 57206.7 59196.0 59244.0 59467.1 72610.3 73381.0 73395.0 73789.3 73802.3 17541.0 17683.6 17694.1 17846.0 17884.7 13608.1 13678.2 13680.3 13692.3 13697.0 20109.2 20389.0 20452.8 20477.0 20600.8 8129.8 8314.9 8319.5 8334.6 8398.3 991.2 1023.7 1083.3 1135.6 1135.7 28706.1 29303.7 29835.6 30176.8 30256.8 1081.2 1132.5 1137.4 1137.7 1214.8 13245.5 13436.5 13664.9 13959.2 14859.3 350972.0 351197.0 354764.0 356115.0 358178.0 55134.7 55257.4 55308.4 55850.0 55914.0 1305.9 1321.4 1335.3 1351.1 1446.2 26465.2 26538.0 26727.9 26891.6 27008.9 41614.8 41661.0 41788.2 41816.0 45807.8 201381.0 328271.0 333949.0 333974.0 334011.0 30521.5 30883.0 31045.0 31099.1 31148.0 41081.8 41623.1 41796.8 42272.8 42734.6 35800.6 36000.6 36053.3 36120.6 39632.6 37458.8 38326.6 38750.8 39089.0 39176.6 35224.5 35615.6 35654.6 38533.2 39258.6 29945.9 31172.0 33366.0 33449.3 33457.5 26169.0 26532.7 26544.5 26858.5 27310.3 01:46:19 INFO - 2016-01-26 01:46:19,860 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,860 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30628.80 Median:11668.05 stddev:95935.47 (822.2%) stddev-sans-first:96177.73 01:46:19 INFO - 2016-01-26 01:46:19,861 DEBUG : BROWSER_OUTPUT: Values: 392.1 394.8 397.6 398.0 399.5 14299.6 16635.7 17129.9 18457.8 18502.9 11538.4 11811.7 11813.5 18664.2 19116.4 5067.5 5182.2 5185.5 5186.9 5189.9 3984.5 4087.8 4088.4 5066.9 5478.5 5576.0 5576.6 5606.5 5616.9 5625.5 5460.4 5549.3 5549.9 5556.6 5557.8 5340.5 5350.8 5354.9 5361.4 5365.2 18085.4 19494.0 20279.2 21111.3 21144.6 2191.5 2253.1 2255.3 2262.7 2284.4 9183.3 9537.0 9637.7 9653.3 9889.3 1854.9 1901.6 1910.8 1956.0 2076.2 54727.7 56093.6 63835.0 63971.7 65174.7 11211.2 11230.8 11235.4 11334.3 11336.9 15039.8 15110.5 15138.6 15144.6 15172.6 8537.0 8576.5 8589.7 8592.6 8601.7 8324.3 8341.2 8354.3 8402.9 8406.5 4648.5 4658.6 4876.9 4901.3 4913.0 1764.0 1834.4 1884.1 1911.7 1914.4 930.5 961.1 970.1 1046.0 1064.2 14469.2 15856.8 16039.4 16191.7 16618.9 997.1 997.3 1006.2 1023.5 1061.8 9664.9 9881.5 10033.9 10056.1 10071.6 574364.0 580554.0 581492.0 598066.0 603223.0 78014.0 79221.6 80365.7 83617.0 85595.1 1121.8 1128.8 1135.2 1145.8 1156.8 15670.5 15712.4 15790.0 15861.4 16179.4 35471.0 36215.6 36474.8 37114.6 37205.0 47509.3 48474.8 49681.0 51947.7 52202.0 10039.0 10106.7 10172.3 10719.7 10749.9 17918.6 18231.8 18252.5 18260.3 18853.4 15196.6 15198.4 15401.2 15686.4 15838.0 14904.1 15136.6 15182.9 15203.8 15327.8 15318.8 15468.2 15898.8 15996.6 16009.7 9493.8 9988.3 10077.4 10516.8 10667.4 13810.6 13997.5 14737.4 15226.5 15272.6 01:46:19 INFO - 2016-01-26 01:46:19,861 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,861 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5707.19 Median:6507.42 stddev:2975.20 (45.7%) stddev-sans-first:2966.79 01:46:19 INFO - 2016-01-26 01:46:19,862 DEBUG : BROWSER_OUTPUT: Values: 1506.3 1516.1 1637.2 1777.9 1810.3 7763.9 8367.6 8369.7 8372.8 8381.0 6865.9 7218.0 7821.1 7978.6 7978.7 2309.7 2331.3 2355.0 2356.5 2357.9 1967.0 2362.2 2393.6 2407.2 2413.0 1994.6 2301.5 2336.7 2338.6 2339.0 2260.3 2285.7 2297.3 2298.9 2328.9 2298.7 2299.5 2323.8 2324.9 2325.8 7990.1 8037.3 8064.9 8069.0 8077.8 4793.1 4870.1 4881.0 4889.6 4901.9 3116.8 3132.2 3132.3 3174.5 3179.2 1006.3 1011.3 1036.8 1045.3 1049.2 11174.7 11196.8 11199.3 11201.4 11219.8 4266.4 4273.6 4285.0 4300.4 4309.4 9584.4 9601.0 9607.0 9609.4 9616.9 4838.3 4874.3 4875.7 4876.2 4878.7 4439.8 4458.5 4458.9 4463.4 4464.2 3796.0 3834.1 3842.2 3863.9 3867.6 1146.4 1253.9 1256.9 1258.0 1262.9 1042.5 1112.1 1173.6 1325.2 1423.4 7673.8 7709.5 7730.4 7737.3 7781.4 1165.1 1166.0 1179.6 1183.1 1190.3 6066.7 6123.5 6126.7 6129.4 6133.9 9389.4 9769.0 9772.0 9903.6 9976.1 9610.9 9670.8 9786.3 9847.4 9851.2 7380.0 7657.8 7728.7 7729.3 7732.3 7504.4 7591.5 7608.0 7622.2 7622.4 8750.8 8773.0 8803.3 8863.4 8950.6 8865.6 8921.8 9090.7 9106.1 9174.3 7220.8 7230.9 7248.2 7259.9 7263.6 7803.6 7868.9 7884.4 7899.9 7997.3 7398.3 7496.1 7504.4 7544.4 7614.7 6150.6 6931.5 6965.0 7025.1 7299.9 7477.6 7524.7 7557.1 7564.2 7575.8 6864.2 6894.8 6898.3 6899.7 6901.5 7041.1 7090.9 7093.7 7094.1 7095.9 01:46:19 INFO - 2016-01-26 01:46:19,862 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,862 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5444.94 Median:6221.69 stddev:1610.90 (25.9%) stddev-sans-first:1569.36 01:46:19 INFO - 2016-01-26 01:46:19,863 DEBUG : BROWSER_OUTPUT: Values: 349.6 352.7 356.6 359.9 361.4 6015.2 6080.2 6114.6 6142.6 6150.2 5899.4 5993.5 6060.5 6064.2 6066.5 4747.2 4748.3 4749.8 4751.5 4761.0 4542.3 4641.4 4667.6 4732.8 4750.4 4673.1 4686.4 4694.2 4698.0 4707.9 4692.7 4693.1 4695.1 4697.8 4706.3 4157.3 4158.1 4162.7 4162.8 4169.0 5678.7 5777.0 5778.2 5786.0 5787.3 5461.3 5475.3 5476.7 5480.3 5480.4 6201.6 6415.1 6423.1 6429.5 6430.0 4501.5 4529.5 4594.5 4597.4 4597.4 6615.5 6633.0 6633.9 6637.2 6639.7 4714.9 4718.5 4721.0 4721.7 4724.6 4700.6 4780.0 4787.9 4789.5 4803.9 5457.6 5461.1 5461.8 5462.0 5465.4 6480.1 6480.9 6483.5 6494.4 6494.8 1676.2 1699.2 1701.1 1703.8 1704.6 1147.6 1162.9 1170.8 1181.9 1186.9 6339.5 6347.2 6349.5 6355.5 6357.5 6638.5 6670.3 6681.5 6689.3 6689.7 6241.8 6325.7 6338.3 6338.5 6345.0 3588.3 3621.7 3624.2 3627.0 3631.6 6861.7 6861.7 6864.7 6873.4 6876.6 6711.6 6802.9 6812.8 6817.2 6822.7 6812.1 6845.2 6847.0 6849.7 6857.4 6460.7 6565.9 6628.7 6667.3 6674.5 6592.9 6603.1 6614.8 6632.8 6663.3 6899.8 6900.1 6906.0 6906.6 6906.7 4544.7 4662.5 4667.1 4759.5 4767.6 6698.5 6702.7 6712.1 6712.2 6721.2 6508.1 6521.6 6523.8 6525.5 6525.5 6383.0 6460.1 6477.8 6563.2 6603.4 6447.4 6464.2 6464.8 6467.8 6471.2 6568.5 6598.3 6600.0 6605.3 6608.0 6281.6 6416.6 6421.9 6424.4 6455.8 01:46:19 INFO - 2016-01-26 01:46:19,864 DEBUG : BROWSER_OUTPUT: 01:46:19 INFO - 2016-01-26 01:46:19,864 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13894.98 Median:47452.29 stddev:15703.04 (33.1%) stddev-sans-first:15716.57 01:46:19 INFO - 2016-01-26 01:46:19,865 DEBUG : BROWSER_OUTPUT: Values: 857.3 864.9 866.6 900.7 924.0 14470.0 14491.5 14964.7 14977.3 15003.9 13133.1 13141.2 13141.9 13179.0 13191.7 741.1 764.2 885.4 907.7 911.3 903.1 913.9 919.3 919.8 919.8 799.8 813.8 968.9 973.0 975.3 936.1 961.5 966.7 967.1 967.3 709.6 715.5 716.2 716.4 717.1 14159.6 14353.1 14363.1 14456.3 14463.1 11910.9 12629.9 13017.0 13146.3 13337.0 10324.3 10458.2 10487.5 10582.5 10628.3 3806.8 3841.9 3845.8 3852.3 3854.6 46407.0 46976.0 47422.3 47482.3 47493.3 9653.7 9720.5 9822.6 9863.6 9921.7 17879.3 18091.0 18097.8 18098.3 18119.5 7368.0 7592.2 7613.3 7757.6 7759.5 4417.1 4470.6 4496.4 4528.8 4650.4 3117.2 3141.5 3143.9 3144.7 3146.0 553.8 557.3 559.0 574.3 587.4 640.8 685.4 687.7 693.1 698.0 8080.2 8772.6 8912.6 9008.1 9082.2 549.5 573.4 600.0 651.6 733.2 4036.7 4244.9 4348.7 4389.5 4516.3 53895.2 53986.5 53996.5 54135.0 54329.7 49137.8 52978.0 53087.2 53100.0 53319.0 46477.0 47104.5 47503.5 47616.8 48198.8 9135.8 9404.6 9517.0 9528.8 9573.0 34713.5 35082.5 35312.0 35482.1 35927.3 41800.0 44289.6 44463.0 44721.6 44800.0 11070.6 11554.5 11927.6 12012.0 12063.5 11619.3 11684.9 12406.4 12421.3 12533.6 11231.1 11231.6 11313.9 11419.7 11464.2 11780.9 11838.0 12031.4 12038.3 12335.9 10507.9 11492.8 11578.4 11637.6 11695.0 8868.5 9069.3 9888.6 9981.4 10181.9 9249.6 9708.0 9723.9 9734.0 9737.2 01:46:19 INFO - 2016-01-26 01:46:19,865 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:46:19 INFO - 2016-01-26 01:46:19,866 DEBUG : BROWSER_OUTPUT: 01:46:20 INFO - 2016-01-26 01:46:20,347 INFO : Browser exited with error code: 0 01:46:20 INFO - 2016-01-26 01:46:20,365 INFO : Completed test dromaeo_css (00:18:30) 01:46:20 INFO - 2016-01-26 01:46:20,365 INFO : Starting test kraken 01:46:20 INFO - 2016-01-26 01:46:20,365 DEBUG : operating with platform_type : linux_ 01:46:20 INFO - 2016-01-26 01:46:20,365 INFO : Initialising browser for kraken test... 01:46:20 INFO - 2016-01-26 01:46:20,371 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCAHI1/profile http://localhost:37175/getInfo.html 01:46:24 INFO - 2016-01-26 01:46:24,076 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:46:24 INFO - 2016-01-26 01:46:24,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:46:24 INFO - 2016-01-26 01:46:24,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:46:24 INFO - 2016-01-26 01:46:24,077 DEBUG : BROWSER_OUTPUT: __metrics 01:46:24 INFO - 2016-01-26 01:46:24,294 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] 01:46:25 INFO - 2016-01-26 01:46:25,386 INFO : Browser initialized. 01:46:25 INFO - 2016-01-26 01:46:25,387 INFO : Running cycle 1/1 for kraken test... 01:46:25 INFO - 2016-01-26 01:46:25,387 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCAHI1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:46:37 INFO - 2016-01-26 01:46:37,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 134725632 01:46:37 INFO - 2016-01-26 01:46:37,129 DEBUG : BROWSER_OUTPUT: 01:46:39 INFO - 2016-01-26 01:46:39,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-beat-detection) 01:46:40 INFO - 2016-01-26 01:46:40,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 166903808 01:46:40 INFO - 2016-01-26 01:46:40,152 DEBUG : BROWSER_OUTPUT: 01:46:42 INFO - 2016-01-26 01:46:42,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-dft) 01:46:43 INFO - 2016-01-26 01:46:43,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 164921344 01:46:43 INFO - 2016-01-26 01:46:43,262 DEBUG : BROWSER_OUTPUT: 01:46:46 INFO - 2016-01-26 01:46:46,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-fft) 01:46:46 INFO - 2016-01-26 01:46:46,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 163176448 01:46:46 INFO - 2016-01-26 01:46:46,607 DEBUG : BROWSER_OUTPUT: 01:46:48 INFO - 2016-01-26 01:46:48,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-oscillator) 01:46:49 INFO - 2016-01-26 01:46:49,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 162398208 01:46:49 INFO - 2016-01-26 01:46:49,126 DEBUG : BROWSER_OUTPUT: 01:46:51 INFO - 2016-01-26 01:46:51,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:46:51 INFO - 2016-01-26 01:46:51,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 159936512 01:46:51 INFO - 2016-01-26 01:46:51,869 DEBUG : BROWSER_OUTPUT: 01:46:54 INFO - 2016-01-26 01:46:54,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-darkroom) 01:46:55 INFO - 2016-01-26 01:46:55,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 161714176 01:46:55 INFO - 2016-01-26 01:46:55,288 DEBUG : BROWSER_OUTPUT: 01:46:58 INFO - 2016-01-26 01:46:58,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-desaturate) 01:46:59 INFO - 2016-01-26 01:46:59,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 162000896 01:46:59 INFO - 2016-01-26 01:46:59,209 DEBUG : BROWSER_OUTPUT: 01:47:01 INFO - 2016-01-26 01:47:01,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37175/tests/kraken/driver.html?testName=json-parse-financial) 01:47:02 INFO - 2016-01-26 01:47:02,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 160571392 01:47:02 INFO - 2016-01-26 01:47:02,468 DEBUG : BROWSER_OUTPUT: 01:47:03 INFO - 2016-01-26 01:47:03,988 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:47:04 INFO - 2016-01-26 01:47:04,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 169730048 01:47:04 INFO - 2016-01-26 01:47:04,541 DEBUG : BROWSER_OUTPUT: 01:47:06 INFO - 2016-01-26 01:47:06,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:47:06 INFO - 2016-01-26 01:47:06,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 166154240 01:47:06 INFO - 2016-01-26 01:47:06,869 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2016-01-26 01:47:08,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:47:09 INFO - 2016-01-26 01:47:09,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 170434560 01:47:09 INFO - 2016-01-26 01:47:09,423 DEBUG : BROWSER_OUTPUT: 01:47:11 INFO - 2016-01-26 01:47:11,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:47:12 INFO - 2016-01-26 01:47:12,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 177446912 01:47:12 INFO - 2016-01-26 01:47:12,356 DEBUG : BROWSER_OUTPUT: 01:47:14 INFO - 2016-01-26 01:47:14,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:47:15 INFO - 2016-01-26 01:47:15,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 175476736 01:47:15 INFO - 2016-01-26 01:47:15,400 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37175/tests/kraken/driver.html?testName=ai-astar) 01:47:17 INFO - 2016-01-26 01:47:17,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 233156608 01:47:17 INFO - 2016-01-26 01:47:17,283 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;109;108;110;99;108;109;108 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;126;144;159;124;149;145;121;157;122 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;160;160;160;161;162;159 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;71;153;70;71;71;70;152;70 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;133;92;92;92;145;91;92;129 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;109;108;109;109 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;148;146;145;145;146;146;144;145 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;97;96;96 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;56;56;58;55;58;56;53;54 01:47:17 INFO - 2016-01-26 01:47:17,287 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;63;65;63;64;64;64 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;78;81;79;80;80;80;80;80;80 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;121;117;123;118;110;116;116;126;114 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;135;147;147;155;137;143;146;143;133 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;64;64;65;63;62;66;64;65;64 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801637284__endTimestamp 01:47:17 INFO - 2016-01-26 01:47:17,288 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:47:17 INFO - 2016-01-26 01:47:17,289 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:47:17 INFO - 2016-01-26 01:47:17,289 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:3.41 (3.1%) stddev-sans-first:3.56 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 109.0 108.0 110.0 99.0 108.0 109.0 108.0 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.00 stddev:14.86 (10.1%) stddev-sans-first:15.37 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: Values: 149.0 126.0 144.0 159.0 124.0 149.0 145.0 121.0 157.0 122.0 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 160.0 160.0 160.0 161.0 162.0 159.0 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.10 Median:71.00 stddev:34.48 (48.6%) stddev-sans-first:36.07 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 153.0 70.0 71.0 71.0 70.0 152.0 70.0 01:47:17 INFO - 2016-01-26 01:47:17,290 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.90 Median:92.00 stddev:21.59 (23.5%) stddev-sans-first:22.39 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 133.0 92.0 92.0 92.0 145.0 91.0 92.0 129.0 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 108.0 109.0 109.0 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 148.0 146.0 145.0 145.0 146.0 146.0 144.0 145.0 01:47:17 INFO - 2016-01-26 01:47:17,291 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 97.0 96.0 96.0 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.64 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 56.0 56.0 58.0 55.0 58.0 56.0 53.0 54.0 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 63.0 65.0 63.0 64.0 64.0 64.0 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: Values: 79.0 78.0 81.0 79.0 80.0 80.0 80.0 80.0 80.0 80.0 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.50 Median:117.50 stddev:4.72 (4.0%) stddev-sans-first:4.83 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: Values: 114.0 121.0 117.0 123.0 118.0 110.0 116.0 116.0 126.0 114.0 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,292 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.50 stddev:6.80 (4.7%) stddev-sans-first:6.94 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: Values: 137.0 135.0 147.0 147.0 155.0 137.0 143.0 146.0 143.0 133.0 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.43 (2.2%) stddev-sans-first:1.17 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: Values: 67.0 64.0 64.0 65.0 63.0 62.0 66.0 64.0 65.0 64.0 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:47:17 INFO - 2016-01-26 01:47:17,293 DEBUG : BROWSER_OUTPUT: 01:47:17 INFO - 2016-01-26 01:47:17,946 INFO : Browser exited with error code: 0 01:47:17 INFO - 2016-01-26 01:47:17,996 INFO : Completed test kraken (00:00:57) 01:47:17 INFO - 2016-01-26 01:47:17,996 INFO : Starting test v8_7 01:47:17 INFO - 2016-01-26 01:47:17,996 DEBUG : operating with platform_type : linux_ 01:47:17 INFO - 2016-01-26 01:47:17,996 INFO : Initialising browser for v8_7 test... 01:47:18 INFO - 2016-01-26 01:47:18,002 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb4I3gF/profile http://localhost:37175/getInfo.html 01:47:21 INFO - 2016-01-26 01:47:21,944 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:47:21 INFO - 2016-01-26 01:47:21,944 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:47:21 INFO - 2016-01-26 01:47:21,944 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:47:21 INFO - 2016-01-26 01:47:21,944 DEBUG : BROWSER_OUTPUT: __metrics 01:47:22 INFO - 2016-01-26 01:47:22,093 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] 01:47:22 INFO - 2016-01-26 01:47:22,773 INFO : Browser initialized. 01:47:22 INFO - 2016-01-26 01:47:22,773 INFO : Running cycle 1/1 for v8_7 test... 01:47:22 INFO - 2016-01-26 01:47:22,773 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpb4I3gF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:47:34 INFO - 2016-01-26 01:47:34,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 135204864 01:47:34 INFO - 2016-01-26 01:47:34,597 DEBUG : BROWSER_OUTPUT: 01:47:55 INFO - 2016-01-26 01:47:55,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37175/tests/v8_7/run.html (next: http://localhost:37175/tests/v8_7/run.html) 01:47:56 INFO - 2016-01-26 01:47:56,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 423219200 01:47:56 INFO - 2016-01-26 01:47:56,183 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,183 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:47:56 INFO - 2016-01-26 01:47:56,183 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |0;Richards;168.12373907195695 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.72224074691565 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |4;RayTrace;941.6195856873823 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |5;Earley;535.9056806002144 01:47:56 INFO - 2016-01-26 01:47:56,184 DEBUG : BROWSER_OUTPUT: |6;Boyer;10600 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: |7;RegExp;24560.975609756097 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: |8;Splay;524.9343832020998 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: __startTimestamp1453801676177__endTimestamp 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:47:56 INFO - 2016-01-26 01:47:56,185 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.12 Median:168.12 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: Values: 168.1 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.72 Median:166.72 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: Values: 166.7 01:47:56 INFO - 2016-01-26 01:47:56,186 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,187 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,187 DEBUG : BROWSER_OUTPUT: Values: 279.0 01:47:56 INFO - 2016-01-26 01:47:56,187 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,187 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,187 DEBUG : BROWSER_OUTPUT: Values: 5117.3 01:47:56 INFO - 2016-01-26 01:47:56,188 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,188 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,188 DEBUG : BROWSER_OUTPUT: Values: 941.6 01:47:56 INFO - 2016-01-26 01:47:56,188 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,188 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:535.91 Median:535.91 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,189 DEBUG : BROWSER_OUTPUT: Values: 535.9 01:47:56 INFO - 2016-01-26 01:47:56,189 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,189 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10600.00 Median:10600.00 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,189 DEBUG : BROWSER_OUTPUT: Values: 10600.0 01:47:56 INFO - 2016-01-26 01:47:56,189 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24560.98 Median:24560.98 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: Values: 24561.0 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.93 Median:524.93 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: Values: 524.9 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: Values: 4835.7 01:47:56 INFO - 2016-01-26 01:47:56,190 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:47:56 INFO - 2016-01-26 01:47:56,191 DEBUG : BROWSER_OUTPUT: 01:47:56 INFO - 2016-01-26 01:47:56,850 INFO : Browser exited with error code: 0 01:47:56 INFO - 2016-01-26 01:47:56,865 INFO : Completed test v8_7 (00:00:38) 01:47:57 INFO - 2016-01-26 01:47:57,224 INFO : Completed test suite (00:20:07) 01:47:57 INFO - 2016-01-26 01:47:57,225 DEBUG : Working with test: dromaeo_css 01:47:57 INFO - 2016-01-26 01:47:57,225 DEBUG : Generating results file: dromaeo_css 01:47:57 INFO - 2016-01-26 01:47:57,226 DEBUG : Working with test: kraken 01:47:57 INFO - 2016-01-26 01:47:57,226 DEBUG : Generating results file: kraken 01:47:57 INFO - 2016-01-26 01:47:57,226 INFO : javascript benchmark 01:47:57 INFO - 2016-01-26 01:47:57,226 DEBUG : Working with test: v8_7 01:47:57 INFO - 2016-01-26 01:47:57,226 DEBUG : Generating results file: v8_7 01:47:57 INFO - 2016-01-26 01:47:57,227 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:57 INFO - 2016-01-26 01:47:57,272 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 01:47:57 INFO - 2016-01-26 01:47:57,273 DEBUG : process_Request line: dromaeo_css 7298.48 graph.html#tests=[[72,53,35]] 01:47:57 INFO - 2016-01-26 01:47:57,273 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:57 INFO - 2016-01-26 01:47:57,299 DEBUG : process_Request line: kraken 1473.30 graph.html#tests=[[232,53,35]] 01:47:57 INFO - 2016-01-26 01:47:57,299 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:47:57 INFO - 2016-01-26 01:47:57,324 DEBUG : process_Request line: v8_7 23273.91 graph.html#tests=[[230,53,35]] 01:47:57 INFO - 2016-01-26 01:47:57,325 INFO : javascript benchmark 01:47:57 INFO - 2016-01-26 01:47:57,329 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3343.4149023920813, 3396.0660818274987, 3417.0773891049416, 3420.3843308204546, 3440.845161967711, 5594.608377413582, 5606.971965140168, 5614.382417934024, 5618.662880227184, 5645.60480766346, 5626.184203290521, 5662.320521537421, 5679.375268720448, 5679.5740319476, 5692.686902220376, 4870.586000189988, 5157.53582177603, 5183.326167598207, 5245.527902488775, 5275.894482110375, 5027.195648696209, 5047.545720885119, 5108.64239503235, 5145.459726728677, 5153.768080436371, 5140.997505486432, 5175.146100893367, 5198.142306519419, 5207.921881171786, 5225.399079105894, 5035.899282014376, 5102.9489705103215, 5119.872003199913, 5178.119719647669, 5210.869728256786, 4939.506049395068, 5059.3422855028975, 5064.442911279756, 5074.162763144077, 5076.466970968032, 5426.077566813612, 5430.3755068167275, 5447.782088716446, 5449.6730196187955, 5464.666214436801, 5872.236609240814, 6027.758889644453, 6094.024956007018, 6096.4903529599715, 6097.3292937776805, 5990.730417131196, 6065.5450841187085, 6094.5329332676565, 6096.268447786294, 6109.5723299369065, 5646.265985421869, 5649.359018847718, 5724.370319264877, 5729.713514324267, 5729.885402291972, 6080.75012245472, 6182.969085154546, 6192.442680158717, 6213.96893015532, 6219.502439804895, 5856.297244330707, 5927.318358388754, 5929.762809487658, 5931.169636250928, 5969.074793407029, 6103.23709536308, 6103.786367477206, 6104.053871649901, 6108.3280839107665, 6110.450059494667, 5837.270341207349, 5969.283685957626, 5971.671558064349, 6057.757689692451, 6074.696265186723, 6057.545684073712, 6084.543659225487, 6087.969560152171, 6088.086786981989, 6109.205803245639, 4645.419322584677, 4649.790759415834, 4651.813927442864, 4654.720716757005, 4678.578927896506, 4061.5126184857413, 4097.467329247179, 4139.399787030864, 4146.274401979642, 4193.0, 5754.079347304411, 5795.1886735857015, 5797.652140871562, 5798.971005145032, 5800.477956983892, 6068.271807383142, 6106.938930610637, 6119.112728654321, 6124.724387402578, 6135.754569817246, 5624.971875140598, 5648.491635752802, 5735.340435849931, 5747.3103227612955, 5762.279715035621, 5337.386200586904, 5344.412114667383, 5345.037893179265, 5347.732613369316, 5352.19717042439, 6274.937250627435, 6286.4342209201395, 6294.213223347173, 6297.086922396227, 6297.338779428185, 5837.270341207349, 5968.552358573038, 6072.574919755575, 6164.7842325518395, 6185.226846644169, 6290.685465726604, 6344.460720838596, 6346.873062538631, 6349.0, 6356.3325850785, 5798.188253644409, 6103.908441373294, 6103.908441373472, 6105.633661980118, 6111.205543279345, 5934.554908381975, 6003.339632640494, 6029.51763858899, 6070.453659170696, 6103.664298463627, 5915.668974480879, 5964.5526585505395, 5968.224130863134, 5973.940260597338, 5994.760209591567, 5798.942010580009, 5912.467877890838, 5946.524278057832, 5949.2266005419015, 5967.194428752063, 5785.681787501728, 5830.708464576839, 5859.794907178229, 5862.7654893805475, 5899.705014749331, 5973.223480947449, 5999.370066142992, 6001.639901605918, 6020.608660437058, 6024.487918526975, 5618.073017951992, 5669.971650141723, 5750.7987220447085, 5856.0, 5863.149843272787], "unit": "ms", "name": "dojo.html", "value": 5588.27127104052}, {"lowerIsBetter": false, "replicates": [581.9505342045926, 639.6194264412675, 661.5203977116589, 662.4600950225569, 664.8204984654144, 32680.67319326806, 34071.82964085176, 34082.318353632945, 34083.14792130192, 34091.14772130698, 42257.57742422575, 42942.570574294245, 43015.0, 43031.0, 43128.568714312845, 9120.954395228015, 9308.534573271343, 9316.58075386606, 9321.300902432346, 9322.347435679505, 8272.793180170484, 8463.0, 8478.915210847905, 9061.365704400694, 9195.126462986005, 8205.343572514214, 10978.396188209645, 11187.608433704821, 11203.04774094203, 11223.775524489505, 10763.515641796137, 10847.511861966192, 10866.891331086666, 10871.945640271828, 10878.292910960841, 10621.681349559525, 10696.78606427875, 10746.408947507884, 10764.300320479144, 10768.084712799422, 42680.0, 43066.35400468996, 43142.0, 43216.351754723706, 43274.56725432768, 3372.15696075981, 3389.5932488101585, 3433.0, 3540.7698499597445, 3621.4386770050683, 32044.6795532044, 32353.867614633375, 32388.514172287436, 32553.348933021443, 32625.0, 4042.8382864685377, 4200.494877324095, 4279.315309550457, 4299.548547402509, 4339.479262488521, 312584.0, 313212.0, 313417.0, 313689.0, 314317.0, 56273.718631406584, 57206.7139664299, 59196.0, 59244.0, 59467.10799338014, 72610.2738972614, 73381.0, 73395.0, 73789.26210737931, 73802.26197737954, 17541.0, 17683.646327073388, 17694.11529423524, 17846.0, 17884.731729024075, 13608.115472494255, 13678.247696376795, 13680.31598420075, 13692.31538423075, 13697.041207115406, 20109.19563217455, 20389.0, 20452.795472045385, 20477.0, 20600.793992060186, 8129.796755081052, 8314.916850831536, 8319.459235149696, 8334.62494187763, 8398.286145677564, 991.2367477042637, 1023.744063984004, 1083.268793564341, 1135.6195674448986, 1135.6706555098929, 28706.13881583556, 29303.706962930522, 29835.552466713016, 30176.84911575472, 30256.84871575628, 1081.210716177195, 1132.4847194526471, 1137.4312843578211, 1137.6757624077263, 1214.7509760499076, 13245.470181192837, 13436.462541498426, 13664.93167534156, 13959.232242226775, 14859.2570371481, 350972.0, 351197.0, 354764.0, 356115.0, 358178.0, 55134.72432637811, 55257.447425526036, 55308.44691553033, 55850.0, 55914.0, 1305.8824705776526, 1321.3723481346476, 1335.252258735092, 1351.074513957942, 1446.2262689461297, 26465.206043818715, 26538.0, 26727.86636066807, 26891.596626050232, 27008.864955675097, 41614.791926040176, 41661.0, 41788.164236715704, 41816.0, 45807.77096114498, 201381.0, 328271.0, 333949.0, 333974.0, 334011.0, 30521.542176866922, 30883.0, 31045.0, 31099.067027989197, 31148.0, 41081.79459102685, 41623.13740583919, 41796.75055750316, 42272.788636056626, 42734.57265427306, 35800.64199357973, 36000.639993599725, 36053.27893442169, 36120.638793611724, 39632.60367396405, 37458.812705936296, 38326.61673383231, 38750.80624596972, 39089.0, 39176.608233918436, 35224.471632925015, 35615.643843561236, 35654.643453565135, 38533.22933541257, 39258.60741392549, 29945.850270748506, 31172.0, 33366.0, 33449.33101337911, 33457.49813752844, 26169.0, 26532.734672653027, 26544.469110618065, 26858.462830742887, 27310.317242069108], "unit": "ms", "name": "ext.html", "value": 19513.073451863176}, {"lowerIsBetter": false, "replicates": [392.05905826017556, 394.79076089672463, 397.5944536572696, 397.9960200397997, 399.45075521158407, 14299.571012869605, 16635.66728665429, 17129.914350428247, 18457.81542184578, 18502.907485462572, 11538.423078846066, 11811.70470738232, 11813.527458901655, 18664.16011279492, 19116.42650720477, 5067.518585734359, 5182.196759502283, 5185.455527169649, 5186.948130518703, 5189.870253243661, 3984.482017337742, 4087.7751723655188, 4088.4276201331836, 5066.923996140061, 5478.534324582415, 5576.0, 5576.5817563682685, 5606.523445507137, 5616.85957851055, 5625.46558076982, 5460.399356070829, 5549.306336707911, 5549.916751248735, 5556.583256255797, 5557.833265002077, 5340.54605358545, 5350.812721554766, 5354.9196762048605, 5361.383440904268, 5365.248865158881, 18085.36701215451, 19494.025298735007, 20279.188832446685, 21111.26110586122, 21144.5771084579, 2191.5288213034114, 2253.1325439705834, 2255.3459496745922, 2262.7284725833006, 2284.3717977556307, 9183.265338772882, 9536.952315238379, 9637.662681806174, 9653.324267301292, 9889.258305627034, 1854.935077272289, 1901.6291823094502, 1910.837578805803, 1955.9804401955942, 2076.1591555419927, 54727.72636136834, 56093.55070153079, 63835.0, 63971.680141599456, 65174.674126629536, 11211.215214935039, 11230.831537526943, 11235.382053986945, 11334.263272887236, 11336.886631133748, 15039.774403383957, 15110.54668359951, 15138.621534461727, 15144.621384465256, 15172.620684482976, 8536.957315213509, 8576.485410875368, 8589.65641374338, 8592.5703714814, 8601.741947741577, 8324.334053275723, 8341.24928756415, 8354.331653467709, 8402.915970840213, 8406.495610263404, 4648.5119062498625, 4658.579133364288, 4876.926846097312, 4901.289313049588, 4913.0, 1763.951864393801, 1834.367143335547, 1884.1427150646423, 1911.7132430135591, 1914.3778272061636, 930.4510338900081, 961.110972350573, 970.088117169858, 1046.0062940206833, 1064.1539975719322, 14469.204193769443, 15856.841431585768, 16039.358425663077, 16191.676166476604, 16618.916905415397, 997.0706682569107, 997.2620261006803, 1006.1548299428515, 1023.534291897185, 1061.77702682436, 9664.90335096654, 9881.505924703735, 10033.899661003297, 10056.145227655585, 10071.647492337734, 574364.0, 580554.0, 581492.0, 598066.0, 603223.0, 78014.0, 79221.60389198133, 80365.65739361654, 83617.0, 85595.14404855996, 1121.7884684540677, 1128.841962125303, 1135.1713249328036, 1145.7823013627385, 1156.7628636129741, 15670.529884103495, 15712.371505140123, 15790.0, 15861.444849430214, 16179.352825886832, 35471.0, 36215.637843621225, 36474.8176259117, 37114.62885371112, 37205.0, 47509.287360688926, 48474.75762621305, 49681.0, 51947.74026129845, 52202.0, 10039.0, 10106.747331316776, 10172.287939844437, 10719.678409647722, 10749.89250107489, 17918.641627167122, 18231.817681823544, 18252.543686407946, 18260.26958921628, 18853.434396968114, 15196.620084497976, 15198.392064317304, 15401.229938503255, 15686.372545098067, 15838.0, 14904.105753654816, 15136.621584460476, 15182.924085379502, 15203.77194342108, 15327.77008344898, 15318.770218446954, 15468.226588670297, 15898.841011589737, 15996.600084997968, 16009.679806403574, 9493.76265593338, 9988.300818942604, 10077.395356278646, 10516.842247366449, 10667.413292269, 13810.585682429542, 13997.46154845523, 14737.410503579737, 15226.46707365237, 15272.618184545476], "unit": "ms", "name": "jquery.html", "value": 9228.04762578382}, {"lowerIsBetter": false, "replicates": [1506.2619316534901, 1516.1282262698944, 1637.1568642149289, 1777.85777137829, 1810.2849374497073, 7763.922360776391, 8367.623456944437, 8369.665213391472, 8372.83254334913, 8381.036180839204, 6865.897011544818, 7218.0, 7821.100573434057, 7978.561179135145, 7978.720744773934, 2309.734380546238, 2331.3239160643393, 2355.046206286448, 2356.5404746074437, 2357.8938947747306, 1967.0263219706264, 2362.2086600988605, 2393.581123303415, 2407.1574948767966, 2412.95174096518, 1994.5512259741588, 2301.539692061586, 2336.7312759032757, 2338.6258198688215, 2339.0, 2260.2880092770724, 2285.73714022887, 2297.3452566018686, 2298.8735619541003, 2328.871912044837, 2298.7241531016216, 2299.494111295512, 2323.7560056194193, 2324.8837558122195, 2325.7906788388955, 7990.081140668839, 8037.276645101911, 8064.879026814602, 8069.0, 8077.838443231161, 4793.089313030513, 4870.0746858096845, 4880.951190488086, 4889.608831293488, 4901.852944411673, 3116.844157792101, 3132.201288671374, 3132.2795756975797, 3174.539691744684, 3179.2210908327606, 1006.2905651515664, 1011.281989787252, 1036.813373592753, 1045.2839804733783, 1049.21833234241, 11174.720631984266, 11196.776064478665, 11199.328040317607, 11201.383923884183, 11219.831702524469, 4266.4240327556, 4273.636740876998, 4284.978575107105, 4300.397944287803, 4309.439772829513, 9584.37701549397, 9601.0, 9607.039296070338, 9609.423434593948, 9616.855747163798, 4838.298446725275, 4874.268859671007, 4875.731834749123, 4876.195427754452, 4878.731669758197, 4439.778011099432, 4458.464984201852, 4458.866234012985, 4463.4420697412825, 4464.196444639931, 3796.0, 3834.079820842978, 3842.193139440693, 3863.9034024149623, 3867.57456679765, 1146.4038699876185, 1253.9373031348396, 1256.9308688022247, 1257.9748405031849, 1262.8800263974908, 1042.525650828871, 1112.076976109827, 1173.5951096871565, 1325.2379881568138, 1423.3737155651688, 7673.769786906401, 7709.498882572615, 7730.420218483636, 7737.3036426721865, 7781.377489800802, 1165.1086918507349, 1165.976680466386, 1179.598936361624, 1183.059467723145, 1190.2501424102759, 6066.696665166724, 6123.479504242189, 6126.663033533109, 6129.35641757609, 6133.907991380132, 9389.436633801994, 9768.951155244178, 9771.951140244395, 9903.60385584583, 9976.102150806462, 9610.90389096114, 9670.806583868283, 9786.314957953018, 9847.359921605073, 9851.162651174587, 7379.963100184465, 7657.770266892002, 7728.690852365842, 7729.343005844454, 7732.265434783687, 7504.362129219077, 7591.4685971983645, 7608.01095857535, 7622.199669034671, 7622.428317876071, 8750.82498350042, 8773.0, 8803.295736341206, 8863.423877447945, 8950.567909134506, 8865.601047952987, 8921.776955575902, 9090.727278181665, 9106.134917182857, 9174.266058715153, 7220.819479513054, 7230.855382892208, 7248.238934911969, 7259.891101633585, 7263.564186148848, 7803.609819508888, 7868.921310786819, 7884.369250459835, 7899.921000789918, 7997.320227780704, 7398.3341499265325, 7496.062992125984, 7504.437167212372, 7544.396448284234, 7614.695412183451, 6150.60021098645, 6931.480138989697, 6965.0, 7025.121859767529, 7299.9270007301375, 7477.626118693935, 7524.699012039676, 7557.05536807899, 7564.167941526318, 7575.772726818204, 6864.24493305746, 6894.827629309308, 6898.344657257552, 6899.689513971984, 6901.482388820959, 7041.119860017498, 7090.858182836211, 7093.680784364613, 7094.148702155568, 7095.8935615964765], "unit": "ms", "name": "mootools.html", "value": 4676.362383061834}, {"lowerIsBetter": false, "replicates": [349.5682831702848, 352.68787123395794, 356.59882632038955, 359.9496070550123, 361.4253337193861, 6015.21802165719, 6080.2399700037495, 6114.602550834193, 6142.570020098589, 6150.231221097357, 5899.380565040673, 5993.520518358532, 6060.515158787298, 6064.211652485182, 6066.454019138277, 4747.240441529356, 4748.335233067373, 4749.76251187441, 4751.453582837966, 4761.047790441909, 4542.341360502742, 4641.373414589021, 4667.626589872819, 4732.810687572493, 4750.382450281459, 4673.135469938073, 4686.437627484706, 4694.201985662446, 4697.953020469786, 4707.882302942419, 4692.671512994092, 4693.084848454553, 4695.060987802453, 4697.78859951303, 4706.294055891643, 4157.251694694954, 4158.126793373395, 4162.708610397273, 4162.812673429703, 4168.979155104235, 5678.716064196774, 5777.046787280094, 5778.162166485878, 5785.971070144622, 5787.276590426197, 5461.290032295776, 5475.342958844924, 5476.726163691799, 5480.342358916916, 5480.369757477902, 6201.596896201732, 6415.101885736, 6423.100765892778, 6429.5177861660095, 6430.0, 4501.549845015472, 4529.547045295477, 4594.494605593382, 4597.356370108188, 4597.448306203277, 6615.4707623390495, 6632.966835165793, 6633.86732265352, 6637.1703537057865, 6639.668016599199, 4714.905701885943, 4718.528147185254, 4721.0, 4721.740304283228, 4724.622030237572, 4700.55344742249, 4779.976100119477, 4787.880302992453, 4789.4971028041555, 4803.879903002383, 5457.590680698963, 5461.098918678374, 5461.836144915659, 5462.0, 5465.371482279589, 6480.125183100316, 6480.902786458207, 6483.481321494363, 6494.447971922439, 6494.837629059311, 1676.245689439757, 1699.192883380409, 1701.0899168944554, 1703.7870266216723, 1704.5568152280248, 1147.5696613769837, 1162.9069674426025, 1170.789257933563, 1181.9468123934444, 1186.8694443611196, 6339.492840572743, 6347.206599175103, 6349.46029587481, 6355.459785918156, 6357.459615932605, 6638.502112341594, 6670.299618539983, 6681.532292739462, 6689.331066893272, 6689.732410703615, 6241.78153764616, 6325.65208913505, 6338.334474880164, 6338.524610654219, 6344.968275158594, 3588.2644057968055, 3621.7464777465852, 3624.1664417184197, 3626.9818650907105, 3631.6368363164, 6861.691223894937, 6861.725530978705, 6864.691088901011, 6873.415759660485, 6876.553024053421, 6711.563748356341, 6802.897956530557, 6812.761553345609, 6817.239018197638, 6822.692978815965, 6812.080369150201, 6845.247022827485, 6847.007183958298, 6849.726010959605, 6857.382835544825, 6460.676966151767, 6565.934340656532, 6628.701708423229, 6667.299933507106, 6674.499412544175, 6592.868142637216, 6603.075569420381, 6614.801555953329, 6632.83417914556, 6663.300353463011, 6899.827504312432, 6900.102986611709, 6906.0, 6906.551074180162, 6906.723731050903, 4544.7045942013665, 4662.463816660992, 4667.066586682745, 4759.524047595212, 4767.6424268179335, 6698.497612678971, 6702.698378572878, 6712.060311556484, 6712.160979877515, 6721.1598550181225, 6508.121403610452, 6521.576097553644, 6523.7716679915975, 6525.477961762953, 6525.543211975116, 6382.968085159545, 6460.095586617783, 6477.838054048687, 6563.212414510289, 6603.372679595431, 6447.4197322241225, 6464.159659244268, 6464.806055818333, 6467.838304042437, 6471.191101112361, 6568.507361947969, 6598.274189839018, 6599.967000164968, 6605.306442823435, 6607.96696016536, 6281.59169653971, 6416.615003099829, 6421.903671444838, 6424.421802037839, 6455.838604034937], "unit": "ms", "name": "prototype.html", "value": 4929.271020256737}, {"lowerIsBetter": false, "replicates": [857.3184318466818, 864.9178328058836, 866.5623859950724, 900.6667533012786, 923.9538023098847, 14470.0, 14491.492797752067, 14964.700705985873, 14977.251137443138, 15003.949723519345, 13133.080684352099, 13141.211527308344, 13141.93429032856, 13179.0, 13191.6702082448, 741.1291732214653, 764.2319468933741, 885.3536918049796, 907.6505545365048, 911.2755359489189, 903.0969030969031, 913.8994710581864, 919.3105171121625, 919.8114386550741, 919.8482250428705, 799.8080460689422, 813.8413009463158, 968.8692026576392, 972.9562169702381, 975.2685485885586, 936.1434287626847, 961.543266948201, 966.709987003896, 967.1199208720101, 967.2987084363815, 709.5742554467279, 715.4526787007943, 716.2443621978811, 716.4232792601954, 717.1430140981529, 14159.575212743634, 14353.138811671228, 14363.138211707332, 14456.349464274133, 14463.13221206731, 11910.880891191064, 12629.87370126296, 13017.0, 13146.276954767483, 13336.999725020565, 10324.277300588961, 10458.163346932228, 10487.528061237263, 10582.470876456146, 10628.309159904658, 3806.7525610835205, 3841.9039524011846, 3845.769253844778, 3852.3451013327804, 3854.633809788094, 46407.0, 46976.0, 47422.28866567004, 47482.28776568389, 47493.28760068602, 9653.662121825702, 9720.465374404475, 9822.607095716234, 9863.556139973718, 9921.652742154134, 17879.28482860697, 18091.0, 18097.819021809875, 18098.27606895736, 18119.45641630753, 7368.0, 7592.202818703957, 7613.276738709814, 7757.635064630344, 7759.456838021284, 4417.138657961731, 4470.552944705503, 4496.437945256843, 4528.750918699503, 4650.395448591729, 3117.1583672408324, 3141.4659507883716, 3143.8742450301734, 3144.6698096699974, 3145.968540314613, 553.8227767114485, 557.2978047659977, 558.9580781441408, 574.348114889595, 587.3744462147799, 640.8348709402233, 685.396850771328, 687.7420967137324, 693.0920494152575, 697.9895301570481, 8080.191980801873, 8772.605232764541, 8912.55437228136, 9008.056269174196, 9082.22801061904, 549.5246611680867, 573.377884994777, 599.9670018149044, 651.6188030002406, 733.1898252431093, 4036.737612055207, 4244.87265382039, 4348.695591308578, 4389.4732632083715, 4516.277395616686, 53895.19157212645, 53986.46013539893, 53996.46003539993, 54135.0, 54329.72835135799, 49137.754311228215, 52978.0, 53087.203691944655, 53100.0, 53319.0, 46477.0, 47104.5289547107, 47503.52496474991, 47616.7619161902, 48198.759006204746, 9135.77160570991, 9404.576794044147, 9517.048295170427, 9528.761780955532, 9573.0, 34713.479297811056, 35082.47376289307, 35312.0, 35482.11294717653, 35927.28145437024, 41800.0, 44289.557104428546, 44463.0, 44721.552784471736, 44800.0, 11070.612528561462, 11554.48004839801, 11927.582534611247, 12012.0, 12063.457144428698, 11619.302841829518, 11684.941575292069, 12406.441710122886, 12421.254724716546, 12533.561325353568, 11231.101511879193, 11231.606893758679, 11313.886861131283, 11419.714507137056, 11464.197506174487, 11780.882191178322, 11838.0, 12031.398430078287, 12038.337891416057, 12335.876641233473, 10507.94746026265, 11492.827607585725, 11578.363190024293, 11637.592684256011, 11695.005924496512, 8868.512231827312, 9069.319801014819, 9888.604455821687, 9981.351212171186, 10181.89818101839, 9249.630014799333, 9707.951460242653, 9723.9027609723, 9734.0, 9737.221022318055], "unit": "ms", "name": "yui.html", "value": 6515.601546795812}], "name": "dromaeo_css", "value": 7298.484067673633}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 109.0, 108.0, 110.0, 99.0, 108.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.4}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 144.0, 159.0, 124.0, 149.0, 145.0, 121.0, 157.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 153.0, 70.0, 71.0, 71.0, 70.0, 152.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 133.0, 92.0, 92.0, 92.0, 145.0, 91.0, 92.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 108.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 148.0, 146.0, 145.0, 145.0, 146.0, 146.0, 144.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 56.0, 58.0, 55.0, 58.0, 56.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [79.0, 78.0, 81.0, 79.0, 80.0, 80.0, 80.0, 80.0, 80.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.7}, {"lowerIsBetter": true, "replicates": [114.0, 121.0, 117.0, 123.0, 118.0, 110.0, 116.0, 116.0, 126.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.5}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 147.0, 147.0, 155.0, 137.0, 143.0, 146.0, 143.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 64.0, 65.0, 63.0, 62.0, 66.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.4}], "name": "kraken", "value": 1473.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.12373907195695], "unit": "score", "name": "Richards", "value": 209.97629600000008}, {"lowerIsBetter": false, "replicates": [166.72224074691565], "unit": "score", "name": "DeltaBlue", "value": 396.575764}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [941.6195856873823], "unit": "score", "name": "RayTrace", "value": 785.8683179999997}, {"lowerIsBetter": false, "replicates": [535.9056806002144], "unit": "score", "name": "Earley", "value": 1243.6199580000002}, {"lowerIsBetter": false, "replicates": [10600.0], "unit": "score", "name": "Boyer", "value": 62.873867924528355}, {"lowerIsBetter": false, "replicates": [24560.975609756097], "unit": "score", "name": "RegExp", "value": 37.09074975173787}, {"lowerIsBetter": false, "replicates": [524.9343832020998], "unit": "score", "name": "Splay", "value": 155.24035499999994}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23273.910327544352}]} 01:47:57 INFO - RETURN: dromaeo_css: 7298.48 01:47:57 INFO - RETURN: kraken: 1473.30 01:47:57 INFO - RETURN: v8_7: 23273.91 01:47:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23273.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7298.48"}}} 01:47:57 INFO - Return code: 0 01:47:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:47:57 INFO - # TBPL SUCCESS # 01:47:57 INFO - Running post-action listener: _resource_record_post_action 01:47:57 INFO - Running post-run listener: _resource_record_post_run 01:47:58 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269258752; Read time: 40; Write time: 133232 01:47:58 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5152768; Read time: 0; Write time: 412 01:47:58 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264105984; Read time: 40; Write time: 132820 01:47:58 INFO - Running post-run listener: _upload_blobber_files 01:47:58 INFO - Blob upload gear active. 01:47:58 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:47:58 INFO - Copying logs to upload dir... 01:47:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.935702 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-01-26 01:47:58.527674) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:58.530828) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009856 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453734153/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-01-26 01:47:58.581659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:58.582020) ========= 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=337fe3f4b1febe37b85fccc40000019e-1453800421.951722-1679261555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-26 01:47:58.630915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 01:47:58.631190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-26 01:47:58.631468) ========= ========= Total master_lag: 0.26 =========