builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1455040156.79 results: success (0) buildid: 20160209072756 builduid: 4bb0953ff1454211981617239640966b revision: 74179c50c9d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.792164) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.792745) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.793019) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.821065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.821348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.838535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.838875) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.888603) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.888855) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.889205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:16.889597) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 09:49:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-02-09 09:49:17 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.083593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.083912) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017281 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.135458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.135830) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 74179c50c9d1 --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 74179c50c9d1 --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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 09:49:17,499 Setting DEBUG logging. 2016-02-09 09:49:17,499 attempt 1/10 2016-02-09 09:49:17,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/74179c50c9d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 09:49:17,783 unpacking tar archive at: mozilla-beta-74179c50c9d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.745299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.745680) ========= echo 74179c50c9d1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'74179c50c9d1'] 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 74179c50c9d1 program finished with exit code 0 elapsedTime=0.004789 script_repo_revision: '74179c50c9d1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.797638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.797983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 09:49:17.812167) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-09 09:49:17.812785) ========= /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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:49:18 INFO - MultiFileLogger online at 20160209 09:49:18 in /builds/slave/test-pgo 09:49:18 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 09:49:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:49:18 INFO - {'append_to_log': False, 09:49:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:49:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:49:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:49:18 INFO - 'branch': 'Mozilla-Beta', 09:49:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:18 INFO - 'config_files': ('talos/linux_config.py',), 09:49:18 INFO - 'default_actions': ('clobber', 09:49:18 INFO - 'read-buildbot-config', 09:49:18 INFO - 'download-and-extract', 09:49:18 INFO - 'populate-webroot', 09:49:18 INFO - 'create-virtualenv', 09:49:18 INFO - 'install', 09:49:18 INFO - 'run-tests'), 09:49:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:18 INFO - 'download_minidump_stackwalk': True, 09:49:18 INFO - 'download_symbols': 'ondemand', 09:49:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:18 INFO - 'installer_path': 'installer.exe', 09:49:18 INFO - 'log_level': 'info', 09:49:18 INFO - 'log_name': 'talos', 09:49:18 INFO - 'log_to_console': True, 09:49:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:49:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:49:18 INFO - 'opt_config_files': (), 09:49:18 INFO - 'pip_index': False, 09:49:18 INFO - 'sps_profile': False, 09:49:18 INFO - 'sps_profile_interval': 0, 09:49:18 INFO - 'suite': 'dromaeojs', 09:49:18 INFO - 'system_bits': '32', 09:49:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:18 INFO - 'title': 'talos-linux64-ix-058', 09:49:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:18 INFO - 'use_talos_json': True, 09:49:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:49:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:18 INFO - 'work_dir': 'build'} 09:49:18 INFO - ##### 09:49:18 INFO - ##### Running clobber step. 09:49:18 INFO - ##### 09:49:18 INFO - Running pre-action listener: _resource_record_pre_action 09:49:18 INFO - Running main action method: clobber 09:49:18 INFO - rmtree: /builds/slave/test-pgo/build 09:49:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:49:18 INFO - Running post-action listener: _resource_record_post_action 09:49:18 INFO - ##### 09:49:18 INFO - ##### Running read-buildbot-config step. 09:49:18 INFO - ##### 09:49:18 INFO - Running pre-action listener: _resource_record_pre_action 09:49:18 INFO - Running main action method: read_buildbot_config 09:49:18 INFO - Using buildbot properties: 09:49:18 INFO - { 09:49:18 INFO - "properties": { 09:49:18 INFO - "buildnumber": 74, 09:49:18 INFO - "product": "firefox", 09:49:18 INFO - "script_repo_revision": "production", 09:49:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:49:18 INFO - "repository": "", 09:49:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:49:18 INFO - "buildid": "20160209072756", 09:49:18 INFO - "slavename": "talos-linux64-ix-058", 09:49:18 INFO - "pgo_build": "True", 09:49:18 INFO - "basedir": "/builds/slave/test-pgo", 09:49:18 INFO - "project": "", 09:49:18 INFO - "platform": "ubuntu64_hw", 09:49:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:49:18 INFO - "slavebuilddir": "test", 09:49:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:49:18 INFO - "branch": "mozilla-beta", 09:49:18 INFO - "repo_path": "releases/mozilla-beta", 09:49:18 INFO - "stage_platform": "linux64-pgo", 09:49:18 INFO - "builduid": "4bb0953ff1454211981617239640966b", 09:49:18 INFO - "revision": "74179c50c9d1" 09:49:18 INFO - }, 09:49:18 INFO - "sourcestamp": { 09:49:18 INFO - "repository": "", 09:49:18 INFO - "hasPatch": false, 09:49:18 INFO - "project": "", 09:49:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:49:18 INFO - "changes": [ 09:49:18 INFO - { 09:49:18 INFO - "category": null, 09:49:18 INFO - "files": [ 09:49:18 INFO - { 09:49:18 INFO - "url": null, 09:49:18 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2" 09:49:18 INFO - } 09:49:18 INFO - ], 09:49:18 INFO - "repository": "", 09:49:18 INFO - "rev": "74179c50c9d1", 09:49:18 INFO - "who": "sendchange", 09:49:18 INFO - "when": 1455040125, 09:49:18 INFO - "number": 7583188, 09:49:18 INFO - "comments": "Bug 1246854 - Set the pref to not autodetect touch event support in reftests like we do in other sorts of tests, r+a=Sylvestre", 09:49:18 INFO - "project": "", 09:49:18 INFO - "at": "Tue 09 Feb 2016 09:48:45", 09:49:18 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:49:18 INFO - "revlink": "", 09:49:18 INFO - "properties": [ 09:49:18 INFO - [ 09:49:18 INFO - "buildid", 09:49:18 INFO - "20160209072756", 09:49:18 INFO - "Change" 09:49:18 INFO - ], 09:49:18 INFO - [ 09:49:18 INFO - "builduid", 09:49:18 INFO - "4bb0953ff1454211981617239640966b", 09:49:18 INFO - "Change" 09:49:18 INFO - ], 09:49:18 INFO - [ 09:49:18 INFO - "pgo_build", 09:49:18 INFO - "True", 09:49:18 INFO - "Change" 09:49:18 INFO - ] 09:49:18 INFO - ], 09:49:18 INFO - "revision": "74179c50c9d1" 09:49:18 INFO - } 09:49:18 INFO - ], 09:49:18 INFO - "revision": "74179c50c9d1" 09:49:18 INFO - } 09:49:18 INFO - } 09:49:18 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2. 09:49:18 INFO - Running post-action listener: _resource_record_post_action 09:49:18 INFO - ##### 09:49:18 INFO - ##### Running download-and-extract step. 09:49:18 INFO - ##### 09:49:18 INFO - Running pre-action listener: _resource_record_pre_action 09:49:18 INFO - Running main action method: download_and_extract 09:49:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:49: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')]} 09:49:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/test_packages.json 09:49:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:49:18 INFO - Downloaded 1270 bytes. 09:49:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:49:18 INFO - Using the following test package requirements: 09:49:18 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:49:18 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:49:18 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'jsshell-linux-x86_64.zip'], 09:49:18 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:49:18 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:49:18 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 09:49:18 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 09:49:18 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:49:18 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:49:18 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:49:18 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:49:18 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:49: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')]} 09:49:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:49:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:23 INFO - Downloaded 21581681 bytes. 09:49:23 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 09:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:49:23 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 09:49:24 INFO - Return code: 0 09:49:24 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 09:49: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')]} 09:49:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:49:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:25 INFO - Downloaded 21581681 bytes. 09:49:25 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 09:49:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:49:25 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 09:49:26 INFO - Return code: 0 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:49:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:28 INFO - Downloaded 11132038 bytes. 09:49:28 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 09:49:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:49:28 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 09:49:28 INFO - Return code: 0 09:49: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')]} 09:49:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:49:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/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 09:49:33 INFO - Downloaded 57943887 bytes. 09:49:33 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:49:33 INFO - mkdir: /builds/slave/test-pgo/properties 09:49:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:49:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:49:33 INFO - Contents: 09:49:33 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:49:33 INFO - Running post-action listener: _resource_record_post_action 09:49:33 INFO - Running post-action listener: set_extra_try_arguments 09:49:33 INFO - ##### 09:49:33 INFO - ##### Running populate-webroot step. 09:49:33 INFO - ##### 09:49:33 INFO - Running pre-action listener: _resource_record_pre_action 09:49:33 INFO - Running main action method: populate_webroot 09:49:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:33 INFO - '--tppagecycles', 09:49:33 INFO - '7'], 09:49:33 INFO - 'tests': ['tsvgm']}}, 09:49:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:49:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:49:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'tests': ['damp', 'tps']}, 09:49:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['damp', 'tps']}, 09:49:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:49:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:33 INFO - 'other': {'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'other_l64': {'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'other_nol64': {'tests': ['a11yr', 09:49:33 INFO - 'ts_paint', 09:49:33 INFO - 'tpaint', 09:49:33 INFO - 'sessionrestore', 09:49:33 INFO - 'sessionrestore_no_auto_restore']}, 09:49:33 INFO - 'svgr': {'tests': ['tsvgx', 09:49:33 INFO - 'tsvgr_opacity', 09:49:33 INFO - 'tart', 09:49:33 INFO - 'tscrollx', 09:49:33 INFO - 'cart']}, 09:49:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['tsvgx', 09:49:33 INFO - 'tsvgr_opacity', 09:49:33 INFO - 'tart', 09:49:33 INFO - 'tscrollx', 09:49:33 INFO - 'cart']}, 09:49:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'tests': ['tp5o']}, 09:49:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'talos_options': ['--e10s'], 09:49:33 INFO - 'tests': ['tp5o']}, 09:49:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'talos_options': ['--xperf_path', 09:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:33 INFO - 'tests': ['tp5n']}, 09:49:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:49:33 INFO - 'talos_options': ['--e10s', 09:49:33 INFO - '--xperf_path', 09:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:33 INFO - 'tests': ['tp5n']}}, 09:49:33 INFO - 'talos.zip': {'path': '', 09:49:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:33 INFO - Running post-action listener: _resource_record_post_action 09:49:33 INFO - ##### 09:49:33 INFO - ##### Running create-virtualenv step. 09:49:33 INFO - ##### 09:49:33 INFO - Running pre-action listener: _resource_record_pre_action 09:49:33 INFO - Running main action method: create_virtualenv 09:49:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:49:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:49:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:49:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:33 INFO - Using real prefix '/usr' 09:49:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:49:33 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:35 INFO - Installing pip.................done. 09:49:35 INFO - Return code: 0 09:49:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:35 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:35 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 09:49:35 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 09:49:35 INFO - Using env: {'DISPLAY': ':0', 09:49:35 INFO - 'HOME': '/home/cltbld', 09:49:35 INFO - 'LANG': 'en_US.UTF-8', 09:49:35 INFO - 'LANGUAGE': 'en_US:en', 09:49:35 INFO - 'LOGNAME': 'cltbld', 09:49:35 INFO - 'MAIL': '/var/mail/cltbld', 09:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:35 INFO - 'MOZ_NO_REMOTE': '1', 09:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:35 INFO - 'NO_EM_RESTART': '1', 09:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:35 INFO - 'SHELL': '/bin/bash', 09:49:35 INFO - 'SHLVL': '1', 09:49:35 INFO - 'TERM': 'linux', 09:49:35 INFO - 'TMOUT': '86400', 09:49:35 INFO - 'USER': 'cltbld', 09:49:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:35 INFO - '_': '/tools/buildbot/bin/python'} 09:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:49:36 INFO - Cleaning up... 09:49:36 INFO - Return code: 0 09:49:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:36 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:36 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 09:49:36 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 09:49:36 INFO - Using env: {'DISPLAY': ':0', 09:49:36 INFO - 'HOME': '/home/cltbld', 09:49:36 INFO - 'LANG': 'en_US.UTF-8', 09:49:36 INFO - 'LANGUAGE': 'en_US:en', 09:49:36 INFO - 'LOGNAME': 'cltbld', 09:49:36 INFO - 'MAIL': '/var/mail/cltbld', 09:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:36 INFO - 'MOZ_NO_REMOTE': '1', 09:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:36 INFO - 'NO_EM_RESTART': '1', 09:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:36 INFO - 'SHELL': '/bin/bash', 09:49:36 INFO - 'SHLVL': '1', 09:49:36 INFO - 'TERM': 'linux', 09:49:36 INFO - 'TMOUT': '86400', 09:49:36 INFO - 'USER': 'cltbld', 09:49:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:36 INFO - '_': '/tools/buildbot/bin/python'} 09:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:36 INFO - Downloading/unpacking psutil>=0.7.1 09:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:38 INFO - Installing collected packages: psutil 09:49:38 INFO - Running setup.py install for psutil 09:49:38 INFO - building 'psutil._psutil_linux' extension 09:49:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:49:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:49:38 INFO - building 'psutil._psutil_posix' extension 09:49:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:49:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:38 INFO - Successfully installed psutil 09:49:38 INFO - Cleaning up... 09:49:38 INFO - Return code: 0 09:49:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:38 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:38 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 09:49:38 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 09:49:38 INFO - Using env: {'DISPLAY': ':0', 09:49:38 INFO - 'HOME': '/home/cltbld', 09:49:38 INFO - 'LANG': 'en_US.UTF-8', 09:49:38 INFO - 'LANGUAGE': 'en_US:en', 09:49:38 INFO - 'LOGNAME': 'cltbld', 09:49:38 INFO - 'MAIL': '/var/mail/cltbld', 09:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:38 INFO - 'MOZ_NO_REMOTE': '1', 09:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:38 INFO - 'NO_EM_RESTART': '1', 09:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:38 INFO - 'SHELL': '/bin/bash', 09:49:38 INFO - 'SHLVL': '1', 09:49:38 INFO - 'TERM': 'linux', 09:49:38 INFO - 'TMOUT': '86400', 09:49:38 INFO - 'USER': 'cltbld', 09:49:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:38 INFO - '_': '/tools/buildbot/bin/python'} 09:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:49:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:49:40 INFO - Installing collected packages: mozsystemmonitor 09:49:40 INFO - Running setup.py install for mozsystemmonitor 09:49:40 INFO - Successfully installed mozsystemmonitor 09:49:40 INFO - Cleaning up... 09:49:40 INFO - Return code: 0 09:49:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:40 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:40 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 09:49:40 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 09:49:40 INFO - Using env: {'DISPLAY': ':0', 09:49:40 INFO - 'HOME': '/home/cltbld', 09:49:40 INFO - 'LANG': 'en_US.UTF-8', 09:49:40 INFO - 'LANGUAGE': 'en_US:en', 09:49:40 INFO - 'LOGNAME': 'cltbld', 09:49:40 INFO - 'MAIL': '/var/mail/cltbld', 09:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:40 INFO - 'MOZ_NO_REMOTE': '1', 09:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:40 INFO - 'NO_EM_RESTART': '1', 09:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:40 INFO - 'SHELL': '/bin/bash', 09:49:40 INFO - 'SHLVL': '1', 09:49:40 INFO - 'TERM': 'linux', 09:49:40 INFO - 'TMOUT': '86400', 09:49:40 INFO - 'USER': 'cltbld', 09:49:40 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:40 INFO - '_': '/tools/buildbot/bin/python'} 09:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:41 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:49:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:43 INFO - Downloading docopt-0.6.1.tar.gz 09:49:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:43 INFO - Running setup.py install for blobuploader 09:49:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:49:43 INFO - Running setup.py install for requests 09:49:44 INFO - Running setup.py install for docopt 09:49:44 INFO - Successfully installed blobuploader requests docopt 09:49:44 INFO - Cleaning up... 09:49:44 INFO - Return code: 0 09:49:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:44 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:44 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 09:49:44 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 09:49:44 INFO - Using env: {'DISPLAY': ':0', 09:49:44 INFO - 'HOME': '/home/cltbld', 09:49:44 INFO - 'LANG': 'en_US.UTF-8', 09:49:44 INFO - 'LANGUAGE': 'en_US:en', 09:49:44 INFO - 'LOGNAME': 'cltbld', 09:49:44 INFO - 'MAIL': '/var/mail/cltbld', 09:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:44 INFO - 'MOZ_NO_REMOTE': '1', 09:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:44 INFO - 'NO_EM_RESTART': '1', 09:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:44 INFO - 'SHELL': '/bin/bash', 09:49:44 INFO - 'SHLVL': '1', 09:49:44 INFO - 'TERM': 'linux', 09:49:44 INFO - 'TMOUT': '86400', 09:49:44 INFO - 'USER': 'cltbld', 09:49:44 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:44 INFO - '_': '/tools/buildbot/bin/python'} 09:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:44 INFO - Running setup.py (path:/tmp/pip-X20cHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:44 INFO - Running setup.py (path:/tmp/pip-xNygJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:44 INFO - Running setup.py (path:/tmp/pip-Vxshhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:44 INFO - Running setup.py (path:/tmp/pip-XGL78a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:44 INFO - Running setup.py (path:/tmp/pip-TRNqzJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:44 INFO - Running setup.py (path:/tmp/pip-snGxBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:44 INFO - Running setup.py (path:/tmp/pip-_S7QHf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:44 INFO - Running setup.py (path:/tmp/pip-6VWfLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:45 INFO - Running setup.py (path:/tmp/pip-LYWGz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:45 INFO - Running setup.py (path:/tmp/pip-jqcUCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:45 INFO - Running setup.py (path:/tmp/pip-En23ya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:45 INFO - Running setup.py (path:/tmp/pip-WbAU4B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:45 INFO - Running setup.py (path:/tmp/pip-g7oief-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:45 INFO - Running setup.py (path:/tmp/pip-Lqk7AN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:45 INFO - Running setup.py (path:/tmp/pip-dxyA9T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:45 INFO - Running setup.py (path:/tmp/pip-klfetc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:45 INFO - Running setup.py (path:/tmp/pip-UeT1O3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:45 INFO - Running setup.py install for manifestparser 09:49:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:49:45 INFO - Running setup.py install for mozcrash 09:49:45 INFO - Running setup.py install for mozdebug 09:49:45 INFO - Running setup.py install for mozdevice 09:49:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for mozfile 09:49:46 INFO - Running setup.py install for mozhttpd 09:49:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for mozinfo 09:49:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for mozInstall 09:49:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for mozleak 09:49:46 INFO - Running setup.py install for mozlog 09:49:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for moznetwork 09:49:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:49:46 INFO - Running setup.py install for mozprocess 09:49:46 INFO - Running setup.py install for mozprofile 09:49:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:49:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:49:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:49:47 INFO - Running setup.py install for mozrunner 09:49:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:49:47 INFO - Running setup.py install for mozscreenshot 09:49:47 INFO - Running setup.py install for moztest 09:49:47 INFO - Running setup.py install for mozversion 09:49:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:49:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:47 INFO - Cleaning up... 09:49:47 INFO - Return code: 0 09:49:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:47 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:47 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 09:49:47 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 09:49:47 INFO - Using env: {'DISPLAY': ':0', 09:49:47 INFO - 'HOME': '/home/cltbld', 09:49:47 INFO - 'LANG': 'en_US.UTF-8', 09:49:47 INFO - 'LANGUAGE': 'en_US:en', 09:49:47 INFO - 'LOGNAME': 'cltbld', 09:49:47 INFO - 'MAIL': '/var/mail/cltbld', 09:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:47 INFO - 'MOZ_NO_REMOTE': '1', 09:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:47 INFO - 'NO_EM_RESTART': '1', 09:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:47 INFO - 'SHELL': '/bin/bash', 09:49:47 INFO - 'SHLVL': '1', 09:49:47 INFO - 'TERM': 'linux', 09:49:47 INFO - 'TMOUT': '86400', 09:49:47 INFO - 'USER': 'cltbld', 09:49:47 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:47 INFO - '_': '/tools/buildbot/bin/python'} 09:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:47 INFO - Running setup.py (path:/tmp/pip-tyD6FJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:47 INFO - Running setup.py (path:/tmp/pip-PnqwNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:47 INFO - Running setup.py (path:/tmp/pip-ZmHTuI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:49:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:47 INFO - Running setup.py (path:/tmp/pip-GsYh1Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:48 INFO - Running setup.py (path:/tmp/pip-ENSJwt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:48 INFO - Running setup.py (path:/tmp/pip-h2OQsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:48 INFO - Running setup.py (path:/tmp/pip-DF7Vcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:48 INFO - Running setup.py (path:/tmp/pip-9NlMWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:48 INFO - Running setup.py (path:/tmp/pip-w8aJZu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:48 INFO - Running setup.py (path:/tmp/pip-AA8TqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:49:48 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)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:48 INFO - Running setup.py (path:/tmp/pip-3Q76BY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:48 INFO - Running setup.py (path:/tmp/pip-Xmzaps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:48 INFO - Running setup.py (path:/tmp/pip-q6R38d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:48 INFO - Running setup.py (path:/tmp/pip-f_7KiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:48 INFO - Running setup.py (path:/tmp/pip-f20O9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:48 INFO - Running setup.py (path:/tmp/pip-3Z7L8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 09:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:48 INFO - Running setup.py (path:/tmp/pip-JanvjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:49:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:50 INFO - Downloading blessings-1.6.tar.gz 09:49:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:50 INFO - Installing collected packages: blessings 09:49:50 INFO - Running setup.py install for blessings 09:49:50 INFO - Successfully installed blessings 09:49:50 INFO - Cleaning up... 09:49:50 INFO - Return code: 0 09:49:50 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:49:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:51 INFO - Reading from file tmpfile_stdout 09:49:51 INFO - Current package versions: 09:49:51 INFO - argparse == 1.2.1 09:49:51 INFO - blessings == 1.6 09:49:51 INFO - blobuploader == 1.2.4 09:49:51 INFO - docopt == 0.6.1 09:49:51 INFO - manifestparser == 1.1 09:49:51 INFO - mozInstall == 1.12 09:49:51 INFO - mozcrash == 0.16 09:49:51 INFO - mozdebug == 0.1 09:49:51 INFO - mozdevice == 0.47 09:49:51 INFO - mozfile == 1.2 09:49:51 INFO - mozhttpd == 0.7 09:49:51 INFO - mozinfo == 0.9 09:49:51 INFO - mozleak == 0.1 09:49:51 INFO - mozlog == 3.1 09:49:51 INFO - moznetwork == 0.27 09:49:51 INFO - mozprocess == 0.22 09:49:51 INFO - mozprofile == 0.27 09:49:51 INFO - mozrunner == 6.11 09:49:51 INFO - mozscreenshot == 0.1 09:49:51 INFO - mozsystemmonitor == 0.0 09:49:51 INFO - moztest == 0.7 09:49:51 INFO - mozversion == 1.4 09:49:51 INFO - psutil == 3.1.1 09:49:51 INFO - requests == 1.2.3 09:49:51 INFO - wsgiref == 0.1.2 09:49:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:51 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 09:49:51 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 09:49:51 INFO - Using env: {'DISPLAY': ':0', 09:49:51 INFO - 'HOME': '/home/cltbld', 09:49:51 INFO - 'LANG': 'en_US.UTF-8', 09:49:51 INFO - 'LANGUAGE': 'en_US:en', 09:49:51 INFO - 'LOGNAME': 'cltbld', 09:49:51 INFO - 'MAIL': '/var/mail/cltbld', 09:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:51 INFO - 'MOZ_NO_REMOTE': '1', 09:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:51 INFO - 'NO_EM_RESTART': '1', 09:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:51 INFO - 'SHELL': '/bin/bash', 09:49:51 INFO - 'SHLVL': '1', 09:49:51 INFO - 'TERM': 'linux', 09:49:51 INFO - 'TMOUT': '86400', 09:49:51 INFO - 'USER': 'cltbld', 09:49:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:51 INFO - '_': '/tools/buildbot/bin/python'} 09:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 09:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 09:49:51 INFO - Cleaning up... 09:49:51 INFO - Return code: 0 09:49:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:51 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 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:51 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 09:49:51 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 09:49:51 INFO - Using env: {'DISPLAY': ':0', 09:49:51 INFO - 'HOME': '/home/cltbld', 09:49:51 INFO - 'LANG': 'en_US.UTF-8', 09:49:51 INFO - 'LANGUAGE': 'en_US:en', 09:49:51 INFO - 'LOGNAME': 'cltbld', 09:49:51 INFO - 'MAIL': '/var/mail/cltbld', 09:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:51 INFO - 'MOZ_NO_REMOTE': '1', 09:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:51 INFO - 'NO_EM_RESTART': '1', 09:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:51 INFO - 'SHELL': '/bin/bash', 09:49:51 INFO - 'SHLVL': '1', 09:49:51 INFO - 'TERM': 'linux', 09:49:51 INFO - 'TMOUT': '86400', 09:49:51 INFO - 'USER': 'cltbld', 09:49:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:51 INFO - '_': '/tools/buildbot/bin/python'} 09:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:51 INFO - Downloading/unpacking jsonschema 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:53 INFO - Downloading/unpacking functools32 (from jsonschema) 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:53 INFO - warning: no files found matching '*.txt' 09:49:53 INFO - no previously-included directories found matching 'build' 09:49:53 INFO - no previously-included directories found matching 'dist' 09:49:53 INFO - no previously-included directories found matching '.git*' 09:49:53 INFO - Installing collected packages: jsonschema, functools32 09:49:53 INFO - Running setup.py install for functools32 09:49:53 INFO - warning: no files found matching '*.txt' 09:49:53 INFO - no previously-included directories found matching 'build' 09:49:53 INFO - no previously-included directories found matching 'dist' 09:49:53 INFO - no previously-included directories found matching '.git*' 09:49:53 INFO - Successfully installed jsonschema functools32 09:49:53 INFO - Cleaning up... 09:49:53 INFO - Return code: 0 09:49:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a601f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c580e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, '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': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:49:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:49:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:49:53 INFO - Using env: {'DISPLAY': ':0', 09:49:53 INFO - 'HOME': '/home/cltbld', 09:49:53 INFO - 'LANG': 'en_US.UTF-8', 09:49:53 INFO - 'LANGUAGE': 'en_US:en', 09:49:53 INFO - 'LOGNAME': 'cltbld', 09:49:53 INFO - 'MAIL': '/var/mail/cltbld', 09:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:53 INFO - 'MOZ_NO_REMOTE': '1', 09:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:53 INFO - 'NO_EM_RESTART': '1', 09:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:49:53 INFO - 'PWD': '/builds/slave/test-pgo', 09:49:53 INFO - 'SHELL': '/bin/bash', 09:49:53 INFO - 'SHLVL': '1', 09:49:53 INFO - 'TERM': 'linux', 09:49:53 INFO - 'TMOUT': '86400', 09:49:53 INFO - 'USER': 'cltbld', 09:49:53 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:53 INFO - '_': '/tools/buildbot/bin/python'} 09:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:54 INFO - Downloading/unpacking flake8 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:56 INFO - no previously-included directories found matching 'docs/_build' 09:49:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:56 INFO - Running setup.py install for pep8 09:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:56 INFO - no previously-included directories found matching 'docs/_build' 09:49:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:49:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:56 INFO - Cleaning up... 09:49:56 INFO - Return code: 0 09:49:56 INFO - Running post-action listener: _resource_record_post_action 09:49:56 INFO - Running post-action listener: _start_resource_monitoring 09:49:56 INFO - Starting resource monitoring. 09:49:56 INFO - ##### 09:49:56 INFO - ##### Running install step. 09:49:56 INFO - ##### 09:49:56 INFO - Running pre-action listener: _resource_record_pre_action 09:49:56 INFO - Running main action method: install 09:49:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:49:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:49:57 INFO - Reading from file tmpfile_stdout 09:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:49:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:49:57 INFO - Reading from file tmpfile_stdout 09:49:57 INFO - Output received: 09:49:57 INFO - Usage: mozinstall [options] installer 09:49:57 INFO - Options: 09:49:57 INFO - -h, --help show this help message and exit 09:49:57 INFO - -d DEST, --destination=DEST 09:49:57 INFO - Directory to install application into. [default: 09:49:57 INFO - "/builds/slave/test-pgo"] 09:49:57 INFO - --app=APP Application being installed. [default: firefox] 09:49:57 INFO - mkdir: /builds/slave/test-pgo/build/application 09:49:57 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'] 09:49:57 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 09:50:11 INFO - Reading from file tmpfile_stdout 09:50:11 INFO - Output received: 09:50:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:50:11 INFO - Running post-action listener: _resource_record_post_action 09:50:11 INFO - ##### 09:50:11 INFO - ##### Running run-tests step. 09:50:11 INFO - ##### 09:50:11 INFO - Running pre-action listener: _resource_record_pre_action 09:50:11 INFO - Running main action method: run_tests 09:50:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:50:11 INFO - Python 2.7.3 09:50:11 INFO - Return code: 0 09:50:11 INFO - grabbing minidump binary from tooltool 09:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:11 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 0x1ce6e30>, '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 0x1ce7d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce81c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:50:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 09:50:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:50:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:11 INFO - Return code: 0 09:50:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:50:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:50:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:50:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:50:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:50:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:50:12 INFO - Return code: 0 09:50:12 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/1455031676/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:50:12 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/1455031676/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 09:50:12 INFO - Using env: {'DISPLAY': ':0', 09:50:12 INFO - 'HOME': '/home/cltbld', 09:50:12 INFO - 'LANG': 'en_US.UTF-8', 09:50:12 INFO - 'LANGUAGE': 'en_US:en', 09:50:12 INFO - 'LOGNAME': 'cltbld', 09:50:12 INFO - 'MAIL': '/var/mail/cltbld', 09:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:12 INFO - 'MOZ_NO_REMOTE': '1', 09:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:50:12 INFO - 'NO_EM_RESTART': '1', 09:50:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 09:50:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:50:12 INFO - 'SHELL': '/bin/bash', 09:50:12 INFO - 'SHLVL': '1', 09:50:12 INFO - 'TERM': 'linux', 09:50:12 INFO - 'TMOUT': '86400', 09:50:12 INFO - 'USER': 'cltbld', 09:50:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256', 09:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:12 INFO - '_': '/tools/buildbot/bin/python'} 09:50:12 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/1455031676/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 09:50:12 INFO - mozversion INFO | application_buildid: 20160209072756 09:50:12 INFO - mozversion INFO | application_changeset: 74179c50c9d1fae6fd21cad728dcf57c04da3b36 09:50:12 INFO - mozversion INFO | application_display_name: Nightly 09:50:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:12 INFO - mozversion INFO | application_name: Firefox 09:50:12 INFO - mozversion INFO | application_remotingname: firefox 09:50:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:12 INFO - mozversion INFO | application_vendor: Mozilla 09:50:12 INFO - mozversion INFO | application_version: 45.0 09:50:12 INFO - mozversion INFO | platform_buildid: 20160209072756 09:50:12 INFO - mozversion INFO | platform_changeset: 74179c50c9d1fae6fd21cad728dcf57c04da3b36 09:50:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:12 INFO - mozversion INFO | platform_version: 45.0 09:50:12 INFO - 2016-02-09 09:50:12,995 DEBUG : using testdate: 1455040212 09:50:12 INFO - 2016-02-09 09:50:12,995 DEBUG : actual date: 1455040212 09:50:13 INFO - 2016-02-09 09:50:13,084 INFO : starting webserver on 'localhost:58472' 09:50:13 INFO - 2016-02-09 09:50:13,085 INFO : Starting test suite talos-linux64-ix-058 09:50:13 INFO - 2016-02-09 09:50:13,085 INFO : Starting test dromaeo_css 09:50:13 INFO - 2016-02-09 09:50:13,085 DEBUG : operating with platform_type : linux_ 09:50:13 INFO - 2016-02-09 09:50:13,086 INFO : Initialising browser for dromaeo_css test... 09:50:13 INFO - 2016-02-09 09:50:13,099 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL7kS_y/profile http://localhost:58472/getInfo.html 09:50:16 INFO - 2016-02-09 09:50:16,805 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:16 INFO - 2016-02-09 09:50:16,806 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:16 INFO - 2016-02-09 09:50:16,806 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:50:16 INFO - 2016-02-09 09:50:16,806 DEBUG : BROWSER_OUTPUT: __metrics 09:50:16 INFO - 2016-02-09 09:50:16,963 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] 09:50:18 INFO - 2016-02-09 09:50:18,006 INFO : Browser initialized. 09:50:18 INFO - 2016-02-09 09:50:18,006 INFO : Running cycle 1/1 for dromaeo_css test... 09:50:18 INFO - 2016-02-09 09:50:18,007 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL7kS_y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:29 INFO - 2016-02-09 09:50:29,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 134504448 09:50:29 INFO - 2016-02-09 09:50:29,683 DEBUG : BROWSER_OUTPUT: 09:51:20 INFO - 2016-02-09 09:51:20,733 DEBUG : BROWSER_OUTPUT: 1455040280729 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:53:28 INFO - 2016-02-09 09:53:28,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58472/tests/dromaeo/cssquery-ext.html) 09:53:29 INFO - 2016-02-09 09:53:29,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 227643392 09:53:29 INFO - 2016-02-09 09:53:29,924 DEBUG : BROWSER_OUTPUT: 09:56:31 INFO - 2016-02-09 09:56:31,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-ext.html (next: http://localhost:58472/tests/dromaeo/cssquery-jquery.html) 09:56:32 INFO - 2016-02-09 09:56:32,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 220065792 09:56:32 INFO - 2016-02-09 09:56:32,487 DEBUG : BROWSER_OUTPUT: 09:59:34 INFO - 2016-02-09 09:59:34,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58472/tests/dromaeo/cssquery-mootools.html) 09:59:34 INFO - 2016-02-09 09:59:34,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 204636160 09:59:34 INFO - 2016-02-09 09:59:34,849 DEBUG : BROWSER_OUTPUT: 10:02:36 INFO - 2016-02-09 10:02:36,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58472/tests/dromaeo/cssquery-prototype.html) 10:02:37 INFO - 2016-02-09 10:02:37,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 203288576 10:02:37 INFO - 2016-02-09 10:02:37,101 DEBUG : BROWSER_OUTPUT: 10:05:39 INFO - 2016-02-09 10:05:39,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58472/tests/dromaeo/cssquery-yui.html) 10:05:40 INFO - 2016-02-09 10:05:40,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 196481024 10:05:40 INFO - 2016-02-09 10:05:40,122 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/dromaeo/cssquery-yui.html (next: http://localhost:58472/tests/dromaeo/cssquery-dojo.html) 10:08:42 INFO - 2016-02-09 10:08:42,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 239013888 10:08:42 INFO - 2016-02-09 10:08:42,314 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,315 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:08:42 INFO - 2016-02-09 10:08:42,315 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:08:42 INFO - 2016-02-09 10:08:42,316 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:08:42 INFO - 2016-02-09 10:08:42,316 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:08:42 INFO - 2016-02-09 10:08:42,319 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3254.463013602755;3296.126526470487;3339.215284408165;3387.4072037393466;3411.215420453296;5268.47315268473;5446.319210098738;5458.263134476844;5463.48096930792;5485.4788795064505;5451.809186678467;5489.780408783644;5501.972490137544;5506.256655351526;5515.889682206353;4909.091818013661;4969.527894849993;5011.523905229015;5018.573421259197;5029.4216165141115;4939.950600494003;4999.825006124786;5043.268726034723;5044.092063428581;5050.393952725678;5021.046001259749;5085.593152547805;5095.745212739367;5132.820351287705;5179.378474583055;5147.1764517677175;5170.638055336147;5191.2472691459525;5202.707766092988;5226.895462090775;4952.306677065214;4999.3000979862845;5103.209002604603;5122.154844450662;5173.249878767558;5179.792808287664;5265.183896496049;5287.233351164098;5294.152935530296;5299.099153143936;5884.7940322088525;5927.73325200367;5935.317438494585;5938.851528711773;5939.940600594025;5784.8843023139725;5860.912086318709;5862.413758624103;5942.910856337158;5965.135055416984;5616.634918730269;5659.094544872842;5675.9432405675825;5681.460261275172;5681.659100453986;6130.080487926757;6144.078388241799;6151.2618485781095;6152.723127459275;6155;5615.719214039282;5767.192593036978;5838.416158384128;5962.672053037125;5971.820845374646;6041.546883983631;6047.879042419127;6055.848603784941;6060.454559089703;6064.848378790565;5971.134185543159;6010.068439391814;6013.9699301503215;6020;6022;5756.1653560233535;5805.7387417566315;5872.559558033079;5965.403459654;5971.58198926071;4585.839495617637;4589.128065667513;4589.35748995141;4598.586127248564;4616.815327386867;4105.527864295645;4111.814968326433;4117.07365842689;4122.546519882811;4134.669226461876;5479;5618.494335509824;5652.406497317805;5714.514266287412;5751.654900705971;5990.311114221833;6083.330833608299;6094.542909281821;6096.939030609726;6100.694965251809;5508.9724551376985;5711;5764.5676574257095;5777.3933736957015;5780;5123.538881500683;5165.690058596421;5251.212318152231;5253.947460525423;5287.41838397776;6168.938310616836;6174.043023331391;6180.103884936659;6183.288921774054;6213.751449941951;5742.1673857289625;5854.092615644582;6030.969845150747;6041.78853740117;6046.939530604814;6106.786262480792;6203.906941395792;6209.348018457997;6213.5339849512375;6218.81343559694;5849.151872978479;5851.122331650116;5855.151003104611;5855.473007429352;5858.94141058584;5831.94168058314;5900.203472531153;5918.2898052234;5939.287285525592;5970.104484327386;5877.706114694333;5887.352391236875;5889.94110058894;5895.351511333664;5901.3213480450295;5836.620619659709;5881.500072493886;5885.058390657474;5892.057270836645;5899.056151015817;5502.0921547944145;5598.888022239614;5636.971815140898;5805.767769289181;5809.651420914759;5875.14810352488;5890.558208134321;5924.911126333022;5925.140854576149;5934.19888315072;5672.7730890763905;5719.685417302088;5720.141978703228;5728.054870946247;5793.536517078539 10:08:42 INFO - 2016-02-09 10:08:42,321 DEBUG : BROWSER_OUTPUT: |1;ext.html;588.5850475414833;627.2034516164471;636.6689321552793;639.6162302618433;701.092085748955;32891.342173156525;34093;41980.37029444561;42584.14831703364;42614;47049.529504704944;47506.28740568894;47559.762201189034;47622.523774762245;47796;8025.3178479829285;9071.22894553962;9229.907700923006;9236.491992940419;9242.6302947882;7985.800354991114;8044.356451483867;10902.400367979759;11147.498362573662;11217.326960382363;10802.621908233214;10981.725456863562;10989.890101098967;10998.450077496092;11002.229843910929;10777.137828973664;10869.619563315286;10879.12966962641;10894.128469722482;10909.236353455182;10662.680119596425;10758.139348852073;10769.946150269277;10789.83815242772;10799;43570.78214608907;43769;43905.56094439047;43968.56031439677;43992.3401148983;3495.790252584853;3503.982480087583;3605.0446631642635;3733.757305775116;3781.300459415017;32887.17782055444;32940.17649558756;33190;33191.502127468106;33233;4122.606352624771;4271.487421509439;4273.572642735733;4302.41917341158;4329.372241025065;292472;294664;295342;299941;301198;60159.69920150371;61286.38713612807;67222.66388668025;67664.3233567658;67739;74146.6292668544;76083.61958190173;76757.61621191859;76813.85489160965;76868.23131768723;16844.74732879008;17211.483655490356;17245.051522166403;17248.568785780204;17255.65488690219;12637.431315590637;12672.49310027607;12673.17624354414;12677;12678.732126787432;22625.2081177158;22875.771242287363;22961.425964351023;22977.655335169984;23013.42466438319;8588;8736.912630873738;8773.166549177819;8848.557572121368;8936.28509719234;1018.674024312213;1036.8911264317137;1140.845985791924;1176.8528933883265;1236.3262022197923;29692.257693557833;29852.253693657833;30655.233619159255;30765.846170769004;31167.376652466824;1132.314949455584;1133.4049623947494;1204.6085022367765;1213.0053356247968;1216.087934049463;13991.86008139926;15907.522774316789;15988;16108.436204732778;16665.3333866644;240990;243468;244293;244613;244718;60623.393766061774;60965;61083.694581526805;61309.693451532454;61434.92825358714;1266.6263452281598;1481.703659268129;1489.113977183574;1492.6865358274883;1502.6243439140214;30985.845070774503;30991.69008309888;31268.68731312658;31523.21191970219;32094.358112837144;51163.74418127885;51863;51882;51908.22137667862;52016;337714;341424;342166;342211;342698;29815.701842981292;30204.09387718372;34058.489122662686;34379.484307735904;36141.27717445584;39697.80151099341;39918.600813991485;39963.2007359857;40941.18117637571;40986;37755.24489510249;37870;37939.241215176095;45703.54296457126;46660.53339466562;39242.607573923895;39300;39603;39644.603553964094;40068.79965600153;38869.2226155481;39725.80137099296;39727.404088938114;39763.60236397599;40046.799766000986;34615.480767788;35065.474017890265;35478;35624.46563301604;35723;27261.454770904867;27317.317067073483;27378.452430951667;27382.178534643994;27441.17676469709 10:08:42 INFO - 2016-02-09 10:08:42,322 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.2701731623335;378.1057798307004;381.14813392068737;382.9885103446894;383.26413286489935;15250.84749152508;16757.329706811728;17080.82919170808;18454.26182952682;18529.536761580966;18129;18372.35696750614;18559;18780.436586902382;18837.434876953677;4305.892352691177;5550.972245138769;5679.119736440858;5679.204911312419;5679.5740319476;4393.978030109845;6074.514038876901;6189.721462534197;6210.875782484371;6230.158928544633;5298.629095963284;5452.972735136339;6122.938770612303;6154.815355539318;6159.722812473427;5377.919331210035;5432.728363581825;5433.049216387136;5443.5100840924115;5479.150731636582;5488.25908502355;5509.724513774336;5511.311086114236;5512.476314750093;5515.172724091419;13416.597502074954;13651.044426890121;16293.83706162935;20989.89505052465;21473.355799326044;2146.1093646136833;2210.0938615167706;2238.9664155037685;2247.5617254635354;2252.68462415262;7159.74940877072;7206.3154000370405;7410.37011853993;12350.320732359716;12964.37945256843;1831.8626103042325;1832.239620557467;1875.7749070111674;1937.9631896935214;2003.3589251439546;62359;65664.3433565663;65704;65724.67137664281;66016;10872.78254434907;10931.906809319005;10935.56257749697;10960.342379457257;10960.945195273973;14251.429942802379;14254.073485223427;14318.14091154534;14352.425902963765;14356.425742970374;8184.754457366289;8186.345092392594;8207.630656620466;8215.260626543639;8263.545504997162;8023.9598802006785;8039.5176289422825;8066.153053929253;8101.230383113595;8116.513009219466;4319.719218250803;4415.359772832921;4593.150267200579;4645.117427688729;4693.6949098308505;1792.2920446423589;1820.4083672806391;1888.0822293740544;1890.5368184794813;1902.2105826082297;966.4249771386014;993.1310103659298;1011.6054738651932;1081.605214096849;1128.0745975229925;17523.474295771146;17692.292308307522;17884.195211215527;18017.729734054;18230.908845455688;1014.9695509134738;1020.505055048301;1032.9018743219383;1067.508945884886;1070.314998401024;10038.799224015478;10375.636852710119;10401.21990850674;10405.271630985759;10483.842742358871;534185;541155;604514;619257;623859;88913;91061;91833.54083229542;91888.54055729679;95434;1204.4339160594507;1217.3183017510223;1230.6246594788674;1238.4922181905376;1242.7763002659608;15613.76579351288;15701.13643749559;15727.921360393582;16176.433824816075;16195.676086477968;33640.3271934555;34287.31425371528;34303.313933721685;34567.654323456445;35347;40886.79556602317;41847.37228941507;42114.57885421107;43434.13131737411;44912.32631510465;9929.404235745878;10196;10269.07578317925;10297.639582614573;10314.742131446774;11901.047916166513;12954.870451295743;18259.908700456413;18487;18925.14836832318;15112.09327440357;15308.081515109128;15310.464133755266;15427.074375537504;15811.13038782832;15181.089134651957;15378.38486460529;15497.690046198788;15939.123348215959;16010.67978640444;15908.840911591198;15922.840771592137;16250.349986000427;16255.51233462998;16255.674886501967;10137.746556336151;10166.390016599027;10299.330543514647;10414.791704166026;10427.322224055411;11085.057770089632;11142.498587563741;14903.85096149068;15593.766093508833;15646.061236325857 10:08:42 INFO - 2016-02-09 10:08:42,326 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1591.3714082937238;1617.932164771251;1644.2189959769112;1822.5534743987726;1914.2630087416348;7657.617119144042;8052.718154864581;8062.798430039252;8066.878996815045;8068.354531637462;6890.896636550443;7097.077379940613;7590.58251796151;7737.690492380298;7906;2304.7695230476943;2318.084356679111;2337.7662233776655;2339.099446713019;2344.296710986706;2090.195274819198;2382.249591378719;2411.7105947286263;2435.2937648082034;2438.9634155487684;2063.5769667218183;2263.151318255654;2338.333574931145;2340.20433052762;2351.400392899808;2269.5120549081944;2296.47181148336;2297.563462942044;2315.9652605210936;2317.6060069788177;2396.2930935373934;2403.375122468153;2423.1761201191503;2431.222008957134;2439.1097249503982;8007.439479236456;8040.2361775631225;8073.798155046112;8076.636551355203;8088.069871964741;4887.095887260868;4959.032988567231;4971.90056198874;4972.129877271499;4972.726500042532;3079.799813012147;3090.7063828936216;3091.6753740857334;3137.8117312961067;3152.763542734281;1064.909482693972;1065.6376831877121;1102.6471529110688;1104.8508451359044;1110.9833352499718;11240.269382490113;11244.325340479598;11245.662630121109;11262.831057534144;11269.549218031269;4360.869173924787;4461.5092339842595;4465.776711164429;4468.530804265505;4474.105178964221;8886.644534218689;8935.642574297086;8945.552722363856;8953.149450802164;8961.641534338683;4900.215965445512;4925.655204135748;4943.431505376856;4944.728039957837;4954.9752251238515;4502.662300327423;4545.590896819236;4548.56788605082;4549.909001819945;4555.134524440412;3490.441529355291;3528.647135286451;3530.993666804948;3543.9291214175573;3549.5563054618174;993.1806259835664;1034.8706411698538;1060.4326685223368;1079.1528650009705;1106.9723256918642;1109.9389533575732;1156.1213477756964;1159.2696601141395;1322.9140105893086;1444.5594093801492;7700.614969251515;7730.458867879307;7808.843823123506;7822.06135263772;7822.687092516349;669.3607604737464;670.0686046395514;677.075791544548;687.9690413931385;810.8580998325269;6101.328853826164;6190.938090619126;6196.938030619726;6201.96899015502;6202.968985155046;9228.676996305232;9531.714048578553;9691.418514889128;9836.508174591385;9851.261155413229;9708.271879609058;9723.416595004323;9726.17327527154;9747.951260243653;9759.26805489591;7386.778396648109;7515.699372025167;7538.886916696254;7551.584662843707;7555.320021198118;7467.178610352966;7496.100467943882;7511.9624401877645;7514.0607424071995;7515.774526764206;8434.536100514286;8462.111478294937;8490.27832634233;8612.78468038279;8650.697225597074;8642.740717778477;8662.341489239578;8743.606537705691;8829.117088291376;8839.867401989104;7283.8543229136185;7310.305520975498;7365.558066516026;7369.226231245856;7380.077490313711;7882.369410447265;7961.124276329483;7978.002749656293;8001.479903806234;8013.2387423194705;6444.258910225384;7480.476366654282;7499.925000749922;7517.511361761468;7551.433642476726;5927.288725352985;7042.119735033121;7214.458915581247;7251.746188883575;7302.890456643261;6890.44876409896;6892.620905850226;6902.758403455855;6906.585604863724;6930.099087118642;6757.3242675732035;6816.113905192294;6821.488388370793;6828.9317106830285;6860.142482189726;6722.327767223434;6729.158855143107;6764.898526522008;6789.490788190807;6813.182418109858 10:08:42 INFO - 2016-02-09 10:08:42,326 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.998245008775;353.35159981434066;356.37634140254556;368.0999955109754;374.37853163748184;6142.078688196772;6158.353372895843;6233.657148856811;6247.656753797933;6253.906191407133;5868.2664666916635;5933.762649494015;6061.575689701712;6148.047052706826;6153.661548614825;4789.904201915968;4792.065547218293;4796.688215266014;4799.688020278671;4823.686460380081;4541.159885421192;4802.4237091548885;4807.687500312486;4810.542998415145;4821.855344339676;4585.679002469828;4597.356370108188;4722.763861806913;4732.290156476522;4744.620430365562;4702.988857395642;4711.7879695413785;4720.103180395731;4721.74030428328;4753.786079626425;4176.958230417687;4182.602652747984;4183.686223533247;4184.644305234059;4193.22425351311;5720.170575266605;5817.360090390053;5821.941780582225;5826.038703613898;5826.067829147316;5543.584231182637;5546.140348246028;5547.3343198816;5550.139728342114;5552.500274975231;6485.610863348167;6488.935110648928;6492.480601551864;6494.5453818232745;6495.253045899734;4648.721076735406;4653.395058642355;4655.6964050066035;4667.789949452283;4692.10849938514;6590.275069742324;6745.932540674579;6788.083608712859;6800.217974932896;6806.829829254309;4636.188666983265;4660.13787449323;4662.6269898408045;4663.207254766698;4664.55686709762;4723.267893476516;4724.244120940633;4724.29925226918;4725.787339569728;4728.692634978785;5344.625876188629;5457.972710136424;5458.645188062763;5459.153831156177;5461.1808228766;6546.279909209983;6558.770443034471;6558.770443034567;6560.803175904731;6568.770093046721;1659.236751094486;1690.2985261116744;1691.1544227886056;1693.8729595280404;1693.9243580326336;1101.5208384352832;1115.8214685650257;1121.52895783771;1124.3310230412892;1167.7781221567875;6315.589486683442;6330.0821380899515;6334.081558174131;6338.049292606053;6341.778037768656;6575.276719560845;6740.494462915301;6780.118584583973;6788.355106264897;6793.524453288322;6282.811515654537;6341.143945567289;6458.031295305648;6464.806055818333;6469.51478639104;3633.7274704397278;3682.8526858925343;3683.686886614614;3684.6868016218923;3690.132818787583;6935.791926242221;7066.929330706627;7073.115860517435;7077.6461176941975;7078.115235595551;7017.122859642544;7020.7542736004;7031.6484175791;7035.085438892911;7038.40173585251;7096.042034325404;7100;7104.43164546835;7109.324614161646;7112.28877112295;6662.467002639874;6836.111305530449;6848.315168483112;6853.691583878638;6863.691133899087;6748.561343512656;6752.054712340375;6753.966230168818;6754.0881980931945;6756.087928129836;7059.894101588377;7062.8940565890525;7078.787636370917;7081.716731330689;7084.964575177091;4532.4334458192725;4622.6764126510825;4689.132510485571;4721.386219791405;4726.645501587326;6766.323367663194;6771.729130834711;6775;6779.457643388616;6780.38976492118;6601.240857301472;6602.801915942529;6607.867842643216;6611.305812889577;6621.073049772939;6448.709808058742;6575.342465753386;6577.046328282277;6598.307177746267;6603.405693487609;6480.611163330215;6483.578567393104;6490.448311893542;6490.578112422678;6491.642959637265;6617.338266173344;6621.0068489725;6622.403983641495;6623.3376662333385;6623.966880165568;6317.052442133717;6354.936450635434;6453.967730161319;6456.54804163704;6475.481961443167 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: |5;yui.html;835.7618078847528;891.157855826244;901.1484147480634;920.3695468604003;949.7483166960754;11499.080073594114;11672.591459298927;11789.882101178986;11791.233569817978;11792.941035294822;10973.83539246912;11343.602973895915;11377.146713996442;11395.487203075862;11404.828927566072;729.9890501642479;741.9925800742004;890.3900827932887;903.832790933676;905.6060613633091;897.0625696147509;900.8018235988072;903.0878812399491;904.1049361132465;904.3759805734022;783.2715574515698;945.9621615135386;947.2800671489683;947.7535840681403;948.6869333120088;785.4619585583865;935.957881895313;938.6386241297116;943.5518128888791;944.3531181140941;703.63762662229;703.7958991892345;704.031956060417;705.3369832357567;707.6886170085146;11278.887211127865;11413.942930285379;11414.657560273205;11432.885671143265;11457.484413201426;10767.83848242277;11221.38282394468;11504.309741415542;11591.362475063868;11861.9917307029;9550.90449095507;9690.418574885529;9712.368696034806;9853.655122070693;9915.058069483388;3480.6519348065244;3531.699805516534;3532.7527073104893;3534.540509733718;3541.911452213715;47310.29034564484;47634.523654763354;48156;48713.51286487125;49044;8659.437136586102;8742.08208138149;8752.081031491602;8763.956180219186;8767.517786521803;18453.7231941521;18478.722819157723;18501.259949602136;18504.16731247097;18520.351787687367;7037.120359955005;7071.82320441993;7088.539244949062;7171.426285897116;7196.4962452627815;4230.957690423118;4327.02641905575;4343.066240758252;4348.913021739548;4350.630196433339;2995.8801647934274;3005.2637103909683;3024.2439390152463;3034.150437877398;3037.4380739563253;553.391269603433;559.9356074051454;560.246468499867;562.0220815780513;575.2378099018733;686.8866637004938;706.4454403293493;708.0193931404938;719.2555704845564;767.0603510699349;7890.171531989058;8136.600740053739;8247.298979586682;8338.874916876252;8352.540610266493;569.4305694305694;621.6177051113623;663.9468842492589;699.9825004374932;702.685977222597;3759.3984962405884;3871.380579107329;4205.852795152155;4220.451341325608;4235.618794308527;59152.40847591469;59206.703966479894;59922.40077599255;60420;60637.393626064055;49693;51282.74358628183;51453.48546514562;51633;52021.878687278884;46496.3025554617;47719.522804771506;48061.5193848064;48062.759686201345;48337;8001.639926203218;8149.225823546753;8468.788280293042;8502.022267439077;8566.18621230982;34745.74580565336;35388;35964.10089747777;36043.42942718083;36607.81696091503;41713.79143104265;42554.78722606367;43746.781266093465;45696.54303456923;46120.30819537643;10863.076638485818;10959;11059.336439813636;11154.386508742096;11292.774144517229;12412.937935310265;12417;12705.301208433624;12894.743395004782;12957.805632915703;10807.405592692478;10860.348379097279;11040.061594764215;11146.609868654557;11162.497687603915;11009.559617615527;11153.498092586015;11156.219064665396;11252.75729814576;11327.716807079889;9863.852042219229;10027.498625068863;10264.743381415525;10405.427701476492;10409.531571079167;9743.366681165986;10083.294169408364;10241.84637230457;10436.217283703905;10573.207009474474;9281.776791559689;9399.34204605671;9408.717738467856;9481.952590237004;9489.57296921654 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: __startTimestamp1455041322315__endTimestamp 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,327 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5538.94 Median:5764.57 stddev:617.54 (10.7%) stddev-sans-first:592.86 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: Values: 3254.5 3296.1 3339.2 3387.4 3411.2 5268.5 5446.3 5458.3 5463.5 5485.5 5451.8 5489.8 5502.0 5506.3 5515.9 4909.1 4969.5 5011.5 5018.6 5029.4 4940.0 4999.8 5043.3 5044.1 5050.4 5021.0 5085.6 5095.7 5132.8 5179.4 5147.2 5170.6 5191.2 5202.7 5226.9 4952.3 4999.3 5103.2 5122.2 5173.2 5179.8 5265.2 5287.2 5294.2 5299.1 5884.8 5927.7 5935.3 5938.9 5939.9 5784.9 5860.9 5862.4 5942.9 5965.1 5616.6 5659.1 5675.9 5681.5 5681.7 6130.1 6144.1 6151.3 6152.7 6155.0 5615.7 5767.2 5838.4 5962.7 5971.8 6041.5 6047.9 6055.8 6060.5 6064.8 5971.1 6010.1 6014.0 6020.0 6022.0 5756.2 5805.7 5872.6 5965.4 5971.6 4585.8 4589.1 4589.4 4598.6 4616.8 4105.5 4111.8 4117.1 4122.5 4134.7 5479.0 5618.5 5652.4 5714.5 5751.7 5990.3 6083.3 6094.5 6096.9 6100.7 5509.0 5711.0 5764.6 5777.4 5780.0 5123.5 5165.7 5251.2 5253.9 5287.4 6168.9 6174.0 6180.1 6183.3 6213.8 5742.2 5854.1 6031.0 6041.8 6046.9 6106.8 6203.9 6209.3 6213.5 6218.8 5849.2 5851.1 5855.2 5855.5 5858.9 5831.9 5900.2 5918.3 5939.3 5970.1 5877.7 5887.4 5889.9 5895.4 5901.3 5836.6 5881.5 5885.1 5892.1 5899.1 5502.1 5598.9 5637.0 5805.8 5809.7 5875.1 5890.6 5924.9 5925.1 5934.2 5672.8 5719.7 5720.1 5728.1 5793.5 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,328 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48822.45 Median:342188.50 stddev:77425.61 (22.6%) stddev-sans-first:77558.11 10:08:42 INFO - 2016-02-09 10:08:42,329 DEBUG : BROWSER_OUTPUT: Values: 588.6 627.2 636.7 639.6 701.1 32891.3 34093.0 41980.4 42584.1 42614.0 47049.5 47506.3 47559.8 47622.5 47796.0 8025.3 9071.2 9229.9 9236.5 9242.6 7985.8 8044.4 10902.4 11147.5 11217.3 10802.6 10981.7 10989.9 10998.5 11002.2 10777.1 10869.6 10879.1 10894.1 10909.2 10662.7 10758.1 10769.9 10789.8 10799.0 43570.8 43769.0 43905.6 43968.6 43992.3 3495.8 3504.0 3605.0 3733.8 3781.3 32887.2 32940.2 33190.0 33191.5 33233.0 4122.6 4271.5 4273.6 4302.4 4329.4 292472.0 294664.0 295342.0 299941.0 301198.0 60159.7 61286.4 67222.7 67664.3 67739.0 74146.6 76083.6 76757.6 76813.9 76868.2 16844.7 17211.5 17245.1 17248.6 17255.7 12637.4 12672.5 12673.2 12677.0 12678.7 22625.2 22875.8 22961.4 22977.7 23013.4 8588.0 8736.9 8773.2 8848.6 8936.3 1018.7 1036.9 1140.8 1176.9 1236.3 29692.3 29852.3 30655.2 30765.8 31167.4 1132.3 1133.4 1204.6 1213.0 1216.1 13991.9 15907.5 15988.0 16108.4 16665.3 240990.0 243468.0 244293.0 244613.0 244718.0 60623.4 60965.0 61083.7 61309.7 61434.9 1266.6 1481.7 1489.1 1492.7 1502.6 30985.8 30991.7 31268.7 31523.2 32094.4 51163.7 51863.0 51882.0 51908.2 52016.0 337714.0 341424.0 342166.0 342211.0 342698.0 29815.7 30204.1 34058.5 34379.5 36141.3 39697.8 39918.6 39963.2 40941.2 40986.0 37755.2 37870.0 37939.2 45703.5 46660.5 39242.6 39300.0 39603.0 39644.6 40068.8 38869.2 39725.8 39727.4 39763.6 40046.8 34615.5 35065.5 35478.0 35624.5 35723.0 27261.5 27317.3 27378.5 27382.2 27441.2 10:08:42 INFO - 2016-02-09 10:08:42,329 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,329 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30724.49 Median:10362.76 stddev:95827.02 (924.7%) stddev-sans-first:96068.74 10:08:42 INFO - 2016-02-09 10:08:42,330 DEBUG : BROWSER_OUTPUT: Values: 374.3 378.1 381.1 383.0 383.3 15250.8 16757.3 17080.8 18454.3 18529.5 18129.0 18372.4 18559.0 18780.4 18837.4 4305.9 5551.0 5679.1 5679.2 5679.6 4394.0 6074.5 6189.7 6210.9 6230.2 5298.6 5453.0 6122.9 6154.8 6159.7 5377.9 5432.7 5433.0 5443.5 5479.2 5488.3 5509.7 5511.3 5512.5 5515.2 13416.6 13651.0 16293.8 20989.9 21473.4 2146.1 2210.1 2239.0 2247.6 2252.7 7159.7 7206.3 7410.4 12350.3 12964.4 1831.9 1832.2 1875.8 1938.0 2003.4 62359.0 65664.3 65704.0 65724.7 66016.0 10872.8 10931.9 10935.6 10960.3 10960.9 14251.4 14254.1 14318.1 14352.4 14356.4 8184.8 8186.3 8207.6 8215.3 8263.5 8024.0 8039.5 8066.2 8101.2 8116.5 4319.7 4415.4 4593.2 4645.1 4693.7 1792.3 1820.4 1888.1 1890.5 1902.2 966.4 993.1 1011.6 1081.6 1128.1 17523.5 17692.3 17884.2 18017.7 18230.9 1015.0 1020.5 1032.9 1067.5 1070.3 10038.8 10375.6 10401.2 10405.3 10483.8 534185.0 541155.0 604514.0 619257.0 623859.0 88913.0 91061.0 91833.5 91888.5 95434.0 1204.4 1217.3 1230.6 1238.5 1242.8 15613.8 15701.1 15727.9 16176.4 16195.7 33640.3 34287.3 34303.3 34567.7 35347.0 40886.8 41847.4 42114.6 43434.1 44912.3 9929.4 10196.0 10269.1 10297.6 10314.7 11901.0 12954.9 18259.9 18487.0 18925.1 15112.1 15308.1 15310.5 15427.1 15811.1 15181.1 15378.4 15497.7 15939.1 16010.7 15908.8 15922.8 16250.3 16255.5 16255.7 10137.7 10166.4 10299.3 10414.8 10427.3 11085.1 11142.5 14903.9 15593.8 15646.1 10:08:42 INFO - 2016-02-09 10:08:42,330 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,330 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5619.46 Median:6761.11 stddev:2929.20 (43.3%) stddev-sans-first:2921.77 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: Values: 1591.4 1617.9 1644.2 1822.6 1914.3 7657.6 8052.7 8062.8 8066.9 8068.4 6890.9 7097.1 7590.6 7737.7 7906.0 2304.8 2318.1 2337.8 2339.1 2344.3 2090.2 2382.2 2411.7 2435.3 2439.0 2063.6 2263.2 2338.3 2340.2 2351.4 2269.5 2296.5 2297.6 2316.0 2317.6 2396.3 2403.4 2423.2 2431.2 2439.1 8007.4 8040.2 8073.8 8076.6 8088.1 4887.1 4959.0 4971.9 4972.1 4972.7 3079.8 3090.7 3091.7 3137.8 3152.8 1064.9 1065.6 1102.6 1104.9 1111.0 11240.3 11244.3 11245.7 11262.8 11269.5 4360.9 4461.5 4465.8 4468.5 4474.1 8886.6 8935.6 8945.6 8953.1 8961.6 4900.2 4925.7 4943.4 4944.7 4955.0 4502.7 4545.6 4548.6 4549.9 4555.1 3490.4 3528.6 3531.0 3543.9 3549.6 993.2 1034.9 1060.4 1079.2 1107.0 1109.9 1156.1 1159.3 1322.9 1444.6 7700.6 7730.5 7808.8 7822.1 7822.7 669.4 670.1 677.1 688.0 810.9 6101.3 6190.9 6196.9 6202.0 6203.0 9228.7 9531.7 9691.4 9836.5 9851.3 9708.3 9723.4 9726.2 9748.0 9759.3 7386.8 7515.7 7538.9 7551.6 7555.3 7467.2 7496.1 7512.0 7514.1 7515.8 8434.5 8462.1 8490.3 8612.8 8650.7 8642.7 8662.3 8743.6 8829.1 8839.9 7283.9 7310.3 7365.6 7369.2 7380.1 7882.4 7961.1 7978.0 8001.5 8013.2 6444.3 7480.5 7499.9 7517.5 7551.4 5927.3 7042.1 7214.5 7251.7 7302.9 6890.4 6892.6 6902.8 6906.6 6930.1 6757.3 6816.1 6821.5 6828.9 6860.1 6722.3 6729.2 6764.9 6789.5 6813.2 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5507.48 Median:6299.20 stddev:1654.20 (26.3%) stddev-sans-first:1612.92 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: Values: 351.0 353.4 356.4 368.1 374.4 6142.1 6158.4 6233.7 6247.7 6253.9 5868.3 5933.8 6061.6 6148.0 6153.7 4789.9 4792.1 4796.7 4799.7 4823.7 4541.2 4802.4 4807.7 4810.5 4821.9 4585.7 4597.4 4722.8 4732.3 4744.6 4703.0 4711.8 4720.1 4721.7 4753.8 4177.0 4182.6 4183.7 4184.6 4193.2 5720.2 5817.4 5821.9 5826.0 5826.1 5543.6 5546.1 5547.3 5550.1 5552.5 6485.6 6488.9 6492.5 6494.5 6495.3 4648.7 4653.4 4655.7 4667.8 4692.1 6590.3 6745.9 6788.1 6800.2 6806.8 4636.2 4660.1 4662.6 4663.2 4664.6 4723.3 4724.2 4724.3 4725.8 4728.7 5344.6 5458.0 5458.6 5459.2 5461.2 6546.3 6558.8 6558.8 6560.8 6568.8 1659.2 1690.3 1691.2 1693.9 1693.9 1101.5 1115.8 1121.5 1124.3 1167.8 6315.6 6330.1 6334.1 6338.0 6341.8 6575.3 6740.5 6780.1 6788.4 6793.5 6282.8 6341.1 6458.0 6464.8 6469.5 3633.7 3682.9 3683.7 3684.7 3690.1 6935.8 7066.9 7073.1 7077.6 7078.1 7017.1 7020.8 7031.6 7035.1 7038.4 7096.0 7100.0 7104.4 7109.3 7112.3 6662.5 6836.1 6848.3 6853.7 6863.7 6748.6 6752.1 6754.0 6754.1 6756.1 7059.9 7062.9 7078.8 7081.7 7085.0 4532.4 4622.7 4689.1 4721.4 4726.6 6766.3 6771.7 6775.0 6779.5 6780.4 6601.2 6602.8 6607.9 6611.3 6621.1 6448.7 6575.3 6577.0 6598.3 6603.4 6480.6 6483.6 6490.4 6490.6 6491.6 6617.3 6621.0 6622.4 6623.3 6624.0 6317.1 6354.9 6454.0 6456.5 6475.5 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13635.81 Median:48525.26 stddev:16241.14 (33.5%) stddev-sans-first:16258.26 10:08:42 INFO - 2016-02-09 10:08:42,331 DEBUG : BROWSER_OUTPUT: Values: 835.8 891.2 901.1 920.4 949.7 11499.1 11672.6 11789.9 11791.2 11792.9 10973.8 11343.6 11377.1 11395.5 11404.8 730.0 742.0 890.4 903.8 905.6 897.1 900.8 903.1 904.1 904.4 783.3 946.0 947.3 947.8 948.7 785.5 936.0 938.6 943.6 944.4 703.6 703.8 704.0 705.3 707.7 11278.9 11413.9 11414.7 11432.9 11457.5 10767.8 11221.4 11504.3 11591.4 11862.0 9550.9 9690.4 9712.4 9853.7 9915.1 3480.7 3531.7 3532.8 3534.5 3541.9 47310.3 47634.5 48156.0 48713.5 49044.0 8659.4 8742.1 8752.1 8764.0 8767.5 18453.7 18478.7 18501.3 18504.2 18520.4 7037.1 7071.8 7088.5 7171.4 7196.5 4231.0 4327.0 4343.1 4348.9 4350.6 2995.9 3005.3 3024.2 3034.2 3037.4 553.4 559.9 560.2 562.0 575.2 686.9 706.4 708.0 719.3 767.1 7890.2 8136.6 8247.3 8338.9 8352.5 569.4 621.6 663.9 700.0 702.7 3759.4 3871.4 4205.9 4220.5 4235.6 59152.4 59206.7 59922.4 60420.0 60637.4 49693.0 51282.7 51453.5 51633.0 52021.9 46496.3 47719.5 48061.5 48062.8 48337.0 8001.6 8149.2 8468.8 8502.0 8566.2 34745.7 35388.0 35964.1 36043.4 36607.8 41713.8 42554.8 43746.8 45696.5 46120.3 10863.1 10959.0 11059.3 11154.4 11292.8 12412.9 12417.0 12705.3 12894.7 12957.8 10807.4 10860.3 11040.1 11146.6 11162.5 11009.6 11153.5 11156.2 11252.8 11327.7 9863.9 10027.5 10264.7 10405.4 10409.5 9743.4 10083.3 10241.8 10436.2 10573.2 9281.8 9399.3 9408.7 9482.0 9489.6 10:08:42 INFO - 2016-02-09 10:08:42,332 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:08:42 INFO - 2016-02-09 10:08:42,332 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-09 10:08:42,890 INFO : Browser exited with error code: 0 10:08:42 INFO - 2016-02-09 10:08:42,908 INFO : Completed test dromaeo_css (00:18:29) 10:08:42 INFO - 2016-02-09 10:08:42,908 INFO : Starting test kraken 10:08:42 INFO - 2016-02-09 10:08:42,908 DEBUG : operating with platform_type : linux_ 10:08:42 INFO - 2016-02-09 10:08:42,909 INFO : Initialising browser for kraken test... 10:08:42 INFO - 2016-02-09 10:08:42,915 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgjkX2J/profile http://localhost:58472/getInfo.html 10:08:46 INFO - 2016-02-09 10:08:46,811 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:08:46 INFO - 2016-02-09 10:08:46,811 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:08:46 INFO - 2016-02-09 10:08:46,811 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:08:46 INFO - 2016-02-09 10:08:46,812 DEBUG : BROWSER_OUTPUT: __metrics 10:08:46 INFO - 2016-02-09 10:08:46,954 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] 10:08:47 INFO - 2016-02-09 10:08:47,750 INFO : Browser initialized. 10:08:47 INFO - 2016-02-09 10:08:47,750 INFO : Running cycle 1/1 for kraken test... 10:08:47 INFO - 2016-02-09 10:08:47,750 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgjkX2J/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:08:59 INFO - 2016-02-09 10:08:59,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 133926912 10:08:59 INFO - 2016-02-09 10:08:59,471 DEBUG : BROWSER_OUTPUT: 10:09:01 INFO - 2016-02-09 10:09:01,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58472/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:02 INFO - 2016-02-09 10:09:02,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 164597760 10:09:02 INFO - 2016-02-09 10:09:02,467 DEBUG : BROWSER_OUTPUT: 10:09:05 INFO - 2016-02-09 10:09:05,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58472/tests/kraken/driver.html?testName=audio-dft) 10:09:05 INFO - 2016-02-09 10:09:05,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 160079872 10:09:05 INFO - 2016-02-09 10:09:05,618 DEBUG : BROWSER_OUTPUT: 10:09:08 INFO - 2016-02-09 10:09:08,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58472/tests/kraken/driver.html?testName=audio-fft) 10:09:08 INFO - 2016-02-09 10:09:08,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 158617600 10:09:08 INFO - 2016-02-09 10:09:08,994 DEBUG : BROWSER_OUTPUT: 10:09:10 INFO - 2016-02-09 10:09:10,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58472/tests/kraken/driver.html?testName=audio-oscillator) 10:09:11 INFO - 2016-02-09 10:09:11,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 159490048 10:09:11 INFO - 2016-02-09 10:09:11,514 DEBUG : BROWSER_OUTPUT: 10:09:13 INFO - 2016-02-09 10:09:13,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58472/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:14 INFO - 2016-02-09 10:09:14,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 158351360 10:09:14 INFO - 2016-02-09 10:09:14,243 DEBUG : BROWSER_OUTPUT: 10:09:17 INFO - 2016-02-09 10:09:17,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58472/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:17 INFO - 2016-02-09 10:09:17,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 158441472 10:09:17 INFO - 2016-02-09 10:09:17,687 DEBUG : BROWSER_OUTPUT: 10:09:21 INFO - 2016-02-09 10:09:21,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58472/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:21 INFO - 2016-02-09 10:09:21,568 DEBUG : BROWSER_OUTPUT: RSS: Main: 159125504 10:09:21 INFO - 2016-02-09 10:09:21,568 DEBUG : BROWSER_OUTPUT: 10:09:24 INFO - 2016-02-09 10:09:24,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58472/tests/kraken/driver.html?testName=json-parse-financial) 10:09:24 INFO - 2016-02-09 10:09:24,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 158216192 10:09:24 INFO - 2016-02-09 10:09:24,934 DEBUG : BROWSER_OUTPUT: 10:09:26 INFO - 2016-02-09 10:09:26,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58472/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:27 INFO - 2016-02-09 10:09:27,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 163475456 10:09:27 INFO - 2016-02-09 10:09:27,052 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2016-02-09 10:09:28,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:29 INFO - 2016-02-09 10:09:29,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 161251328 10:09:29 INFO - 2016-02-09 10:09:29,405 DEBUG : BROWSER_OUTPUT: 10:09:31 INFO - 2016-02-09 10:09:31,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:31 INFO - 2016-02-09 10:09:31,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 165838848 10:09:31 INFO - 2016-02-09 10:09:31,943 DEBUG : BROWSER_OUTPUT: 10:09:34 INFO - 2016-02-09 10:09:34,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:34 INFO - 2016-02-09 10:09:34,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 170291200 10:09:34 INFO - 2016-02-09 10:09:34,855 DEBUG : BROWSER_OUTPUT: 10:09:37 INFO - 2016-02-09 10:09:37,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:37 INFO - 2016-02-09 10:09:37,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 168427520 10:09:37 INFO - 2016-02-09 10:09:37,906 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58472/tests/kraken/driver.html?testName=ai-astar) 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 225755136 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;104;110;110;109;100;108;107;110 10:09:39 INFO - 2016-02-09 10:09:39,819 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;122;162;158;121;146;151;130;169;122 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;162;161;163;163;161;163;159;171;159 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;149;71;70;71;71;148;71 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;149;92;93;92;140;91;93;136 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;108;110;110;110 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;145;146;145;145;145;146;146 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;97;95;96;95;95 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;57;57;57;57;57;57;58;55;54 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;65;64;64;65;66;65;64;64;64 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;76;78;77;78;78;85;86;79 10:09:39 INFO - 2016-02-09 10:09:39,820 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;113;112;117;112;113;121;117;117;120 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;136;147;142;141;132;143;140;141;141 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;63;64;62;62;64;65;65;65;64 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,876 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: __startTimestamp1455041379813__endTimestamp 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,821 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:109.00 stddev:3.24 (3.0%) stddev-sans-first:3.40 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 104.0 110.0 110.0 109.0 100.0 108.0 107.0 110.0 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:148.50 stddev:17.85 (12.0%) stddev-sans-first:18.93 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 144.0 122.0 162.0 158.0 121.0 146.0 151.0 130.0 169.0 122.0 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.57 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 165.0 162.0 161.0 163.0 163.0 161.0 163.0 159.0 171.0 159.0 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.00 Median:71.00 stddev:32.43 (45.7%) stddev-sans-first:34.00 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 149.0 71.0 70.0 71.0 71.0 148.0 71.0 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:92.50 stddev:24.00 (25.9%) stddev-sans-first:24.90 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 149.0 92.0 93.0 92.0 140.0 91.0 93.0 136.0 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,822 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 10:09:39 INFO - 2016-02-09 10:09:39,822 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 108.0 110.0 110.0 110.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 95.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.24 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: Values: 55.0 57.0 57.0 57.0 57.0 57.0 57.0 58.0 55.0 54.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 64.0 64.0 65.0 66.0 65.0 64.0 64.0 64.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:78.00 stddev:3.56 (4.6%) stddev-sans-first:3.70 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 76.0 78.0 77.0 78.0 78.0 85.0 86.0 79.0 10:09:39 INFO - 2016-02-09 10:09:39,823 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:117.00 stddev:3.30 (2.8%) stddev-sans-first:3.42 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: Values: 118.0 113.0 112.0 117.0 112.0 113.0 121.0 117.0 117.0 120.0 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.60 Median:141.00 stddev:4.62 (3.3%) stddev-sans-first:4.24 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: Values: 133.0 136.0 147.0 142.0 141.0 132.0 143.0 140.0 141.0 141.0 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:3.73 (5.8%) stddev-sans-first:1.20 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: Values: 75.0 63.0 64.0 62.0 62.0 64.0 65.0 65.0 65.0 64.0 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:09:39 INFO - 2016-02-09 10:09:39,824 DEBUG : BROWSER_OUTPUT: 10:09:40 INFO - 2016-02-09 10:09:40,410 INFO : Browser exited with error code: 0 10:09:40 INFO - 2016-02-09 10:09:40,459 INFO : Completed test kraken (00:00:57) 10:09:40 INFO - 2016-02-09 10:09:40,459 INFO : Starting test v8_7 10:09:40 INFO - 2016-02-09 10:09:40,459 DEBUG : operating with platform_type : linux_ 10:09:40 INFO - 2016-02-09 10:09:40,459 INFO : Initialising browser for v8_7 test... 10:09:40 INFO - 2016-02-09 10:09:40,466 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNnXwK0/profile http://localhost:58472/getInfo.html 10:09:44 INFO - 2016-02-09 10:09:44,287 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:09:44 INFO - 2016-02-09 10:09:44,287 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:09:44 INFO - 2016-02-09 10:09:44,287 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:09:44 INFO - 2016-02-09 10:09:44,287 DEBUG : BROWSER_OUTPUT: __metrics 10:09:44 INFO - 2016-02-09 10:09:44,489 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] 10:09:45 INFO - 2016-02-09 10:09:45,314 INFO : Browser initialized. 10:09:45 INFO - 2016-02-09 10:09:45,314 INFO : Running cycle 1/1 for v8_7 test... 10:09:45 INFO - 2016-02-09 10:09:45,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNnXwK0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:09:56 INFO - 2016-02-09 10:09:56,948 DEBUG : BROWSER_OUTPUT: RSS: Main: 134119424 10:09:56 INFO - 2016-02-09 10:09:56,949 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58472/tests/v8_7/run.html (next: http://localhost:58472/tests/v8_7/run.html) 10:10:18 INFO - 2016-02-09 10:10:18,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 421916672 10:10:18 INFO - 2016-02-09 10:10:18,539 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,539 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:10:18 INFO - 2016-02-09 10:10:18,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:10:18 INFO - 2016-02-09 10:10:18,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |0;Richards;168.9189189189189 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.0437365901964 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |5;Earley;539.3743257820928 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |6;Boyer;10531.25 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |7;RegExp;24119.04761904762 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |8;Splay;517.3305742369374 10:10:18 INFO - 2016-02-09 10:10:18,541 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:10:18 INFO - 2016-02-09 10:10:18,542 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:10:18 INFO - 2016-02-09 10:10:18,542 DEBUG : BROWSER_OUTPUT: __startTimestamp1455041418539__endTimestamp 10:10:18 INFO - 2016-02-09 10:10:18,542 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,542 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:10:18 INFO - 2016-02-09 10:10:18,542 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.92 Median:168.92 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: Values: 168.9 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.04 Median:165.04 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,543 DEBUG : BROWSER_OUTPUT: Values: 165.0 10:10:18 INFO - 2016-02-09 10:10:18,544 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,544 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,544 DEBUG : BROWSER_OUTPUT: Values: 278.8 10:10:18 INFO - 2016-02-09 10:10:18,544 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,544 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,545 DEBUG : BROWSER_OUTPUT: Values: 5202.1 10:10:18 INFO - 2016-02-09 10:10:18,545 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,545 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,545 DEBUG : BROWSER_OUTPUT: Values: 950.6 10:10:18 INFO - 2016-02-09 10:10:18,545 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,546 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.37 Median:539.37 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,546 DEBUG : BROWSER_OUTPUT: Values: 539.4 10:10:18 INFO - 2016-02-09 10:10:18,546 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,547 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10531.25 Median:10531.25 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,547 DEBUG : BROWSER_OUTPUT: Values: 10531.3 10:10:18 INFO - 2016-02-09 10:10:18,547 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,547 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24119.05 Median:24119.05 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: Values: 24119.0 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.33 Median:517.33 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: Values: 517.3 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:10:18 INFO - 2016-02-09 10:10:18,548 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:10:18 INFO - 2016-02-09 10:10:18,549 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:10:18 INFO - 2016-02-09 10:10:18,549 DEBUG : BROWSER_OUTPUT: 10:10:19 INFO - 2016-02-09 10:10:19,190 INFO : Browser exited with error code: 0 10:10:19 INFO - 2016-02-09 10:10:19,204 INFO : Completed test v8_7 (00:00:38) 10:10:19 INFO - 2016-02-09 10:10:19,597 INFO : Completed test suite (00:20:06) 10:10:19 INFO - 2016-02-09 10:10:19,598 DEBUG : Working with test: dromaeo_css 10:10:19 INFO - 2016-02-09 10:10:19,598 DEBUG : Generating results file: dromaeo_css 10:10:19 INFO - 2016-02-09 10:10:19,600 DEBUG : Working with test: kraken 10:10:19 INFO - 2016-02-09 10:10:19,600 DEBUG : Generating results file: kraken 10:10:19 INFO - 2016-02-09 10:10:19,600 INFO : javascript benchmark 10:10:19 INFO - 2016-02-09 10:10:19,600 DEBUG : Working with test: v8_7 10:10:19 INFO - 2016-02-09 10:10:19,601 DEBUG : Generating results file: v8_7 10:10:19 INFO - 2016-02-09 10:10:19,601 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:19 INFO - 2016-02-09 10:10:19,656 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:10:19 INFO - 2016-02-09 10:10:19,657 DEBUG : process_Request line: dromaeo_css 7270.05 graph.html#tests=[[72,53,35]] 10:10:19 INFO - 2016-02-09 10:10:19,657 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:19 INFO - 2016-02-09 10:10:19,692 DEBUG : process_Request line: kraken 1478.40 graph.html#tests=[[232,53,35]] 10:10:19 INFO - 2016-02-09 10:10:19,692 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:10:19 INFO - 2016-02-09 10:10:19,721 DEBUG : process_Request line: v8_7 23306.22 graph.html#tests=[[230,53,35]] 10:10:19 INFO - 2016-02-09 10:10:19,722 INFO : javascript benchmark 10:10:19 INFO - 2016-02-09 10:10:19,726 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3254.463013602755, 3296.126526470487, 3339.215284408165, 3387.4072037393466, 3411.215420453296, 5268.47315268473, 5446.319210098738, 5458.263134476844, 5463.48096930792, 5485.4788795064505, 5451.809186678467, 5489.780408783644, 5501.972490137544, 5506.256655351526, 5515.889682206353, 4909.091818013661, 4969.527894849993, 5011.523905229015, 5018.573421259197, 5029.4216165141115, 4939.950600494003, 4999.825006124786, 5043.268726034723, 5044.092063428581, 5050.393952725678, 5021.046001259749, 5085.593152547805, 5095.745212739367, 5132.820351287705, 5179.378474583055, 5147.1764517677175, 5170.638055336147, 5191.2472691459525, 5202.707766092988, 5226.895462090775, 4952.306677065214, 4999.3000979862845, 5103.209002604603, 5122.154844450662, 5173.249878767558, 5179.792808287664, 5265.183896496049, 5287.233351164098, 5294.152935530296, 5299.099153143936, 5884.7940322088525, 5927.73325200367, 5935.317438494585, 5938.851528711773, 5939.940600594025, 5784.8843023139725, 5860.912086318709, 5862.413758624103, 5942.910856337158, 5965.135055416984, 5616.634918730269, 5659.094544872842, 5675.9432405675825, 5681.460261275172, 5681.659100453986, 6130.080487926757, 6144.078388241799, 6151.2618485781095, 6152.723127459275, 6155.0, 5615.719214039282, 5767.192593036978, 5838.416158384128, 5962.672053037125, 5971.820845374646, 6041.546883983631, 6047.879042419127, 6055.848603784941, 6060.454559089703, 6064.848378790565, 5971.134185543159, 6010.068439391814, 6013.9699301503215, 6020.0, 6022.0, 5756.1653560233535, 5805.7387417566315, 5872.559558033079, 5965.403459654, 5971.58198926071, 4585.839495617637, 4589.128065667513, 4589.35748995141, 4598.586127248564, 4616.815327386867, 4105.527864295645, 4111.814968326433, 4117.07365842689, 4122.546519882811, 4134.669226461876, 5479.0, 5618.494335509824, 5652.406497317805, 5714.514266287412, 5751.654900705971, 5990.311114221833, 6083.330833608299, 6094.542909281821, 6096.939030609726, 6100.694965251809, 5508.9724551376985, 5711.0, 5764.5676574257095, 5777.3933736957015, 5780.0, 5123.538881500683, 5165.690058596421, 5251.212318152231, 5253.947460525423, 5287.41838397776, 6168.938310616836, 6174.043023331391, 6180.103884936659, 6183.288921774054, 6213.751449941951, 5742.1673857289625, 5854.092615644582, 6030.969845150747, 6041.78853740117, 6046.939530604814, 6106.786262480792, 6203.906941395792, 6209.348018457997, 6213.5339849512375, 6218.81343559694, 5849.151872978479, 5851.122331650116, 5855.151003104611, 5855.473007429352, 5858.94141058584, 5831.94168058314, 5900.203472531153, 5918.2898052234, 5939.287285525592, 5970.104484327386, 5877.706114694333, 5887.352391236875, 5889.94110058894, 5895.351511333664, 5901.3213480450295, 5836.620619659709, 5881.500072493886, 5885.058390657474, 5892.057270836645, 5899.056151015817, 5502.0921547944145, 5598.888022239614, 5636.971815140898, 5805.767769289181, 5809.651420914759, 5875.14810352488, 5890.558208134321, 5924.911126333022, 5925.140854576149, 5934.19888315072, 5672.7730890763905, 5719.685417302088, 5720.141978703228, 5728.054870946247, 5793.536517078539], "unit": "ms", "name": "dojo.html", "value": 5498.941055330387}, {"lowerIsBetter": false, "replicates": [588.5850475414833, 627.2034516164471, 636.6689321552793, 639.6162302618433, 701.092085748955, 32891.342173156525, 34093.0, 41980.37029444561, 42584.14831703364, 42614.0, 47049.529504704944, 47506.28740568894, 47559.762201189034, 47622.523774762245, 47796.0, 8025.3178479829285, 9071.22894553962, 9229.907700923006, 9236.491992940419, 9242.6302947882, 7985.800354991114, 8044.356451483867, 10902.400367979759, 11147.498362573662, 11217.326960382363, 10802.621908233214, 10981.725456863562, 10989.890101098967, 10998.450077496092, 11002.229843910929, 10777.137828973664, 10869.619563315286, 10879.12966962641, 10894.128469722482, 10909.236353455182, 10662.680119596425, 10758.139348852073, 10769.946150269277, 10789.83815242772, 10799.0, 43570.78214608907, 43769.0, 43905.56094439047, 43968.56031439677, 43992.3401148983, 3495.790252584853, 3503.982480087583, 3605.0446631642635, 3733.757305775116, 3781.300459415017, 32887.17782055444, 32940.17649558756, 33190.0, 33191.502127468106, 33233.0, 4122.606352624771, 4271.487421509439, 4273.572642735733, 4302.41917341158, 4329.372241025065, 292472.0, 294664.0, 295342.0, 299941.0, 301198.0, 60159.69920150371, 61286.38713612807, 67222.66388668025, 67664.3233567658, 67739.0, 74146.6292668544, 76083.61958190173, 76757.61621191859, 76813.85489160965, 76868.23131768723, 16844.74732879008, 17211.483655490356, 17245.051522166403, 17248.568785780204, 17255.65488690219, 12637.431315590637, 12672.49310027607, 12673.17624354414, 12677.0, 12678.732126787432, 22625.2081177158, 22875.771242287363, 22961.425964351023, 22977.655335169984, 23013.42466438319, 8588.0, 8736.912630873738, 8773.166549177819, 8848.557572121368, 8936.28509719234, 1018.674024312213, 1036.8911264317137, 1140.845985791924, 1176.8528933883265, 1236.3262022197923, 29692.257693557833, 29852.253693657833, 30655.233619159255, 30765.846170769004, 31167.376652466824, 1132.314949455584, 1133.4049623947494, 1204.6085022367765, 1213.0053356247968, 1216.087934049463, 13991.86008139926, 15907.522774316789, 15988.0, 16108.436204732778, 16665.3333866644, 240990.0, 243468.0, 244293.0, 244613.0, 244718.0, 60623.393766061774, 60965.0, 61083.694581526805, 61309.693451532454, 61434.92825358714, 1266.6263452281598, 1481.703659268129, 1489.113977183574, 1492.6865358274883, 1502.6243439140214, 30985.845070774503, 30991.69008309888, 31268.68731312658, 31523.21191970219, 32094.358112837144, 51163.74418127885, 51863.0, 51882.0, 51908.22137667862, 52016.0, 337714.0, 341424.0, 342166.0, 342211.0, 342698.0, 29815.701842981292, 30204.09387718372, 34058.489122662686, 34379.484307735904, 36141.27717445584, 39697.80151099341, 39918.600813991485, 39963.2007359857, 40941.18117637571, 40986.0, 37755.24489510249, 37870.0, 37939.241215176095, 45703.54296457126, 46660.53339466562, 39242.607573923895, 39300.0, 39603.0, 39644.603553964094, 40068.79965600153, 38869.2226155481, 39725.80137099296, 39727.404088938114, 39763.60236397599, 40046.799766000986, 34615.480767788, 35065.474017890265, 35478.0, 35624.46563301604, 35723.0, 27261.454770904867, 27317.317067073483, 27378.452430951667, 27382.178534643994, 27441.17676469709], "unit": "ms", "name": "ext.html", "value": 20311.449565790845}, {"lowerIsBetter": false, "replicates": [374.2701731623335, 378.1057798307004, 381.14813392068737, 382.9885103446894, 383.26413286489935, 15250.84749152508, 16757.329706811728, 17080.82919170808, 18454.26182952682, 18529.536761580966, 18129.0, 18372.35696750614, 18559.0, 18780.436586902382, 18837.434876953677, 4305.892352691177, 5550.972245138769, 5679.119736440858, 5679.204911312419, 5679.5740319476, 4393.978030109845, 6074.514038876901, 6189.721462534197, 6210.875782484371, 6230.158928544633, 5298.629095963284, 5452.972735136339, 6122.938770612303, 6154.815355539318, 6159.722812473427, 5377.919331210035, 5432.728363581825, 5433.049216387136, 5443.5100840924115, 5479.150731636582, 5488.25908502355, 5509.724513774336, 5511.311086114236, 5512.476314750093, 5515.172724091419, 13416.597502074954, 13651.044426890121, 16293.83706162935, 20989.89505052465, 21473.355799326044, 2146.1093646136833, 2210.0938615167706, 2238.9664155037685, 2247.5617254635354, 2252.68462415262, 7159.74940877072, 7206.3154000370405, 7410.37011853993, 12350.320732359716, 12964.37945256843, 1831.8626103042325, 1832.239620557467, 1875.7749070111674, 1937.9631896935214, 2003.3589251439546, 62359.0, 65664.3433565663, 65704.0, 65724.67137664281, 66016.0, 10872.78254434907, 10931.906809319005, 10935.56257749697, 10960.342379457257, 10960.945195273973, 14251.429942802379, 14254.073485223427, 14318.14091154534, 14352.425902963765, 14356.425742970374, 8184.754457366289, 8186.345092392594, 8207.630656620466, 8215.260626543639, 8263.545504997162, 8023.9598802006785, 8039.5176289422825, 8066.153053929253, 8101.230383113595, 8116.513009219466, 4319.719218250803, 4415.359772832921, 4593.150267200579, 4645.117427688729, 4693.6949098308505, 1792.2920446423589, 1820.4083672806391, 1888.0822293740544, 1890.5368184794813, 1902.2105826082297, 966.4249771386014, 993.1310103659298, 1011.6054738651932, 1081.605214096849, 1128.0745975229925, 17523.474295771146, 17692.292308307522, 17884.195211215527, 18017.729734054, 18230.908845455688, 1014.9695509134738, 1020.505055048301, 1032.9018743219383, 1067.508945884886, 1070.314998401024, 10038.799224015478, 10375.636852710119, 10401.21990850674, 10405.271630985759, 10483.842742358871, 534185.0, 541155.0, 604514.0, 619257.0, 623859.0, 88913.0, 91061.0, 91833.54083229542, 91888.54055729679, 95434.0, 1204.4339160594507, 1217.3183017510223, 1230.6246594788674, 1238.4922181905376, 1242.7763002659608, 15613.76579351288, 15701.13643749559, 15727.921360393582, 16176.433824816075, 16195.676086477968, 33640.3271934555, 34287.31425371528, 34303.313933721685, 34567.654323456445, 35347.0, 40886.79556602317, 41847.37228941507, 42114.57885421107, 43434.13131737411, 44912.32631510465, 9929.404235745878, 10196.0, 10269.07578317925, 10297.639582614573, 10314.742131446774, 11901.047916166513, 12954.870451295743, 18259.908700456413, 18487.0, 18925.14836832318, 15112.09327440357, 15308.081515109128, 15310.464133755266, 15427.074375537504, 15811.13038782832, 15181.089134651957, 15378.38486460529, 15497.690046198788, 15939.123348215959, 16010.67978640444, 15908.840911591198, 15922.840771592137, 16250.349986000427, 16255.51233462998, 16255.674886501967, 10137.746556336151, 10166.390016599027, 10299.330543514647, 10414.791704166026, 10427.322224055411, 11085.057770089632, 11142.498587563741, 14903.85096149068, 15593.766093508833, 15646.061236325857], "unit": "ms", "name": "jquery.html", "value": 9290.23388280461}, {"lowerIsBetter": false, "replicates": [1591.3714082937238, 1617.932164771251, 1644.2189959769112, 1822.5534743987726, 1914.2630087416348, 7657.617119144042, 8052.718154864581, 8062.798430039252, 8066.878996815045, 8068.354531637462, 6890.896636550443, 7097.077379940613, 7590.58251796151, 7737.690492380298, 7906.0, 2304.7695230476943, 2318.084356679111, 2337.7662233776655, 2339.099446713019, 2344.296710986706, 2090.195274819198, 2382.249591378719, 2411.7105947286263, 2435.2937648082034, 2438.9634155487684, 2063.5769667218183, 2263.151318255654, 2338.333574931145, 2340.20433052762, 2351.400392899808, 2269.5120549081944, 2296.47181148336, 2297.563462942044, 2315.9652605210936, 2317.6060069788177, 2396.2930935373934, 2403.375122468153, 2423.1761201191503, 2431.222008957134, 2439.1097249503982, 8007.439479236456, 8040.2361775631225, 8073.798155046112, 8076.636551355203, 8088.069871964741, 4887.095887260868, 4959.032988567231, 4971.90056198874, 4972.129877271499, 4972.726500042532, 3079.799813012147, 3090.7063828936216, 3091.6753740857334, 3137.8117312961067, 3152.763542734281, 1064.909482693972, 1065.6376831877121, 1102.6471529110688, 1104.8508451359044, 1110.9833352499718, 11240.269382490113, 11244.325340479598, 11245.662630121109, 11262.831057534144, 11269.549218031269, 4360.869173924787, 4461.5092339842595, 4465.776711164429, 4468.530804265505, 4474.105178964221, 8886.644534218689, 8935.642574297086, 8945.552722363856, 8953.149450802164, 8961.641534338683, 4900.215965445512, 4925.655204135748, 4943.431505376856, 4944.728039957837, 4954.9752251238515, 4502.662300327423, 4545.590896819236, 4548.56788605082, 4549.909001819945, 4555.134524440412, 3490.441529355291, 3528.647135286451, 3530.993666804948, 3543.9291214175573, 3549.5563054618174, 993.1806259835664, 1034.8706411698538, 1060.4326685223368, 1079.1528650009705, 1106.9723256918642, 1109.9389533575732, 1156.1213477756964, 1159.2696601141395, 1322.9140105893086, 1444.5594093801492, 7700.614969251515, 7730.458867879307, 7808.843823123506, 7822.06135263772, 7822.687092516349, 669.3607604737464, 670.0686046395514, 677.075791544548, 687.9690413931385, 810.8580998325269, 6101.328853826164, 6190.938090619126, 6196.938030619726, 6201.96899015502, 6202.968985155046, 9228.676996305232, 9531.714048578553, 9691.418514889128, 9836.508174591385, 9851.261155413229, 9708.271879609058, 9723.416595004323, 9726.17327527154, 9747.951260243653, 9759.26805489591, 7386.778396648109, 7515.699372025167, 7538.886916696254, 7551.584662843707, 7555.320021198118, 7467.178610352966, 7496.100467943882, 7511.9624401877645, 7514.0607424071995, 7515.774526764206, 8434.536100514286, 8462.111478294937, 8490.27832634233, 8612.78468038279, 8650.697225597074, 8642.740717778477, 8662.341489239578, 8743.606537705691, 8829.117088291376, 8839.867401989104, 7283.8543229136185, 7310.305520975498, 7365.558066516026, 7369.226231245856, 7380.077490313711, 7882.369410447265, 7961.124276329483, 7978.002749656293, 8001.479903806234, 8013.2387423194705, 6444.258910225384, 7480.476366654282, 7499.925000749922, 7517.511361761468, 7551.433642476726, 5927.288725352985, 7042.119735033121, 7214.458915581247, 7251.746188883575, 7302.890456643261, 6890.44876409896, 6892.620905850226, 6902.758403455855, 6906.585604863724, 6930.099087118642, 6757.3242675732035, 6816.113905192294, 6821.488388370793, 6828.9317106830285, 6860.142482189726, 6722.327767223434, 6729.158855143107, 6764.898526522008, 6789.490788190807, 6813.182418109858], "unit": "ms", "name": "mootools.html", "value": 4566.451577992485}, {"lowerIsBetter": false, "replicates": [350.998245008775, 353.35159981434066, 356.37634140254556, 368.0999955109754, 374.37853163748184, 6142.078688196772, 6158.353372895843, 6233.657148856811, 6247.656753797933, 6253.906191407133, 5868.2664666916635, 5933.762649494015, 6061.575689701712, 6148.047052706826, 6153.661548614825, 4789.904201915968, 4792.065547218293, 4796.688215266014, 4799.688020278671, 4823.686460380081, 4541.159885421192, 4802.4237091548885, 4807.687500312486, 4810.542998415145, 4821.855344339676, 4585.679002469828, 4597.356370108188, 4722.763861806913, 4732.290156476522, 4744.620430365562, 4702.988857395642, 4711.7879695413785, 4720.103180395731, 4721.74030428328, 4753.786079626425, 4176.958230417687, 4182.602652747984, 4183.686223533247, 4184.644305234059, 4193.22425351311, 5720.170575266605, 5817.360090390053, 5821.941780582225, 5826.038703613898, 5826.067829147316, 5543.584231182637, 5546.140348246028, 5547.3343198816, 5550.139728342114, 5552.500274975231, 6485.610863348167, 6488.935110648928, 6492.480601551864, 6494.5453818232745, 6495.253045899734, 4648.721076735406, 4653.395058642355, 4655.6964050066035, 4667.789949452283, 4692.10849938514, 6590.275069742324, 6745.932540674579, 6788.083608712859, 6800.217974932896, 6806.829829254309, 4636.188666983265, 4660.13787449323, 4662.6269898408045, 4663.207254766698, 4664.55686709762, 4723.267893476516, 4724.244120940633, 4724.29925226918, 4725.787339569728, 4728.692634978785, 5344.625876188629, 5457.972710136424, 5458.645188062763, 5459.153831156177, 5461.1808228766, 6546.279909209983, 6558.770443034471, 6558.770443034567, 6560.803175904731, 6568.770093046721, 1659.236751094486, 1690.2985261116744, 1691.1544227886056, 1693.8729595280404, 1693.9243580326336, 1101.5208384352832, 1115.8214685650257, 1121.52895783771, 1124.3310230412892, 1167.7781221567875, 6315.589486683442, 6330.0821380899515, 6334.081558174131, 6338.049292606053, 6341.778037768656, 6575.276719560845, 6740.494462915301, 6780.118584583973, 6788.355106264897, 6793.524453288322, 6282.811515654537, 6341.143945567289, 6458.031295305648, 6464.806055818333, 6469.51478639104, 3633.7274704397278, 3682.8526858925343, 3683.686886614614, 3684.6868016218923, 3690.132818787583, 6935.791926242221, 7066.929330706627, 7073.115860517435, 7077.6461176941975, 7078.115235595551, 7017.122859642544, 7020.7542736004, 7031.6484175791, 7035.085438892911, 7038.40173585251, 7096.042034325404, 7100.0, 7104.43164546835, 7109.324614161646, 7112.28877112295, 6662.467002639874, 6836.111305530449, 6848.315168483112, 6853.691583878638, 6863.691133899087, 6748.561343512656, 6752.054712340375, 6753.966230168818, 6754.0881980931945, 6756.087928129836, 7059.894101588377, 7062.8940565890525, 7078.787636370917, 7081.716731330689, 7084.964575177091, 4532.4334458192725, 4622.6764126510825, 4689.132510485571, 4721.386219791405, 4726.645501587326, 6766.323367663194, 6771.729130834711, 6775.0, 6779.457643388616, 6780.38976492118, 6601.240857301472, 6602.801915942529, 6607.867842643216, 6611.305812889577, 6621.073049772939, 6448.709808058742, 6575.342465753386, 6577.046328282277, 6598.307177746267, 6603.405693487609, 6480.611163330215, 6483.578567393104, 6490.448311893542, 6490.578112422678, 6491.642959637265, 6617.338266173344, 6621.0068489725, 6622.403983641495, 6623.3376662333385, 6623.966880165568, 6317.052442133717, 6354.936450635434, 6453.967730161319, 6456.54804163704, 6475.481961443167], "unit": "ms", "name": "prototype.html", "value": 4974.660202198137}, {"lowerIsBetter": false, "replicates": [835.7618078847528, 891.157855826244, 901.1484147480634, 920.3695468604003, 949.7483166960754, 11499.080073594114, 11672.591459298927, 11789.882101178986, 11791.233569817978, 11792.941035294822, 10973.83539246912, 11343.602973895915, 11377.146713996442, 11395.487203075862, 11404.828927566072, 729.9890501642479, 741.9925800742004, 890.3900827932887, 903.832790933676, 905.6060613633091, 897.0625696147509, 900.8018235988072, 903.0878812399491, 904.1049361132465, 904.3759805734022, 783.2715574515698, 945.9621615135386, 947.2800671489683, 947.7535840681403, 948.6869333120088, 785.4619585583865, 935.957881895313, 938.6386241297116, 943.5518128888791, 944.3531181140941, 703.63762662229, 703.7958991892345, 704.031956060417, 705.3369832357567, 707.6886170085146, 11278.887211127865, 11413.942930285379, 11414.657560273205, 11432.885671143265, 11457.484413201426, 10767.83848242277, 11221.38282394468, 11504.309741415542, 11591.362475063868, 11861.9917307029, 9550.90449095507, 9690.418574885529, 9712.368696034806, 9853.655122070693, 9915.058069483388, 3480.6519348065244, 3531.699805516534, 3532.7527073104893, 3534.540509733718, 3541.911452213715, 47310.29034564484, 47634.523654763354, 48156.0, 48713.51286487125, 49044.0, 8659.437136586102, 8742.08208138149, 8752.081031491602, 8763.956180219186, 8767.517786521803, 18453.7231941521, 18478.722819157723, 18501.259949602136, 18504.16731247097, 18520.351787687367, 7037.120359955005, 7071.82320441993, 7088.539244949062, 7171.426285897116, 7196.4962452627815, 4230.957690423118, 4327.02641905575, 4343.066240758252, 4348.913021739548, 4350.630196433339, 2995.8801647934274, 3005.2637103909683, 3024.2439390152463, 3034.150437877398, 3037.4380739563253, 553.391269603433, 559.9356074051454, 560.246468499867, 562.0220815780513, 575.2378099018733, 686.8866637004938, 706.4454403293493, 708.0193931404938, 719.2555704845564, 767.0603510699349, 7890.171531989058, 8136.600740053739, 8247.298979586682, 8338.874916876252, 8352.540610266493, 569.4305694305694, 621.6177051113623, 663.9468842492589, 699.9825004374932, 702.685977222597, 3759.3984962405884, 3871.380579107329, 4205.852795152155, 4220.451341325608, 4235.618794308527, 59152.40847591469, 59206.703966479894, 59922.40077599255, 60420.0, 60637.393626064055, 49693.0, 51282.74358628183, 51453.48546514562, 51633.0, 52021.878687278884, 46496.3025554617, 47719.522804771506, 48061.5193848064, 48062.759686201345, 48337.0, 8001.639926203218, 8149.225823546753, 8468.788280293042, 8502.022267439077, 8566.18621230982, 34745.74580565336, 35388.0, 35964.10089747777, 36043.42942718083, 36607.81696091503, 41713.79143104265, 42554.78722606367, 43746.781266093465, 45696.54303456923, 46120.30819537643, 10863.076638485818, 10959.0, 11059.336439813636, 11154.386508742096, 11292.774144517229, 12412.937935310265, 12417.0, 12705.301208433624, 12894.743395004782, 12957.805632915703, 10807.405592692478, 10860.348379097279, 11040.061594764215, 11146.609868654557, 11162.497687603915, 11009.559617615527, 11153.498092586015, 11156.219064665396, 11252.75729814576, 11327.716807079889, 9863.852042219229, 10027.498625068863, 10264.743381415525, 10405.427701476492, 10409.531571079167, 9743.366681165986, 10083.294169408364, 10241.84637230457, 10436.217283703905, 10573.207009474474, 9281.776791559689, 9399.34204605671, 9408.717738467856, 9481.952590237004, 9489.57296921654], "unit": "ms", "name": "yui.html", "value": 6263.19211765716}], "name": "dromaeo_css", "value": 7270.051884128527}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 110.0, 110.0, 109.0, 100.0, 108.0, 107.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 162.0, 158.0, 121.0, 146.0, 151.0, 130.0, 169.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 161.0, 163.0, 163.0, 161.0, 163.0, 159.0, 171.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 149.0, 71.0, 70.0, 71.0, 71.0, 148.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 92.0, 93.0, 92.0, 140.0, 91.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 58.0, 55.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 64.0, 64.0, 65.0, 66.0, 65.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 76.0, 78.0, 77.0, 78.0, 78.0, 85.0, 86.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [118.0, 113.0, 112.0, 117.0, 112.0, 113.0, 121.0, 117.0, 117.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [133.0, 136.0, 147.0, 142.0, 141.0, 132.0, 143.0, 140.0, 141.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.6}, {"lowerIsBetter": true, "replicates": [75.0, 63.0, 64.0, 62.0, 62.0, 64.0, 65.0, 65.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1478.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.9189189189189], "unit": "score", "name": "Richards", "value": 208.98783999999998}, {"lowerIsBetter": false, "replicates": [165.0437365901964], "unit": "score", "name": "DeltaBlue", "value": 400.608962}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [539.3743257820928], "unit": "score", "name": "Earley", "value": 1235.6224020000004}, {"lowerIsBetter": false, "replicates": [10531.25], "unit": "score", "name": "Boyer", "value": 63.28432047477742}, {"lowerIsBetter": false, "replicates": [24119.04761904762], "unit": "score", "name": "RegExp", "value": 37.77035538005923}, {"lowerIsBetter": false, "replicates": [517.3305742369374], "unit": "score", "name": "Splay", "value": 157.52210300000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23306.220768358162}]} 10:10:19 INFO - RETURN: dromaeo_css: 7270.05 10:10:19 INFO - RETURN: kraken: 1478.40 10:10:19 INFO - RETURN: v8_7: 23306.22 10:10:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23306.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1478.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7270.05"}}} 10:10:19 INFO - Return code: 0 10:10:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:10:19 INFO - # TBPL SUCCESS # 10:10:19 INFO - Running post-action listener: _resource_record_post_action 10:10:19 INFO - Running post-run listener: _resource_record_post_run 10:10:20 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 323584; Write bytes: 509108224; Read time: 388; Write time: 415328 10:10:20 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 179941376; Read time: 216; Write time: 229516 10:10:20 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 319488; Write bytes: 264802304; Read time: 172; Write time: 135304 10:10:20 INFO - Running post-run listener: _upload_blobber_files 10:10:20 INFO - Blob upload gear active. 10:10:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:10:20 INFO - Copying logs to upload dir... 10:10:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.839566 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-09 10:10:20.665978) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:10:20.669713) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009945 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455031676/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:10:20.721129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:10:20.721462) ========= 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=0e2a256762fed810e2f0f810000001b3-1455039305.16577-715103256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:10:20.770878) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:10:20.771174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:10:20.771458) ========= ========= Total master_lag: 0.27 =========