builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1454968334.6 results: success (0) buildid: 20160208111124 builduid: 3dfc71b8864b4f7298d633d70f3bed9b revision: 8b5409c04676 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.600171) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.600673) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.600988) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006138 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.629122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.629460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.689826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.690234) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021420 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.742591) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.742975) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.743393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.743761) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-08 13:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-02-08 13:52:14 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094816 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.854054) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.854383) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051378 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.917072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:14.917452) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b5409c04676 --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 8b5409c04676 --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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-08 13:52:15,092 Setting DEBUG logging. 2016-02-08 13:52:15,092 attempt 1/10 2016-02-08 13:52:15,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b5409c04676?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 13:52:15,339 unpacking tar archive at: mozilla-beta-8b5409c04676/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:15.492769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:15.493140) ========= echo 8b5409c04676 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8b5409c04676'] 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8b5409c04676 program finished with exit code 0 elapsedTime=0.004597 script_repo_revision: '8b5409c04676' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:15.547227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:15.547544) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 13:52:15.641803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-08 13:52:15.642095) ========= /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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:15 INFO - MultiFileLogger online at 20160208 13:52:15 in /builds/slave/test-pgo 13:52:15 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 13:52:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:52:15 INFO - {'append_to_log': False, 13:52:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:52:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:52:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:52:15 INFO - 'branch': 'Mozilla-Beta', 13:52:15 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:15 INFO - 'config_files': ('talos/linux_config.py',), 13:52:15 INFO - 'default_actions': ('clobber', 13:52:15 INFO - 'read-buildbot-config', 13:52:15 INFO - 'download-and-extract', 13:52:15 INFO - 'populate-webroot', 13:52:15 INFO - 'create-virtualenv', 13:52:15 INFO - 'install', 13:52:15 INFO - 'run-tests'), 13:52:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:15 INFO - 'download_minidump_stackwalk': True, 13:52:15 INFO - 'download_symbols': 'ondemand', 13:52:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:52:15 INFO - 'tooltool.py': '/tools/tooltool.py', 13:52:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:52:15 INFO - '/tools/misc-python/virtualenv.py')}, 13:52:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:15 INFO - 'installer_path': 'installer.exe', 13:52:15 INFO - 'log_level': 'info', 13:52:15 INFO - 'log_name': 'talos', 13:52:15 INFO - 'log_to_console': True, 13:52:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:15 INFO - 'opt_config_files': (), 13:52:15 INFO - 'pip_index': False, 13:52:15 INFO - 'sps_profile': False, 13:52:15 INFO - 'sps_profile_interval': 0, 13:52:15 INFO - 'suite': 'dromaeojs', 13:52:15 INFO - 'system_bits': '32', 13:52:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:15 INFO - 'title': 'talos-linux64-ix-050', 13:52:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:15 INFO - 'use_talos_json': True, 13:52:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:52:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:15 INFO - 'work_dir': 'build'} 13:52:15 INFO - ##### 13:52:15 INFO - ##### Running clobber step. 13:52:15 INFO - ##### 13:52:15 INFO - Running pre-action listener: _resource_record_pre_action 13:52:15 INFO - Running main action method: clobber 13:52:15 INFO - rmtree: /builds/slave/test-pgo/build 13:52:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:52:17 INFO - Running post-action listener: _resource_record_post_action 13:52:17 INFO - ##### 13:52:17 INFO - ##### Running read-buildbot-config step. 13:52:17 INFO - ##### 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: read_buildbot_config 13:52:17 INFO - Using buildbot properties: 13:52:17 INFO - { 13:52:17 INFO - "properties": { 13:52:17 INFO - "buildnumber": 72, 13:52:17 INFO - "product": "firefox", 13:52:17 INFO - "script_repo_revision": "production", 13:52:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:52:17 INFO - "repository": "", 13:52:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:52:17 INFO - "buildid": "20160208111124", 13:52:17 INFO - "slavename": "talos-linux64-ix-050", 13:52:17 INFO - "pgo_build": "True", 13:52:17 INFO - "basedir": "/builds/slave/test-pgo", 13:52:17 INFO - "project": "", 13:52:17 INFO - "platform": "ubuntu64_hw", 13:52:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:52:17 INFO - "slavebuilddir": "test", 13:52:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:52:17 INFO - "branch": "mozilla-beta", 13:52:17 INFO - "repo_path": "releases/mozilla-beta", 13:52:17 INFO - "stage_platform": "linux64-pgo", 13:52:17 INFO - "builduid": "3dfc71b8864b4f7298d633d70f3bed9b", 13:52:17 INFO - "revision": "8b5409c04676" 13:52:17 INFO - }, 13:52:17 INFO - "sourcestamp": { 13:52:17 INFO - "repository": "", 13:52:17 INFO - "hasPatch": false, 13:52:17 INFO - "project": "", 13:52:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:52:17 INFO - "changes": [ 13:52:17 INFO - { 13:52:17 INFO - "category": null, 13:52:17 INFO - "files": [ 13:52:17 INFO - { 13:52:17 INFO - "url": null, 13:52:17 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2" 13:52:17 INFO - } 13:52:17 INFO - ], 13:52:17 INFO - "repository": "", 13:52:17 INFO - "rev": "8b5409c04676", 13:52:17 INFO - "who": "sendchange", 13:52:17 INFO - "when": 1454968263, 13:52:17 INFO - "number": 7579928, 13:52:17 INFO - "comments": "Bug 1226148 - reduce flickering and closing when using the OSK tab key, r=masayuki, a=sylvestre", 13:52:17 INFO - "project": "", 13:52:17 INFO - "at": "Mon 08 Feb 2016 13:51:03", 13:52:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:52:17 INFO - "revlink": "", 13:52:17 INFO - "properties": [ 13:52:17 INFO - [ 13:52:17 INFO - "buildid", 13:52:17 INFO - "20160208111124", 13:52:17 INFO - "Change" 13:52:17 INFO - ], 13:52:17 INFO - [ 13:52:17 INFO - "builduid", 13:52:17 INFO - "3dfc71b8864b4f7298d633d70f3bed9b", 13:52:17 INFO - "Change" 13:52:17 INFO - ], 13:52:17 INFO - [ 13:52:17 INFO - "pgo_build", 13:52:17 INFO - "True", 13:52:17 INFO - "Change" 13:52:17 INFO - ] 13:52:17 INFO - ], 13:52:17 INFO - "revision": "8b5409c04676" 13:52:17 INFO - } 13:52:17 INFO - ], 13:52:17 INFO - "revision": "8b5409c04676" 13:52:17 INFO - } 13:52:17 INFO - } 13:52:17 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2. 13:52:17 INFO - Running post-action listener: _resource_record_post_action 13:52:17 INFO - ##### 13:52:17 INFO - ##### Running download-and-extract step. 13:52:17 INFO - ##### 13:52:17 INFO - Running pre-action listener: _resource_record_pre_action 13:52:17 INFO - Running main action method: download_and_extract 13:52:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:52:17 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')]} 13:52:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/test_packages.json 13:52:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:52:17 INFO - Downloaded 1270 bytes. 13:52:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:52:17 INFO - Using the following test package requirements: 13:52:17 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:52:17 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:52:17 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'jsshell-linux-x86_64.zip'], 13:52:17 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:52:17 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:52:17 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 13:52:17 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 13:52:17 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:52:17 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:52:17 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:52:17 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:52:17 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:52:17 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')]} 13:52:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:52:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:17 INFO - Downloaded 21581127 bytes. 13:52:17 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 13:52:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:52:17 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 13:52:18 INFO - Return code: 0 13:52:18 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 13:52: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')]} 13:52:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:52:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:20 INFO - Downloaded 21581127 bytes. 13:52:20 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 13:52:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:52:20 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 13:52:21 INFO - Return code: 0 13:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:52:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:24 INFO - Downloaded 11132038 bytes. 13:52:24 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 13:52:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:52:24 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 13:52:24 INFO - Return code: 0 13:52: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')]} 13:52:24 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:52:24 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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 13:52:26 INFO - Downloaded 57941967 bytes. 13:52:26 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:52:26 INFO - mkdir: /builds/slave/test-pgo/properties 13:52:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:52:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:52:26 INFO - Contents: 13:52:26 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:52:26 INFO - Running post-action listener: _resource_record_post_action 13:52:26 INFO - Running post-action listener: set_extra_try_arguments 13:52:26 INFO - ##### 13:52:26 INFO - ##### Running populate-webroot step. 13:52:26 INFO - ##### 13:52:26 INFO - Running pre-action listener: _resource_record_pre_action 13:52:26 INFO - Running main action method: populate_webroot 13:52:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:26 INFO - '--tppagecycles', 13:52:26 INFO - '7'], 13:52:26 INFO - 'tests': ['tsvgm']}}, 13:52:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:52:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:52:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'tests': ['damp', 'tps']}, 13:52:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['damp', 'tps']}, 13:52:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:52:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:26 INFO - 'other': {'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'other_l64': {'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'other_nol64': {'tests': ['a11yr', 13:52:26 INFO - 'ts_paint', 13:52:26 INFO - 'tpaint', 13:52:26 INFO - 'sessionrestore', 13:52:26 INFO - 'sessionrestore_no_auto_restore']}, 13:52:26 INFO - 'svgr': {'tests': ['tsvgx', 13:52:26 INFO - 'tsvgr_opacity', 13:52:26 INFO - 'tart', 13:52:26 INFO - 'tscrollx', 13:52:26 INFO - 'cart']}, 13:52:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['tsvgx', 13:52:26 INFO - 'tsvgr_opacity', 13:52:26 INFO - 'tart', 13:52:26 INFO - 'tscrollx', 13:52:26 INFO - 'cart']}, 13:52:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'tests': ['tp5o']}, 13:52:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'talos_options': ['--e10s'], 13:52:26 INFO - 'tests': ['tp5o']}, 13:52:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'talos_options': ['--xperf_path', 13:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:26 INFO - 'tests': ['tp5n']}, 13:52:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:26 INFO - 'talos_options': ['--e10s', 13:52:26 INFO - '--xperf_path', 13:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:26 INFO - 'tests': ['tp5n']}}, 13:52:26 INFO - 'talos.zip': {'path': '', 13:52:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:26 INFO - Running post-action listener: _resource_record_post_action 13:52:26 INFO - ##### 13:52:26 INFO - ##### Running create-virtualenv step. 13:52:26 INFO - ##### 13:52:26 INFO - Running pre-action listener: _resource_record_pre_action 13:52:26 INFO - Running main action method: create_virtualenv 13:52:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:52:26 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 13:52:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:52:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:26 INFO - Using real prefix '/usr' 13:52:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:52:26 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:28 INFO - Installing pip.................done. 13:52:28 INFO - Return code: 0 13:52:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:52:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:52:28 INFO - Using env: {'DISPLAY': ':0', 13:52:28 INFO - 'HOME': '/home/cltbld', 13:52:28 INFO - 'LANG': 'en_US.UTF-8', 13:52:28 INFO - 'LANGUAGE': 'en_US:en', 13:52:28 INFO - 'LOGNAME': 'cltbld', 13:52:28 INFO - 'MAIL': '/var/mail/cltbld', 13:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:28 INFO - 'MOZ_NO_REMOTE': '1', 13:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:28 INFO - 'NO_EM_RESTART': '1', 13:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:28 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:28 INFO - 'SHELL': '/bin/bash', 13:52:28 INFO - 'SHLVL': '1', 13:52:28 INFO - 'TERM': 'linux', 13:52:28 INFO - 'TMOUT': '86400', 13:52:28 INFO - 'USER': 'cltbld', 13:52:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:28 INFO - '_': '/tools/buildbot/bin/python'} 13:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:29 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 13:52:29 INFO - Cleaning up... 13:52:29 INFO - Return code: 0 13:52:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:29 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:29 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 13:52:29 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 13:52:29 INFO - Using env: {'DISPLAY': ':0', 13:52:29 INFO - 'HOME': '/home/cltbld', 13:52:29 INFO - 'LANG': 'en_US.UTF-8', 13:52:29 INFO - 'LANGUAGE': 'en_US:en', 13:52:29 INFO - 'LOGNAME': 'cltbld', 13:52:29 INFO - 'MAIL': '/var/mail/cltbld', 13:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:29 INFO - 'MOZ_NO_REMOTE': '1', 13:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:29 INFO - 'NO_EM_RESTART': '1', 13:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:29 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:29 INFO - 'SHELL': '/bin/bash', 13:52:29 INFO - 'SHLVL': '1', 13:52:29 INFO - 'TERM': 'linux', 13:52:29 INFO - 'TMOUT': '86400', 13:52:29 INFO - 'USER': 'cltbld', 13:52:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:29 INFO - '_': '/tools/buildbot/bin/python'} 13:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:29 INFO - Downloading/unpacking psutil>=0.7.1 13:52:29 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 13:52:29 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 13:52:29 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 13:52:29 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 13:52:29 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 13:52:29 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 13:52:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:31 INFO - Installing collected packages: psutil 13:52:31 INFO - Running setup.py install for psutil 13:52:31 INFO - building 'psutil._psutil_linux' extension 13:52:31 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 13:52:31 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 13:52:31 INFO - building 'psutil._psutil_posix' extension 13:52:31 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 13:52:32 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 13:52:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:32 INFO - Successfully installed psutil 13:52:32 INFO - Cleaning up... 13:52:32 INFO - Return code: 0 13:52:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:52:32 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')]} 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:32 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')]} 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:32 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:32 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 13:52:32 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 13:52:32 INFO - Using env: {'DISPLAY': ':0', 13:52:32 INFO - 'HOME': '/home/cltbld', 13:52:32 INFO - 'LANG': 'en_US.UTF-8', 13:52:32 INFO - 'LANGUAGE': 'en_US:en', 13:52:32 INFO - 'LOGNAME': 'cltbld', 13:52:32 INFO - 'MAIL': '/var/mail/cltbld', 13:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:32 INFO - 'MOZ_NO_REMOTE': '1', 13:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:32 INFO - 'NO_EM_RESTART': '1', 13:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:32 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:32 INFO - 'SHELL': '/bin/bash', 13:52:32 INFO - 'SHLVL': '1', 13:52:32 INFO - 'TERM': 'linux', 13:52:32 INFO - 'TMOUT': '86400', 13:52:32 INFO - 'USER': 'cltbld', 13:52:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:32 INFO - '_': '/tools/buildbot/bin/python'} 13:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:52:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:52:34 INFO - Installing collected packages: mozsystemmonitor 13:52:34 INFO - Running setup.py install for mozsystemmonitor 13:52:34 INFO - Successfully installed mozsystemmonitor 13:52:34 INFO - Cleaning up... 13:52:34 INFO - Return code: 0 13:52:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:52:34 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')]} 13:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:34 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')]} 13:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:34 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:34 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 13:52:34 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 13:52:34 INFO - Using env: {'DISPLAY': ':0', 13:52:34 INFO - 'HOME': '/home/cltbld', 13:52:34 INFO - 'LANG': 'en_US.UTF-8', 13:52:34 INFO - 'LANGUAGE': 'en_US:en', 13:52:34 INFO - 'LOGNAME': 'cltbld', 13:52:34 INFO - 'MAIL': '/var/mail/cltbld', 13:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:34 INFO - 'MOZ_NO_REMOTE': '1', 13:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:34 INFO - 'NO_EM_RESTART': '1', 13:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:34 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:34 INFO - 'SHELL': '/bin/bash', 13:52:34 INFO - 'SHLVL': '1', 13:52:34 INFO - 'TERM': 'linux', 13:52:34 INFO - 'TMOUT': '86400', 13:52:34 INFO - 'USER': 'cltbld', 13:52:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:34 INFO - '_': '/tools/buildbot/bin/python'} 13:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:34 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 13:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:52:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:37 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 13:52:37 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 13:52:37 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 13:52:37 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 13:52:37 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 13:52:37 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 13:52:37 INFO - Downloading docopt-0.6.1.tar.gz 13:52:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:37 INFO - Running setup.py install for blobuploader 13:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:52:37 INFO - Running setup.py install for requests 13:52:37 INFO - Running setup.py install for docopt 13:52:37 INFO - Successfully installed blobuploader requests docopt 13:52:37 INFO - Cleaning up... 13:52:37 INFO - Return code: 0 13:52:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:37 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:37 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 13:52:37 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 13:52:37 INFO - Using env: {'DISPLAY': ':0', 13:52:37 INFO - 'HOME': '/home/cltbld', 13:52:37 INFO - 'LANG': 'en_US.UTF-8', 13:52:37 INFO - 'LANGUAGE': 'en_US:en', 13:52:37 INFO - 'LOGNAME': 'cltbld', 13:52:37 INFO - 'MAIL': '/var/mail/cltbld', 13:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:37 INFO - 'MOZ_NO_REMOTE': '1', 13:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:37 INFO - 'NO_EM_RESTART': '1', 13:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:37 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:37 INFO - 'SHELL': '/bin/bash', 13:52:37 INFO - 'SHLVL': '1', 13:52:37 INFO - 'TERM': 'linux', 13:52:37 INFO - 'TMOUT': '86400', 13:52:37 INFO - 'USER': 'cltbld', 13:52:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:37 INFO - '_': '/tools/buildbot/bin/python'} 13:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:38 INFO - Running setup.py (path:/tmp/pip-9x6jFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:38 INFO - Running setup.py (path:/tmp/pip-H4s9R4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:38 INFO - Running setup.py (path:/tmp/pip-1KWvYi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:38 INFO - Running setup.py (path:/tmp/pip-Pc6EOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:38 INFO - Running setup.py (path:/tmp/pip-sFGqSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:38 INFO - Running setup.py (path:/tmp/pip-FzxODa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:38 INFO - Running setup.py (path:/tmp/pip-xYmIL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:38 INFO - Running setup.py (path:/tmp/pip-P4WMgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:38 INFO - Running setup.py (path:/tmp/pip-kNDaAC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:38 INFO - Running setup.py (path:/tmp/pip-PARXk2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:38 INFO - Running setup.py (path:/tmp/pip-FVSl5g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:38 INFO - Running setup.py (path:/tmp/pip-FC8ejk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:39 INFO - Running setup.py (path:/tmp/pip-nJ487t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:39 INFO - Running setup.py (path:/tmp/pip-U7Pxrb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:39 INFO - Running setup.py (path:/tmp/pip-eXtI7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:39 INFO - Running setup.py (path:/tmp/pip-7O9L3E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:39 INFO - Running setup.py (path:/tmp/pip-cEaio5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:39 INFO - Running setup.py install for manifestparser 13:52:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:52:39 INFO - Running setup.py install for mozcrash 13:52:39 INFO - Running setup.py install for mozdebug 13:52:39 INFO - Running setup.py install for mozdevice 13:52:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:52:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:52:39 INFO - Running setup.py install for mozfile 13:52:39 INFO - Running setup.py install for mozhttpd 13:52:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:52:39 INFO - Running setup.py install for mozinfo 13:52:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for mozInstall 13:52:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for mozleak 13:52:40 INFO - Running setup.py install for mozlog 13:52:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for moznetwork 13:52:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for mozprocess 13:52:40 INFO - Running setup.py install for mozprofile 13:52:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for mozrunner 13:52:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:52:40 INFO - Running setup.py install for mozscreenshot 13:52:40 INFO - Running setup.py install for moztest 13:52:41 INFO - Running setup.py install for mozversion 13:52:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:52:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:52:41 INFO - Cleaning up... 13:52:41 INFO - Return code: 0 13:52:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:41 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:41 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 13:52:41 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 13:52:41 INFO - Using env: {'DISPLAY': ':0', 13:52:41 INFO - 'HOME': '/home/cltbld', 13:52:41 INFO - 'LANG': 'en_US.UTF-8', 13:52:41 INFO - 'LANGUAGE': 'en_US:en', 13:52:41 INFO - 'LOGNAME': 'cltbld', 13:52:41 INFO - 'MAIL': '/var/mail/cltbld', 13:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:41 INFO - 'MOZ_NO_REMOTE': '1', 13:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:41 INFO - 'NO_EM_RESTART': '1', 13:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:41 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:41 INFO - 'SHELL': '/bin/bash', 13:52:41 INFO - 'SHLVL': '1', 13:52:41 INFO - 'TERM': 'linux', 13:52:41 INFO - 'TMOUT': '86400', 13:52:41 INFO - 'USER': 'cltbld', 13:52:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:41 INFO - '_': '/tools/buildbot/bin/python'} 13:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:41 INFO - Running setup.py (path:/tmp/pip-P97X5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:41 INFO - Running setup.py (path:/tmp/pip-df_8sk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:41 INFO - Running setup.py (path:/tmp/pip-6sg8m0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:41 INFO - Running setup.py (path:/tmp/pip-7ZM9TV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:41 INFO - Running setup.py (path:/tmp/pip-zIBfd6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:41 INFO - Running setup.py (path:/tmp/pip-Lppiw0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:41 INFO - Running setup.py (path:/tmp/pip-LzkF3e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:41 INFO - Running setup.py (path:/tmp/pip-MCcyp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:41 INFO - Running setup.py (path:/tmp/pip-doG3pJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:41 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)) 13:52:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:41 INFO - Running setup.py (path:/tmp/pip-AZqXh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:42 INFO - Running setup.py (path:/tmp/pip-nLtcuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:42 INFO - Running setup.py (path:/tmp/pip-Rs2r84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:42 INFO - Running setup.py (path:/tmp/pip-UequDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:42 INFO - Running setup.py (path:/tmp/pip-x51eg2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:42 INFO - Running setup.py (path:/tmp/pip-RBEHGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:42 INFO - Running setup.py (path:/tmp/pip-lDO8Dn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:42 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)) 13:52:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:42 INFO - Running setup.py (path:/tmp/pip-NBz2Sl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:42 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)) 13:52:42 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)) 13:52:42 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)) 13:52:42 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)) 13:52:42 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)) 13:52:42 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)) 13:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:52:42 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 13:52:42 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 13:52:42 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 13:52:42 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 13:52:42 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 13:52:42 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 13:52:44 INFO - Downloading blessings-1.6.tar.gz 13:52:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:52:44 INFO - Installing collected packages: blessings 13:52:44 INFO - Running setup.py install for blessings 13:52:44 INFO - Successfully installed blessings 13:52:44 INFO - Cleaning up... 13:52:44 INFO - Return code: 0 13:52:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:52:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:52:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:52:44 INFO - Reading from file tmpfile_stdout 13:52:44 INFO - Current package versions: 13:52:44 INFO - argparse == 1.2.1 13:52:44 INFO - blessings == 1.6 13:52:44 INFO - blobuploader == 1.2.4 13:52:44 INFO - docopt == 0.6.1 13:52:44 INFO - manifestparser == 1.1 13:52:44 INFO - mozInstall == 1.12 13:52:44 INFO - mozcrash == 0.16 13:52:44 INFO - mozdebug == 0.1 13:52:44 INFO - mozdevice == 0.47 13:52:44 INFO - mozfile == 1.2 13:52:44 INFO - mozhttpd == 0.7 13:52:44 INFO - mozinfo == 0.9 13:52:44 INFO - mozleak == 0.1 13:52:44 INFO - mozlog == 3.1 13:52:44 INFO - moznetwork == 0.27 13:52:44 INFO - mozprocess == 0.22 13:52:44 INFO - mozprofile == 0.27 13:52:44 INFO - mozrunner == 6.11 13:52:44 INFO - mozscreenshot == 0.1 13:52:44 INFO - mozsystemmonitor == 0.0 13:52:44 INFO - moztest == 0.7 13:52:44 INFO - mozversion == 1.4 13:52:44 INFO - psutil == 3.1.1 13:52:44 INFO - requests == 1.2.3 13:52:44 INFO - wsgiref == 0.1.2 13:52:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:44 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:44 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 13:52:44 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 13:52:44 INFO - Using env: {'DISPLAY': ':0', 13:52:44 INFO - 'HOME': '/home/cltbld', 13:52:44 INFO - 'LANG': 'en_US.UTF-8', 13:52:44 INFO - 'LANGUAGE': 'en_US:en', 13:52:44 INFO - 'LOGNAME': 'cltbld', 13:52:44 INFO - 'MAIL': '/var/mail/cltbld', 13:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:44 INFO - 'MOZ_NO_REMOTE': '1', 13:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:44 INFO - 'NO_EM_RESTART': '1', 13:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:44 INFO - 'SHELL': '/bin/bash', 13:52:44 INFO - 'SHLVL': '1', 13:52:44 INFO - 'TERM': 'linux', 13:52:44 INFO - 'TMOUT': '86400', 13:52:44 INFO - 'USER': 'cltbld', 13:52:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:44 INFO - '_': '/tools/buildbot/bin/python'} 13:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 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)) 13:52:44 INFO - Cleaning up... 13:52:44 INFO - Return code: 0 13:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:44 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:44 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 13:52:44 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 13:52:44 INFO - Using env: {'DISPLAY': ':0', 13:52:44 INFO - 'HOME': '/home/cltbld', 13:52:44 INFO - 'LANG': 'en_US.UTF-8', 13:52:44 INFO - 'LANGUAGE': 'en_US:en', 13:52:44 INFO - 'LOGNAME': 'cltbld', 13:52:44 INFO - 'MAIL': '/var/mail/cltbld', 13:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:44 INFO - 'MOZ_NO_REMOTE': '1', 13:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:44 INFO - 'NO_EM_RESTART': '1', 13:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:45 INFO - 'SHELL': '/bin/bash', 13:52:45 INFO - 'SHLVL': '1', 13:52:45 INFO - 'TERM': 'linux', 13:52:45 INFO - 'TMOUT': '86400', 13:52:45 INFO - 'USER': 'cltbld', 13:52:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:45 INFO - '_': '/tools/buildbot/bin/python'} 13:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:45 INFO - Downloading/unpacking jsonschema 13:52:45 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 13:52:45 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 13:52:45 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 13:52:45 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 13:52:45 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 13:52:45 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 13:52:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:52:47 INFO - Downloading/unpacking functools32 (from jsonschema) 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 INFO - Downloading functools32-3.2.3-2.tar.gz 13:52:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:52:47 INFO - warning: no files found matching '*.txt' 13:52:47 INFO - no previously-included directories found matching 'build' 13:52:47 INFO - no previously-included directories found matching 'dist' 13:52:47 INFO - no previously-included directories found matching '.git*' 13:52:47 INFO - Installing collected packages: jsonschema, functools32 13:52:47 INFO - Running setup.py install for functools32 13:52:47 INFO - warning: no files found matching '*.txt' 13:52:47 INFO - no previously-included directories found matching 'build' 13:52:47 INFO - no previously-included directories found matching 'dist' 13:52:47 INFO - no previously-included directories found matching '.git*' 13:52:47 INFO - Successfully installed jsonschema functools32 13:52:47 INFO - Cleaning up... 13:52:47 INFO - Return code: 0 13:52:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:47 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 0x7fbf9d501f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8a600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, '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': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', '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 13:52:47 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 13:52:47 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 13:52:47 INFO - Using env: {'DISPLAY': ':0', 13:52:47 INFO - 'HOME': '/home/cltbld', 13:52:47 INFO - 'LANG': 'en_US.UTF-8', 13:52:47 INFO - 'LANGUAGE': 'en_US:en', 13:52:47 INFO - 'LOGNAME': 'cltbld', 13:52:47 INFO - 'MAIL': '/var/mail/cltbld', 13:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:47 INFO - 'MOZ_NO_REMOTE': '1', 13:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:47 INFO - 'NO_EM_RESTART': '1', 13:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:47 INFO - 'SHELL': '/bin/bash', 13:52:47 INFO - 'SHLVL': '1', 13:52:47 INFO - 'TERM': 'linux', 13:52:47 INFO - 'TMOUT': '86400', 13:52:47 INFO - 'USER': 'cltbld', 13:52:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:47 INFO - '_': '/tools/buildbot/bin/python'} 13:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:47 INFO - Downloading/unpacking flake8 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:47 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 13:52:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:52:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:52:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:49 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 13:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:52:50 INFO - no previously-included directories found matching 'docs/_build' 13:52:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:52:50 INFO - Running setup.py install for pep8 13:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:52:50 INFO - no previously-included directories found matching 'docs/_build' 13:52:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:52:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:52:50 INFO - Cleaning up... 13:52:50 INFO - Return code: 0 13:52:50 INFO - Running post-action listener: _resource_record_post_action 13:52:50 INFO - Running post-action listener: _start_resource_monitoring 13:52:50 INFO - Starting resource monitoring. 13:52:50 INFO - ##### 13:52:50 INFO - ##### Running install step. 13:52:50 INFO - ##### 13:52:50 INFO - Running pre-action listener: _resource_record_pre_action 13:52:50 INFO - Running main action method: install 13:52:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:52:50 INFO - Reading from file tmpfile_stdout 13:52:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:52:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:52:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:52:50 INFO - Reading from file tmpfile_stdout 13:52:50 INFO - Output received: 13:52:50 INFO - Usage: mozinstall [options] installer 13:52:50 INFO - Options: 13:52:50 INFO - -h, --help show this help message and exit 13:52:50 INFO - -d DEST, --destination=DEST 13:52:50 INFO - Directory to install application into. [default: 13:52:50 INFO - "/builds/slave/test-pgo"] 13:52:50 INFO - --app=APP Application being installed. [default: firefox] 13:52:50 INFO - mkdir: /builds/slave/test-pgo/build/application 13:52:50 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'] 13:52:50 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 13:53:05 INFO - Reading from file tmpfile_stdout 13:53:05 INFO - Output received: 13:53:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:53:05 INFO - Running post-action listener: _resource_record_post_action 13:53:05 INFO - ##### 13:53:05 INFO - ##### Running run-tests step. 13:53:05 INFO - ##### 13:53:05 INFO - Running pre-action listener: _resource_record_pre_action 13:53:05 INFO - Running main action method: run_tests 13:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:53:05 INFO - Python 2.7.3 13:53:05 INFO - Return code: 0 13:53:05 INFO - grabbing minidump binary from tooltool 13:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:05 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 0x1019350>, '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 0x101a250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101a6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:53:05 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 13:53:05 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 13:53:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:05 INFO - Return code: 0 13:53:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:53:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:53:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:53:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:53:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:53:06 INFO - Return code: 0 13:53:06 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/1454958684/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:53:06 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/1454958684/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost 13:53:06 INFO - Using env: {'DISPLAY': ':0', 13:53:06 INFO - 'HOME': '/home/cltbld', 13:53:06 INFO - 'LANG': 'en_US.UTF-8', 13:53:06 INFO - 'LANGUAGE': 'en_US:en', 13:53:06 INFO - 'LOGNAME': 'cltbld', 13:53:06 INFO - 'MAIL': '/var/mail/cltbld', 13:53:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:06 INFO - 'MOZ_NO_REMOTE': '1', 13:53:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:06 INFO - 'NO_EM_RESTART': '1', 13:53:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:53:06 INFO - 'SHELL': '/bin/bash', 13:53:06 INFO - 'SHLVL': '1', 13:53:06 INFO - 'TERM': 'linux', 13:53:06 INFO - 'TMOUT': '86400', 13:53:06 INFO - 'USER': 'cltbld', 13:53:06 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243', 13:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:06 INFO - '_': '/tools/buildbot/bin/python'} 13:53:06 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/1454958684/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] with output_timeout 3600 13:53:06 INFO - mozversion INFO | application_buildid: 20160208111124 13:53:06 INFO - mozversion INFO | application_changeset: 8b5409c046760475cd68f6da6a1078074e4c2cb5 13:53:06 INFO - mozversion INFO | application_display_name: Nightly 13:53:06 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:06 INFO - mozversion INFO | application_name: Firefox 13:53:06 INFO - mozversion INFO | application_remotingname: firefox 13:53:06 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:53:06 INFO - mozversion INFO | application_vendor: Mozilla 13:53:06 INFO - mozversion INFO | application_version: 45.0 13:53:06 INFO - mozversion INFO | platform_buildid: 20160208111124 13:53:06 INFO - mozversion INFO | platform_changeset: 8b5409c046760475cd68f6da6a1078074e4c2cb5 13:53:06 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:53:06 INFO - mozversion INFO | platform_version: 45.0 13:53:06 INFO - 2016-02-08 13:53:06,585 DEBUG : using testdate: 1454968386 13:53:06 INFO - 2016-02-08 13:53:06,585 DEBUG : actual date: 1454968386 13:53:06 INFO - 2016-02-08 13:53:06,592 INFO : starting webserver on 'localhost:36544' 13:53:06 INFO - 2016-02-08 13:53:06,593 INFO : Starting test suite talos-linux64-ix-050 13:53:06 INFO - 2016-02-08 13:53:06,593 INFO : Starting test dromaeo_css 13:53:06 INFO - 2016-02-08 13:53:06,594 DEBUG : operating with platform_type : linux_ 13:53:06 INFO - 2016-02-08 13:53:06,594 INFO : Initialising browser for dromaeo_css test... 13:53:06 INFO - 2016-02-08 13:53:06,611 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9cdcPS/profile http://localhost:36544/getInfo.html 13:53:10 INFO - 2016-02-08 13:53:10,292 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:53:10 INFO - 2016-02-08 13:53:10,293 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:53:10 INFO - 2016-02-08 13:53:10,293 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:53:10 INFO - 2016-02-08 13:53:10,293 DEBUG : BROWSER_OUTPUT: __metrics 13:53:10 INFO - 2016-02-08 13:53:10,449 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] 13:53:11 INFO - 2016-02-08 13:53:11,382 INFO : Browser initialized. 13:53:11 INFO - 2016-02-08 13:53:11,383 INFO : Running cycle 1/1 for dromaeo_css test... 13:53:11 INFO - 2016-02-08 13:53:11,383 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9cdcPS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:53:23 INFO - 2016-02-08 13:53:23,085 DEBUG : BROWSER_OUTPUT: RSS: Main: 134631424 13:53:23 INFO - 2016-02-08 13:53:23,086 DEBUG : BROWSER_OUTPUT: 13:54:13 INFO - 2016-02-08 13:54:13,986 DEBUG : BROWSER_OUTPUT: 1454968453986 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] 13:56:22 INFO - 2016-02-08 13:56:22,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36544/tests/dromaeo/cssquery-ext.html) 13:56:23 INFO - 2016-02-08 13:56:23,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 217473024 13:56:23 INFO - 2016-02-08 13:56:23,551 DEBUG : BROWSER_OUTPUT: 13:59:25 INFO - 2016-02-08 13:59:25,599 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-ext.html (next: http://localhost:36544/tests/dromaeo/cssquery-jquery.html) 13:59:26 INFO - 2016-02-08 13:59:26,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 220090368 13:59:26 INFO - 2016-02-08 13:59:26,160 DEBUG : BROWSER_OUTPUT: 14:02:28 INFO - 2016-02-08 14:02:28,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36544/tests/dromaeo/cssquery-mootools.html) 14:02:28 INFO - 2016-02-08 14:02:28,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 213180416 14:02:28 INFO - 2016-02-08 14:02:28,579 DEBUG : BROWSER_OUTPUT: 14:05:30 INFO - 2016-02-08 14:05:30,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36544/tests/dromaeo/cssquery-prototype.html) 14:05:30 INFO - 2016-02-08 14:05:30,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 202604544 14:05:30 INFO - 2016-02-08 14:05:30,847 DEBUG : BROWSER_OUTPUT: 14:08:33 INFO - 2016-02-08 14:08:33,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36544/tests/dromaeo/cssquery-yui.html) 14:08:33 INFO - 2016-02-08 14:08:33,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 204693504 14:08:33 INFO - 2016-02-08 14:08:33,664 DEBUG : BROWSER_OUTPUT: 14:11:35 INFO - 2016-02-08 14:11:35,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/dromaeo/cssquery-yui.html (next: http://localhost:36544/tests/dromaeo/cssquery-dojo.html) 14:11:36 INFO - 2016-02-08 14:11:36,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 223731712 14:11:36 INFO - 2016-02-08 14:11:36,071 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,071 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:11:36 INFO - 2016-02-08 14:11:36,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:11:36 INFO - 2016-02-08 14:11:36,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:11:36 INFO - 2016-02-08 14:11:36,072 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:11:36 INFO - 2016-02-08 14:11:36,072 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3315.088350703557;3379.138319728469;3407.7614566980305;3414.078198886301;3446.6553344665535;5462.0441422751055;5590.161475778636;5602.075657516505;5609.2988376452895;5629.071203251458;5583.804566840151;5632;5644.830655080344;5654;5655.4910058094765;4893.926591101136;5091.23631455281;5134.691918484884;5190.844274671747;5258.605604579653;5054.570361519257;5076.517730815566;5080.949190508103;5090.440051594322;5091.414487333967;4971.825986090469;5035.899282014358;5094.566961808251;5100.974495127519;5101.974490127544;5124.615653825959;5135.974320128413;5196.714180720059;5205.063088644042;5213.791448342062;5017.598592112622;5084.262781896604;5086.4659210783075;5114.028334616411;5135.794568217267;5208.5572726318305;5310.389305229871;5320.5211530962015;5379.623426360156;5398.946010539884;5946.8810623787285;6062.878742425127;6064.545159113084;6068.362821903725;6083;6090.086487026937;6093.512518998469;6121.785737499166;6124.958757011319;6125.571210015256;5461.644993075437;5526.861828454321;5552.250446189753;5615.298087739033;5620.634658747168;6021.849453763691;6059.1820104286235;6061.727222275008;6062.696865156725;6065.727042283108;5886.941130588725;5890.676012819336;5902.6458412495385;5904.498117659961;5908.113782932594;5786.537077033827;5871.266091738533;5965.194698715618;6042.697865106815;6073.1497590337385;6061.969690151521;6080.817575472743;6080.847978800565;6085.908711369245;6088.360722124113;5798.710064496759;6048.818535443944;6072.787452439232;6074.726637301332;6075.726592303357;4445.73325600465;4542.886427839265;4593.19619066662;4593.839215627437;4621.907561848811;4053.2298863215897;4078.0824314528995;4093.9795301023305;4105.712600117963;4108.301588729923;5431.158170483582;5527.668339899619;5679.801206957736;5680.5171560417;5688.63023903445;5982.0727787193055;6044.546659000593;6069.757209711562;6103.05402662588;6112.602680825732;5659.320881494247;5661.716914154275;5663.8867222656145;5666.206731057655;5666.914996275059;4816.373871396696;4898.191798353303;4931.0630980113665;4970.527799859007;4992.725400102957;6268.717907694165;6272.686365681698;6273.278572964167;6274.811755647338;6288.182536270256;6059.21230240066;6063.5452341073715;6064.241969753781;6064.302605200459;6078.5441091919165;5944.73248703818;6105.450509453993;6119.724612392364;6203.472704820141;6266.843328916813;5960.135780311917;6021.789237376671;6052.727627256872;6061.666608336407;6071.241094863142;6121.387861213843;6138.416850399205;6153.323134455296;6153.415425534746;6159.414855588712;5718.771249149988;5769.798057067983;5850.64896106235;5870.735816888165;5907.40925907423;5794.7102644866745;5856.238688970407;5869.7945571904775;5885.411458854081;5892.086726557391;5546.251256080377;5789.421057894346;5799.3040835100055;5816.76732930678;5821.534277257894;5698.0598201296325;5755.827325180251;5855.765769369348;5869.7945571904775;5896.056630939029;5769.567282453917;5803.82588522345;5850.912236316373;5859.531237500904;5860.38465961085 14:11:36 INFO - 2016-02-08 14:11:36,075 DEBUG : BROWSER_OUTPUT: |1;ext.html;630.0769372868747;635.4471609699563;635.7329921432997;638.2659941067772;645.5642441352086;40138.19723605526;40654.79672601633;40895;40924.79537602308;40929.38605920914;46151;46471.30293045607;46577.30134047992;46583.76708116463;46768.76615616926;8161.918380816205;8281.047679516872;8933.374663773522;9105.68130115446;9113.95443022784;10668.30656007361;10816.134709223243;10888.564457421693;10889.237753357229;10903.454827258645;10237.385756854612;10319.793604127914;10326.896731032668;10330.586776528968;10333.328333658288;10568.260221784478;10671.626493072705;10679.519421626046;10681.465926703711;10684.839727404056;10537.84193237102;10648.307859989154;10659.467026648637;10666.466676666136;10676.572937082507;42235.36646950298;42626.147477050596;42748.358774618406;42752;42773.57226427758;3124.125244931423;3184.41088398647;3227.7579181561478;3271.8691252349877;3330.2673411849596;32703.50944735831;32829;33057.6694233057;33223.16942076467;33227.33545329104;4263.680223983214;4324.372965919955;4387.692861499696;4417.182821178092;4423.358613001097;303455;304451;306536;307381;310500.4474977633;57960.42039579635;65753.67123164449;66156.33843661597;66203.68287109928;66255.66872165704;49550.50449495531;50807.23789143166;75171;77198.61400692961;77249;18327;18406;18450.07749612514;18457;18600.069996500122;14019.859801401855;14092.506762263272;14094.154350738989;14100;14100.435982560582;20641;20909.790902090783;20968.685469717966;21064.894675526524;21095.578088438146;7664.348530374869;7753.689852405841;7831.725889593837;7894.960525197337;7925.762227133196;992.1467537917385;1029.7940411917646;1068.6847380022912;1078.719532921446;1090.607381342716;29351.55972660412;29556.704432955394;29590.556141657893;30550.847245763627;30634.69365306363;1115.642994241851;1160.5357856857324;1169.8479197704414;1194.8745381734793;1203.7231436769591;13697.794533082011;15292.311845966959;15374.385024599114;15669.764953525706;16423.096729679743;346227;350887;351083;351748;352619;57548.71225643845;57758.42241577614;57811.421885780604;57862.421375786544;57882.131768023515;1286.414681319997;1341.081359268904;1443.1052747296744;1478.0909740509724;1482.021865568741;27277.86361068182;27454;27711.722882770915;27887;28230.15309540717;41338.79330603328;41470.377944330256;41812;41889;41918.58081419147;198338;200380;201785;202051;202103;31500.36999259956;32140.19649508781;32198.35603287968;32213;32321.35357292794;43066.56933430626;43220.78389608032;44037.559624403344;44087.55912440835;44184;36520.45219321659;36987.26025479529;37562.24875502529;37969;37987.43018854775;36689.26621467609;36798.080047999014;37544.249115018094;37750.43374349442;37784.62215377921;36341.63658363382;37209.25581488409;37266.8136659315;37368.43947340846;37383;33119.66880331166;33720.49419258762;34133.65866341305;34459.82770086134;34784;24409.877950610135;25982.74017259803;27066.729332707208;27535.586966195122;28587.14238572846 14:11:36 INFO - 2016-02-08 14:11:36,077 DEBUG : BROWSER_OUTPUT: |2;jquery.html;369.8132443116228;373.5722597625719;373.771999080561;374.6085340818844;375.4480913057805;15579.065256084614;15588.142652154127;17405.12974351282;18826.435206943795;19462.805371946295;10592.152627789777;17080.402185923496;17227.82772172278;17250.82749172508;17563.12184390782;5087.49125087491;5104.66819656723;5220.164773636219;5223.764930578133;5246.842594722146;4008.3386241270155;4116.547179810218;5592.748326325304;5719.942800572004;5732.168835518847;5675.148727690838;5689.345725241588;5711.543076553887;5711.685857277848;5716.828495145152;5309.469053094679;5433.565314774809;5457.890842183174;5461.208124821878;5461.617686761928;5258.605604579634;5265.368155821326;5298.788048478056;5421.268128802601;5463.2078348639225;20925.430592705456;21112.15551377943;21123;21570.784292157034;21597;2279.4871153990384;2300.332903457995;2303.37808791627;2329;2350.6003979323555;9923.90076099237;9979;9994.9500252499;10119.949400253025;10287.897121028844;1909.3603642779685;1927.60484100759;1964.1161477335113;2007.9598408031757;2023.8482113841521;64362.678186609235;64735.676321618565;64837.35162648407;66226.3377366225;66806.66596667033;11029.503672334604;11139.275947063416;11197;11237.943810280896;11288.774224515464;14777.261136943325;14837.10977341363;14876.628084297763;14881;14932.477363292233;8487.957560212159;8548.700795472128;8596.140385961478;8662.653493860174;8664.176903194186;8421.831563368698;8436.156384361515;8436.957815211008;8459.069502354736;8508.617112229964;4688.109259240733;4688.531146885284;4706.223473126965;4711.3639658646325;4783.56947874686;1760.2726322471597;1804.2151664026192;1850.148931491502;1947.221111555361;1953.2284747524648;897.4435849773182;958.4249450329746;1007.6171054999054;1043.7495001199657;1044.1333693034762;14190.645233869236;16130.596735081483;17505.387311444294;17508.737368939477;17641.7353739694;954.117441366733;956.9952150239204;968.1335204991493;1003.4481035430484;1011.2668315471225;9694.854577181348;9958.477197435692;9968.900310996942;10247.538860751283;10329.225308101923;585576;612167;626473;626611;629245;76660.61669691616;79152.60423697844;79247.20752792513;81026.59486702646;81895.5905220482;1106.5463160104157;1109.439732934879;1152.302856771641;1160.7794519041356;1161.59344229519;15578.29897654631;15891;15983.44057957966;16002.439914602934;16129.193540323171;35310.646893530735;35996.64003360038;36028.639713602526;36067.27865442729;37075.8146209278;43297.13405731805;44007.119857603306;44111;44515;48674;10196;10424.270301078852;10428.634997775041;10525.052745252964;10590.682279531626;17807.109644517463;17845.10774461298;18155.546111346794;18444.07779611041;18737.71893421627;14411.495597654031;15010.324535396152;15051.397944082551;15095.169765662993;15594.220288985733;14025.29873506341;14791.852081479477;14906.32921518556;14921.776173357626;14923.701525969636;11643.53425862956;12079.094067944763;13437;15875;15929.442469513511;9118.635254589743;9443.291753118407;9458.668946586837;9793.755156121155;10201.84697229557;14594.781078284046;14834.035787673767;14854.777178342118;14896.180710061051;15349.693006140038 14:11:36 INFO - 2016-02-08 14:11:36,078 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1547.8297387287396;1556.2841093097168;1744.5289771761616;1798.785819571789;1831.441410369837;7738.651760670769;7986.520808751479;7994.720184793533;7996;7999.4800337977995;7812.921870781291;7900.328472079866;7906.802329941755;7908.92091079089;7913.2086791320835;2279.623862062758;2287.862728236307;2333.649952507129;2334.5214231082587;2335.1710142899283;2339.040993192791;2370.111208296889;2370.8340416170877;2371.9169829055986;2371.95256094878;2069.048237810609;2107.2203284784573;2271.432141964509;2295.231097582312;2361;2304.2626359564947;2314.652802079693;2316.0388438797877;2327.7323107842476;2341.5785158671433;2271.716035495563;2301.4131396493954;2318.826088043387;2319.826013049011;2323.5352929414016;6967.721291148348;7104.25405332443;7555.2067032961295;7710.113336966265;7712.498687585289;4736.407949006374;4789.353437285991;4790.257510085942;4791.904161916777;4828.203346447832;3026.1678038539576;3100.1319630503494;3146.0719087869134;3146.8583913723937;3160.936781264362;979.4759803505161;986.7582442301682;990.4601991914424;996.2179688944217;1032.7418145463635;10343.275970682056;10470.685879423629;10472.947635261851;10473;10474.26680132391;4132.194222126656;4134.524529679065;4221.894452638647;4242.66058715302;4252.532221455637;8896.510691912006;8952.194302512806;8960.148785865333;8962.551872406353;8985.550722463851;4666.323383109498;4715.104130215248;4718.834840780556;4723.102610503994;4723.83466578675;4377.474703035656;4378.321360189176;4383.167198232326;4383.671224658164;4388;3512.4204506256183;3574.249407624376;3594.191306955914;3606.441001644749;3611.8013509256716;1076.725435014082;1080.378782200238;1090.8636420447444;1096.616184335492;1098.8351747237818;933.5332333833084;962.6101428921298;1066.594694016269;1088.6407485529755;1090.2858627598935;7329.9267007329245;7357;7357.558546487228;7362.742304019441;7377.594232317167;507.6573313013701;507.83241530294913;514.4264145477765;515.2142981952477;517.503196930943;5900.498457631149;5975.611585246945;6055.848603784941;6060.878782424327;6095.177151084636;9068.8639670405;9254.768630784285;9372.297077719062;9380.437173769596;9392.201662858597;9076.273898088137;9109.863352049724;9274.489903055262;9276.536173191313;9282.071792820663;7197.640117994184;7307.817304567428;7345.338919497271;7350.705971761176;7366.521176123642;6874.759383421556;6947.756828510978;6980.930190698028;7002.474814388839;7029.156501219886;8057.0734365548715;8154.510729356258;8381.832363352576;8383.916160838558;8391.538465384463;8330.208630180123;8522.659093636184;8526.062133165222;8539.274161696077;8681.565921704016;6758.357955994173;6780.966095169492;6785.728570857308;6856.040154378291;6864.279250678607;7473.588952607659;7526.209747976603;7570.545767253982;7596.050493688289;7637.274458926393;7090.893636595559;7100.822479438056;7172.641367931478;7185.425165986604;7317.707291708272;6986.476014298846;7044.260352663102;7086.610236437045;7122.60825654594;7169.928300716926;7156.320149585781;7182.389496892613;7211.350978411968;7213.062301900719;7218.566885986857;6761.154855643044;6787.796366108827;6854.520183587101;6878;6882.414994725505;6099.9390006099375;6239.438450539473;6530.118434011348;6591.604503729792;6611 14:11:36 INFO - 2016-02-08 14:11:36,081 DEBUG : BROWSER_OUTPUT: |4;prototype.html;343.1917833502104;344.7948470659958;345.8409131799372;352.5821901047258;353.9946900796489;6010.849728756783;6089.695515224232;6140.416660417259;6148.907766383508;6160.353162917896;5761.107028410603;5878.1476685880525;5939.227900372956;5998.310194327653;6018.6689732064715;4651.325557794118;4676.321933319684;4692.8122875084955;4694.90610187796;4700.6004489618335;4674.111918735446;4691.366665500148;4691.624670026406;4695.694779839299;4698.624110071186;4491.932621010687;4531.297648864432;4572;4643.187442197619;4671.696339737906;4627.07458508298;4643.373144625466;4650.046740418206;4656.952185758211;4660.137874493195;4111.691623128248;4116.670666346685;4117.094239267356;4117.608827161444;4125.422440858282;5708.400617935098;5722.7424765885635;5733.082706766939;5735.971320143414;5746.511546518551;5238.449962753933;5399.62202645815;5401.513863752281;5442.863928401782;5451.536619387357;6384.361563843625;6394.58435201715;6395.456386207178;6395.77614783485;6396.776112836028;4543.954560454386;4548.0221752323405;4549.158405694924;4552.68131230814;4556.612687921531;6466.062420948983;6543.378379053982;6606.867862642768;6610.008498725181;6625.370589793962;4512.458504979358;4514.503404625489;4516.864494065183;4517.683762136685;4518;4556.476005259371;4569.017661202791;4573.588377046081;4574.199515084847;4577.427821522309;5303.628745987821;5303.893922121536;5308.071087559739;5309.5752339812725;5314.441983591667;6330.3669633036325;6438.678066096676;6442.26058964077;6454.096426500294;6459.515536334699;1632.2491653839368;1643.753436984438;1644.9095299758628;1645.3336398758522;1645.8765592580605;1090.536521978172;1114.6043154680135;1115.1914861725347;1137.0505627800715;1142.5144313666658;6249.6562689051625;6252.062190671436;6261.499080073583;6264.310925798159;6272.372762723691;6633.933660663428;6661.966690166518;6666.566673166229;6670.699818508178;6678.465722742169;6024.789132380346;6116.755329786848;6229.470495007975;6327.209098862642;6332.588381755171;3564.055525285801;3576.159602493412;3580.6393570443065;3581.9641803582153;3582.46263060543;6943.409810166192;6947.166340039126;6947.305269473113;6951.7914462566205;6966.3730264276455;6611.074449577063;6854.485913556503;6855.622940738307;6865.759698410631;6865.9313406866295;6958.130233720785;6961.895571566431;6964.895526567106;6973.442124629916;6975.407090397373;6570.671466426564;6693.497987651043;6699.598024118569;6703.66481675924;6706.865862682816;6597.868042639217;6598.802035938929;6611.702473388806;6614.603123812587;6621.205455345389;6964.756233531802;6974.7210111597;6976.197737260077;6979.790606281819;6979.965100174467;4550.499445061107;4565.0413413183605;4571.657125715651;4572.085582883503;4576.153411618861;6549.377809108127;6697;6700.865982680417;6705.195376554844;6706.865862682816;6481.287058423664;6483.157189565326;6485.221773387224;6488.188976377953;6489.545731798728;6349.016321481393;6463.935360646334;6481.7731379403385;6482.611043337415;6491.4806815455595;6363.300036996019;6393.840153996187;6398.488120950406;6398.936010639834;6405.4058106466955;6508.9349106508325;6521.380468855451;6523.934760652332;6525;6534.4772418205475;6189.1025801257665;6371.299157092623;6383.585066970632;6396.232452105777;6400.839979000562 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: |5;yui.html;792.8612492813758;794.9999999999999;809.2271880354263;838.4508147163602;878.5431575580702;13410.329483525822;13507.932460337697;13551.322433878317;13574.728505429886;13605.319734013297;12652.746945061093;12670.746585068293;12742.23546587203;12754.80867786984;12767.233965962048;736.8378956629533;744.5644298085626;862.9482231066156;866.0516734176067;877.8112705768259;879.9560021998907;881.5944665453899;883.1168831168832;886.9068747781487;887.0508555845248;769.5921161784263;868.9478631282112;916.1479823763897;920.8664743612172;923.7505873414174;774.7598244544181;893.5978809535735;909.4361495872602;911.1389736698856;911.1981456318398;675.6115233740619;676.8781619308522;677.4918810891832;678.108287601807;680.2890978927034;12603.117781755282;12671.683207919876;12675.239485630891;12692.492300307977;12729.872701272961;12256.325902075383;12632.17890837102;12686.238825670489;14089.225092619901;14260.786088208684;10376.533056012497;10876.782464350748;10970.232083754141;11288.266262692981;11337.206395552315;3833.731638785286;3838.1747924196434;3860.247251785903;3890.591487893787;3975.026118600961;48330.99999999965;48984;49084.50915490871;49277.26084108741;50246;10173.643922462677;10186.236032297607;10204.591816327413;10321.122704570045;10418.374897506174;16332.183390830649;16370.754438683429;16378.181090945405;16392.098434586213;16396.016239025696;7919.485233459806;8008.119106898236;8110.107888132301;8140.389470789714;8215.178482151738;4606.170889239902;4793.592544633745;4846.5153484651255;4876.68720218507;4888.071266459361;2974.5538169274782;2990.1777011321624;2999.0403071017067;3001.0996700989617;3003.4743919813945;550.5265471694339;566.2751677852356;566.7194738604417;573.0859279449272;579.2383016333508;596.4691424632081;630.8675926711563;659.864727730814;693.8889777635554;733.6625152429942;8289.58552072394;8289.95855020721;8485.278751306085;8790.912090879137;8792.912070879338;674.9223839258548;683.7401787320787;694.0560837261321;722.3967986731034;734.4711807498593;4119.361498967664;4452.8218871245435;4604.493505714436;4608.493065762764;4633.096546173531;52582.47417525776;52732.73633631807;52809.47190528122;52959;52992.73503632457;47972.28041579379;54537;54774.178387324224;55143.72428137914;55805.72097139488;47328.763356183685;49174.75412622842;49190.50809491931;49228.75385623049;50183.74908125436;9096;9112.316576256675;9355.53222338894;9497.667581634609;9620.278479114235;35883.28233435369;36283;36943.81528092342;37181.62818371782;37377.25245495129;43395.132097357244;43432.34851477167;47264.7636761814;47540.52459475361;47685.52314476811;11669.824952625548;11688.824667630162;12025.818818983707;12229.205101668364;12277.570285039981;13201.867981320063;13211.075224734177;13365.198088114745;13465.528706495226;13658.521951731642;12831.679208019874;12863.871361286641;12883;12932.547360842325;13405.463781448632;11959.880401195876;12006.879931200925;12042.819357709466;12222.20555663879;12588.244705317711;12311.199772015148;12618.936905315415;12626.747465050832;12783.93608031954;13126.212427254395;10707.357558546511;10753.946230268799;10945.671629851116;10983.39591322485;10995.945020274847;10243.180545556188;10345.896541034494;10768.0847127995;10875.401852898167;10880.510377033212 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,766 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: __startTimestamp1454969496069__endTimestamp 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,082 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5569.03 Median:5789.42 stddev:636.41 (11.0%) stddev-sans-first:613.31 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: Values: 3315.1 3379.1 3407.8 3414.1 3446.7 5462.0 5590.2 5602.1 5609.3 5629.1 5583.8 5632.0 5644.8 5654.0 5655.5 4893.9 5091.2 5134.7 5190.8 5258.6 5054.6 5076.5 5080.9 5090.4 5091.4 4971.8 5035.9 5094.6 5101.0 5102.0 5124.6 5136.0 5196.7 5205.1 5213.8 5017.6 5084.3 5086.5 5114.0 5135.8 5208.6 5310.4 5320.5 5379.6 5398.9 5946.9 6062.9 6064.5 6068.4 6083.0 6090.1 6093.5 6121.8 6125.0 6125.6 5461.6 5526.9 5552.3 5615.3 5620.6 6021.8 6059.2 6061.7 6062.7 6065.7 5886.9 5890.7 5902.6 5904.5 5908.1 5786.5 5871.3 5965.2 6042.7 6073.1 6062.0 6080.8 6080.8 6085.9 6088.4 5798.7 6048.8 6072.8 6074.7 6075.7 4445.7 4542.9 4593.2 4593.8 4621.9 4053.2 4078.1 4094.0 4105.7 4108.3 5431.2 5527.7 5679.8 5680.5 5688.6 5982.1 6044.5 6069.8 6103.1 6112.6 5659.3 5661.7 5663.9 5666.2 5666.9 4816.4 4898.2 4931.1 4970.5 4992.7 6268.7 6272.7 6273.3 6274.8 6288.2 6059.2 6063.5 6064.2 6064.3 6078.5 5944.7 6105.5 6119.7 6203.5 6266.8 5960.1 6021.8 6052.7 6061.7 6071.2 6121.4 6138.4 6153.3 6153.4 6159.4 5718.8 5769.8 5850.6 5870.7 5907.4 5794.7 5856.2 5869.8 5885.4 5892.1 5546.3 5789.4 5799.3 5816.8 5821.5 5698.1 5755.8 5855.8 5869.8 5896.1 5769.6 5803.8 5850.9 5859.5 5860.4 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,083 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47119.46 Median:33088.67 stddev:76628.12 (231.6%) stddev-sans-first:76763.57 14:11:36 INFO - 2016-02-08 14:11:36,085 DEBUG : BROWSER_OUTPUT: Values: 630.1 635.4 635.7 638.3 645.6 40138.2 40654.8 40895.0 40924.8 40929.4 46151.0 46471.3 46577.3 46583.8 46768.8 8161.9 8281.0 8933.4 9105.7 9114.0 10668.3 10816.1 10888.6 10889.2 10903.5 10237.4 10319.8 10326.9 10330.6 10333.3 10568.3 10671.6 10679.5 10681.5 10684.8 10537.8 10648.3 10659.5 10666.5 10676.6 42235.4 42626.1 42748.4 42752.0 42773.6 3124.1 3184.4 3227.8 3271.9 3330.3 32703.5 32829.0 33057.7 33223.2 33227.3 4263.7 4324.4 4387.7 4417.2 4423.4 303455.0 304451.0 306536.0 307381.0 310500.4 57960.4 65753.7 66156.3 66203.7 66255.7 49550.5 50807.2 75171.0 77198.6 77249.0 18327.0 18406.0 18450.1 18457.0 18600.1 14019.9 14092.5 14094.2 14100.0 14100.4 20641.0 20909.8 20968.7 21064.9 21095.6 7664.3 7753.7 7831.7 7895.0 7925.8 992.1 1029.8 1068.7 1078.7 1090.6 29351.6 29556.7 29590.6 30550.8 30634.7 1115.6 1160.5 1169.8 1194.9 1203.7 13697.8 15292.3 15374.4 15669.8 16423.1 346227.0 350887.0 351083.0 351748.0 352619.0 57548.7 57758.4 57811.4 57862.4 57882.1 1286.4 1341.1 1443.1 1478.1 1482.0 27277.9 27454.0 27711.7 27887.0 28230.2 41338.8 41470.4 41812.0 41889.0 41918.6 198338.0 200380.0 201785.0 202051.0 202103.0 31500.4 32140.2 32198.4 32213.0 32321.4 43066.6 43220.8 44037.6 44087.6 44184.0 36520.5 36987.3 37562.2 37969.0 37987.4 36689.3 36798.1 37544.2 37750.4 37784.6 36341.6 37209.3 37266.8 37368.4 37383.0 33119.7 33720.5 34133.7 34459.8 34784.0 24409.9 25982.7 27066.7 27535.6 28587.1 14:11:36 INFO - 2016-02-08 14:11:36,085 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,085 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31388.73 Median:2289.91 stddev:100560.93 (4391.5%) stddev-sans-first:100816.05 14:11:36 INFO - 2016-02-08 14:11:36,086 DEBUG : BROWSER_OUTPUT: Values: 369.8 373.6 373.8 374.6 375.4 15579.1 15588.1 17405.1 18826.4 19462.8 10592.2 17080.4 17227.8 17250.8 17563.1 5087.5 5104.7 5220.2 5223.8 5246.8 4008.3 4116.5 5592.7 5719.9 5732.2 5675.1 5689.3 5711.5 5711.7 5716.8 5309.5 5433.6 5457.9 5461.2 5461.6 5258.6 5265.4 5298.8 5421.3 5463.2 20925.4 21112.2 21123.0 21570.8 21597.0 2279.5 2300.3 2303.4 2329.0 2350.6 9923.9 9979.0 9995.0 10119.9 10287.9 1909.4 1927.6 1964.1 2008.0 2023.8 64362.7 64735.7 64837.4 66226.3 66806.7 11029.5 11139.3 11197.0 11237.9 11288.8 14777.3 14837.1 14876.6 14881.0 14932.5 8488.0 8548.7 8596.1 8662.7 8664.2 8421.8 8436.2 8437.0 8459.1 8508.6 4688.1 4688.5 4706.2 4711.4 4783.6 1760.3 1804.2 1850.1 1947.2 1953.2 897.4 958.4 1007.6 1043.7 1044.1 14190.6 16130.6 17505.4 17508.7 17641.7 954.1 957.0 968.1 1003.4 1011.3 9694.9 9958.5 9968.9 10247.5 10329.2 585576.0 612167.0 626473.0 626611.0 629245.0 76660.6 79152.6 79247.2 81026.6 81895.6 1106.5 1109.4 1152.3 1160.8 1161.6 15578.3 15891.0 15983.4 16002.4 16129.2 35310.6 35996.6 36028.6 36067.3 37075.8 43297.1 44007.1 44111.0 44515.0 48674.0 10196.0 10424.3 10428.6 10525.1 10590.7 17807.1 17845.1 18155.5 18444.1 18737.7 14411.5 15010.3 15051.4 15095.2 15594.2 14025.3 14791.9 14906.3 14921.8 14923.7 11643.5 12079.1 13437.0 15875.0 15929.4 9118.6 9443.3 9458.7 9793.8 10201.8 14594.8 14834.0 14854.8 14896.2 15349.7 14:11:36 INFO - 2016-02-08 14:11:36,086 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,086 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5452.12 Median:6771.06 stddev:2827.96 (41.8%) stddev-sans-first:2820.67 14:11:36 INFO - 2016-02-08 14:11:36,086 DEBUG : BROWSER_OUTPUT: Values: 1547.8 1556.3 1744.5 1798.8 1831.4 7738.7 7986.5 7994.7 7996.0 7999.5 7812.9 7900.3 7906.8 7908.9 7913.2 2279.6 2287.9 2333.6 2334.5 2335.2 2339.0 2370.1 2370.8 2371.9 2372.0 2069.0 2107.2 2271.4 2295.2 2361.0 2304.3 2314.7 2316.0 2327.7 2341.6 2271.7 2301.4 2318.8 2319.8 2323.5 6967.7 7104.3 7555.2 7710.1 7712.5 4736.4 4789.4 4790.3 4791.9 4828.2 3026.2 3100.1 3146.1 3146.9 3160.9 979.5 986.8 990.5 996.2 1032.7 10343.3 10470.7 10472.9 10473.0 10474.3 4132.2 4134.5 4221.9 4242.7 4252.5 8896.5 8952.2 8960.1 8962.6 8985.6 4666.3 4715.1 4718.8 4723.1 4723.8 4377.5 4378.3 4383.2 4383.7 4388.0 3512.4 3574.2 3594.2 3606.4 3611.8 1076.7 1080.4 1090.9 1096.6 1098.8 933.5 962.6 1066.6 1088.6 1090.3 7329.9 7357.0 7357.6 7362.7 7377.6 507.7 507.8 514.4 515.2 517.5 5900.5 5975.6 6055.8 6060.9 6095.2 9068.9 9254.8 9372.3 9380.4 9392.2 9076.3 9109.9 9274.5 9276.5 9282.1 7197.6 7307.8 7345.3 7350.7 7366.5 6874.8 6947.8 6980.9 7002.5 7029.2 8057.1 8154.5 8381.8 8383.9 8391.5 8330.2 8522.7 8526.1 8539.3 8681.6 6758.4 6781.0 6785.7 6856.0 6864.3 7473.6 7526.2 7570.5 7596.1 7637.3 7090.9 7100.8 7172.6 7185.4 7317.7 6986.5 7044.3 7086.6 7122.6 7169.9 7156.3 7182.4 7211.4 7213.1 7218.6 6761.2 6787.8 6854.5 6878.0 6882.4 6099.9 6239.4 6530.1 6591.6 6611.0 14:11:36 INFO - 2016-02-08 14:11:36,087 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,087 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5401.20 Median:6154.63 stddev:1628.02 (26.5%) stddev-sans-first:1587.70 14:11:36 INFO - 2016-02-08 14:11:36,087 DEBUG : BROWSER_OUTPUT: Values: 343.2 344.8 345.8 352.6 354.0 6010.8 6089.7 6140.4 6148.9 6160.4 5761.1 5878.1 5939.2 5998.3 6018.7 4651.3 4676.3 4692.8 4694.9 4700.6 4674.1 4691.4 4691.6 4695.7 4698.6 4491.9 4531.3 4572.0 4643.2 4671.7 4627.1 4643.4 4650.0 4657.0 4660.1 4111.7 4116.7 4117.1 4117.6 4125.4 5708.4 5722.7 5733.1 5736.0 5746.5 5238.4 5399.6 5401.5 5442.9 5451.5 6384.4 6394.6 6395.5 6395.8 6396.8 4544.0 4548.0 4549.2 4552.7 4556.6 6466.1 6543.4 6606.9 6610.0 6625.4 4512.5 4514.5 4516.9 4517.7 4518.0 4556.5 4569.0 4573.6 4574.2 4577.4 5303.6 5303.9 5308.1 5309.6 5314.4 6330.4 6438.7 6442.3 6454.1 6459.5 1632.2 1643.8 1644.9 1645.3 1645.9 1090.5 1114.6 1115.2 1137.1 1142.5 6249.7 6252.1 6261.5 6264.3 6272.4 6633.9 6662.0 6666.6 6670.7 6678.5 6024.8 6116.8 6229.5 6327.2 6332.6 3564.1 3576.2 3580.6 3582.0 3582.5 6943.4 6947.2 6947.3 6951.8 6966.4 6611.1 6854.5 6855.6 6865.8 6865.9 6958.1 6961.9 6964.9 6973.4 6975.4 6570.7 6693.5 6699.6 6703.7 6706.9 6597.9 6598.8 6611.7 6614.6 6621.2 6964.8 6974.7 6976.2 6979.8 6980.0 4550.5 4565.0 4571.7 4572.1 4576.2 6549.4 6697.0 6700.9 6705.2 6706.9 6481.3 6483.2 6485.2 6488.2 6489.5 6349.0 6463.9 6481.8 6482.6 6491.5 6363.3 6393.8 6398.5 6398.9 6405.4 6508.9 6521.4 6523.9 6525.0 6534.5 6189.1 6371.3 6383.6 6396.2 6400.8 14:11:36 INFO - 2016-02-08 14:11:36,087 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,087 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14185.37 Median:4607.33 stddev:16044.31 (348.2%) stddev-sans-first:16057.79 14:11:36 INFO - 2016-02-08 14:11:36,088 DEBUG : BROWSER_OUTPUT: Values: 792.9 795.0 809.2 838.5 878.5 13410.3 13507.9 13551.3 13574.7 13605.3 12652.7 12670.7 12742.2 12754.8 12767.2 736.8 744.6 862.9 866.1 877.8 880.0 881.6 883.1 886.9 887.1 769.6 868.9 916.1 920.9 923.8 774.8 893.6 909.4 911.1 911.2 675.6 676.9 677.5 678.1 680.3 12603.1 12671.7 12675.2 12692.5 12729.9 12256.3 12632.2 12686.2 14089.2 14260.8 10376.5 10876.8 10970.2 11288.3 11337.2 3833.7 3838.2 3860.2 3890.6 3975.0 48331.0 48984.0 49084.5 49277.3 50246.0 10173.6 10186.2 10204.6 10321.1 10418.4 16332.2 16370.8 16378.2 16392.1 16396.0 7919.5 8008.1 8110.1 8140.4 8215.2 4606.2 4793.6 4846.5 4876.7 4888.1 2974.6 2990.2 2999.0 3001.1 3003.5 550.5 566.3 566.7 573.1 579.2 596.5 630.9 659.9 693.9 733.7 8289.6 8290.0 8485.3 8790.9 8792.9 674.9 683.7 694.1 722.4 734.5 4119.4 4452.8 4604.5 4608.5 4633.1 52582.5 52732.7 52809.5 52959.0 52992.7 47972.3 54537.0 54774.2 55143.7 55805.7 47328.8 49174.8 49190.5 49228.8 50183.7 9096.0 9112.3 9355.5 9497.7 9620.3 35883.3 36283.0 36943.8 37181.6 37377.3 43395.1 43432.3 47264.8 47540.5 47685.5 11669.8 11688.8 12025.8 12229.2 12277.6 13201.9 13211.1 13365.2 13465.5 13658.5 12831.7 12863.9 12883.0 12932.5 13405.5 11959.9 12006.9 12042.8 12222.2 12588.2 12311.2 12618.9 12626.7 12783.9 13126.2 10707.4 10753.9 10945.7 10983.4 10995.9 10243.2 10345.9 10768.1 10875.4 10880.5 14:11:36 INFO - 2016-02-08 14:11:36,088 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:11:36 INFO - 2016-02-08 14:11:36,088 DEBUG : BROWSER_OUTPUT: 14:11:36 INFO - 2016-02-08 14:11:36,625 INFO : Browser exited with error code: 0 14:11:36 INFO - 2016-02-08 14:11:36,648 INFO : Completed test dromaeo_css (00:18:30) 14:11:36 INFO - 2016-02-08 14:11:36,648 INFO : Starting test kraken 14:11:36 INFO - 2016-02-08 14:11:36,648 DEBUG : operating with platform_type : linux_ 14:11:36 INFO - 2016-02-08 14:11:36,649 INFO : Initialising browser for kraken test... 14:11:36 INFO - 2016-02-08 14:11:36,655 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptrKHxM/profile http://localhost:36544/getInfo.html 14:11:40 INFO - 2016-02-08 14:11:40,651 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:11:40 INFO - 2016-02-08 14:11:40,651 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:11:40 INFO - 2016-02-08 14:11:40,651 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:11:40 INFO - 2016-02-08 14:11:40,652 DEBUG : BROWSER_OUTPUT: __metrics 14:11:40 INFO - 2016-02-08 14:11:40,788 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] 14:11:41 INFO - 2016-02-08 14:11:41,476 INFO : Browser initialized. 14:11:41 INFO - 2016-02-08 14:11:41,476 INFO : Running cycle 1/1 for kraken test... 14:11:41 INFO - 2016-02-08 14:11:41,477 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptrKHxM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:11:53 INFO - 2016-02-08 14:11:53,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 134434816 14:11:53 INFO - 2016-02-08 14:11:53,226 DEBUG : BROWSER_OUTPUT: 14:11:55 INFO - 2016-02-08 14:11:55,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36544/tests/kraken/driver.html?testName=audio-beat-detection) 14:11:56 INFO - 2016-02-08 14:11:56,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 166133760 14:11:56 INFO - 2016-02-08 14:11:56,246 DEBUG : BROWSER_OUTPUT: 14:11:58 INFO - 2016-02-08 14:11:58,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36544/tests/kraken/driver.html?testName=audio-dft) 14:11:59 INFO - 2016-02-08 14:11:59,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 162729984 14:11:59 INFO - 2016-02-08 14:11:59,410 DEBUG : BROWSER_OUTPUT: 14:12:02 INFO - 2016-02-08 14:12:02,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36544/tests/kraken/driver.html?testName=audio-fft) 14:12:02 INFO - 2016-02-08 14:12:02,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 160772096 14:12:02 INFO - 2016-02-08 14:12:02,763 DEBUG : BROWSER_OUTPUT: 14:12:04 INFO - 2016-02-08 14:12:04,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36544/tests/kraken/driver.html?testName=audio-oscillator) 14:12:05 INFO - 2016-02-08 14:12:05,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 158396416 14:12:05 INFO - 2016-02-08 14:12:05,308 DEBUG : BROWSER_OUTPUT: 14:12:07 INFO - 2016-02-08 14:12:07,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:08 INFO - 2016-02-08 14:12:08,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 159207424 14:12:08 INFO - 2016-02-08 14:12:08,036 DEBUG : BROWSER_OUTPUT: 14:12:10 INFO - 2016-02-08 14:12:10,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36544/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:11 INFO - 2016-02-08 14:12:11,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 158928896 14:12:11 INFO - 2016-02-08 14:12:11,421 DEBUG : BROWSER_OUTPUT: 14:12:14 INFO - 2016-02-08 14:12:14,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36544/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:15 INFO - 2016-02-08 14:12:15,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 158920704 14:12:15 INFO - 2016-02-08 14:12:15,352 DEBUG : BROWSER_OUTPUT: 14:12:18 INFO - 2016-02-08 14:12:18,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36544/tests/kraken/driver.html?testName=json-parse-financial) 14:12:18 INFO - 2016-02-08 14:12:18,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 160382976 14:12:18 INFO - 2016-02-08 14:12:18,692 DEBUG : BROWSER_OUTPUT: 14:12:20 INFO - 2016-02-08 14:12:20,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:20 INFO - 2016-02-08 14:12:20,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 165842944 14:12:20 INFO - 2016-02-08 14:12:20,794 DEBUG : BROWSER_OUTPUT: 14:12:22 INFO - 2016-02-08 14:12:22,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:23 INFO - 2016-02-08 14:12:23,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 166313984 14:12:23 INFO - 2016-02-08 14:12:23,146 DEBUG : BROWSER_OUTPUT: 14:12:25 INFO - 2016-02-08 14:12:25,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:25 INFO - 2016-02-08 14:12:25,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 170545152 14:12:25 INFO - 2016-02-08 14:12:25,676 DEBUG : BROWSER_OUTPUT: 14:12:28 INFO - 2016-02-08 14:12:28,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:28 INFO - 2016-02-08 14:12:28,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 177844224 14:12:28 INFO - 2016-02-08 14:12:28,625 DEBUG : BROWSER_OUTPUT: 14:12:31 INFO - 2016-02-08 14:12:31,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:31 INFO - 2016-02-08 14:12:31,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 175505408 14:12:31 INFO - 2016-02-08 14:12:31,674 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36544/tests/kraken/driver.html?testName=ai-astar) 14:12:33 INFO - 2016-02-08 14:12:33,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 234315776 14:12:33 INFO - 2016-02-08 14:12:33,557 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,560 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:12:33 INFO - 2016-02-08 14:12:33,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;103;108;110;110;100;109;112;99 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;124;146;162;121;147;161;123;169;121 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |2;audio-dft;158;160;161;160;161;161;164;159;159;160 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;77;73;150;73;71;71;71;157;72 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;93;138;92;92;92;137;93;92;135 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;109;110;109;109;109;109 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;146;146;146;147;145;145;147;146 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;96;96;95;95;96 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;56;56;57;57;57;58;59;55;55 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;65;63;64;64;65;63;64;64;64 14:12:33 INFO - 2016-02-08 14:12:33,561 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;78;79;78;78;79;78;78;78;85 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;109;117;116;107;121;114;134;122;114;120 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;134;141;147;147;135;143;142;143;144 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;65;65;64;65;65;62;63;63 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,898 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: __startTimestamp1454969553558__endTimestamp 14:12:33 INFO - 2016-02-08 14:12:33,562 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,563 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:12:33 INFO - 2016-02-08 14:12:33,563 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:12:33 INFO - 2016-02-08 14:12:33,563 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.70 Median:109.50 stddev:4.47 (4.1%) stddev-sans-first:4.74 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 103.0 108.0 110.0 110.0 100.0 109.0 112.0 99.0 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:150.00 stddev:18.90 (12.6%) stddev-sans-first:19.67 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: Values: 153.0 124.0 146.0 162.0 121.0 147.0 161.0 123.0 169.0 121.0 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.64 (1.0%) stddev-sans-first:1.51 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: Values: 158.0 160.0 161.0 160.0 161.0 161.0 164.0 159.0 159.0 160.0 14:12:33 INFO - 2016-02-08 14:12:33,564 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.60 Median:71.50 stddev:34.29 (48.0%) stddev-sans-first:35.78 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: Values: 71.0 77.0 73.0 150.0 73.0 71.0 71.0 71.0 157.0 72.0 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.00 stddev:21.53 (23.4%) stddev-sans-first:22.18 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: Values: 91.0 93.0 138.0 92.0 92.0 92.0 137.0 93.0 92.0 135.0 14:12:33 INFO - 2016-02-08 14:12:33,565 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 146.0 146.0 146.0 147.0 145.0 145.0 147.0 146.0 14:12:33 INFO - 2016-02-08 14:12:33,566 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.32 (2.3%) stddev-sans-first:1.32 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: Values: 58.0 56.0 56.0 57.0 57.0 57.0 58.0 59.0 55.0 55.0 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 63.0 64.0 64.0 65.0 63.0 64.0 64.0 64.0 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,567 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:2.18 (2.8%) stddev-sans-first:2.29 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: Values: 80.0 78.0 79.0 78.0 78.0 79.0 78.0 78.0 78.0 85.0 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:118.50 stddev:7.60 (6.4%) stddev-sans-first:7.43 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: Values: 109.0 117.0 116.0 107.0 121.0 114.0 134.0 122.0 114.0 120.0 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:143.50 stddev:4.90 (3.4%) stddev-sans-first:4.60 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: Values: 149.0 134.0 141.0 147.0 147.0 135.0 143.0 142.0 143.0 144.0 14:12:33 INFO - 2016-02-08 14:12:33,568 DEBUG : BROWSER_OUTPUT: 14:12:33 INFO - 2016-02-08 14:12:33,570 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 14:12:33 INFO - 2016-02-08 14:12:33,570 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 65.0 65.0 64.0 65.0 65.0 62.0 63.0 63.0 14:12:33 INFO - 2016-02-08 14:12:33,570 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:12:33 INFO - 2016-02-08 14:12:33,570 DEBUG : BROWSER_OUTPUT: 14:12:34 INFO - 2016-02-08 14:12:34,249 INFO : Browser exited with error code: 0 14:12:34 INFO - 2016-02-08 14:12:34,304 INFO : Completed test kraken (00:00:57) 14:12:34 INFO - 2016-02-08 14:12:34,304 INFO : Starting test v8_7 14:12:34 INFO - 2016-02-08 14:12:34,304 DEBUG : operating with platform_type : linux_ 14:12:34 INFO - 2016-02-08 14:12:34,304 INFO : Initialising browser for v8_7 test... 14:12:34 INFO - 2016-02-08 14:12:34,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcai9Mp/profile http://localhost:36544/getInfo.html 14:12:38 INFO - 2016-02-08 14:12:38,260 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:12:38 INFO - 2016-02-08 14:12:38,260 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:12:38 INFO - 2016-02-08 14:12:38,260 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:12:38 INFO - 2016-02-08 14:12:38,260 DEBUG : BROWSER_OUTPUT: __metrics 14:12:38 INFO - 2016-02-08 14:12:38,417 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] 14:12:39 INFO - 2016-02-08 14:12:39,031 INFO : Browser initialized. 14:12:39 INFO - 2016-02-08 14:12:39,031 INFO : Running cycle 1/1 for v8_7 test... 14:12:39 INFO - 2016-02-08 14:12:39,032 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcai9Mp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:12:50 INFO - 2016-02-08 14:12:50,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 134410240 14:12:50 INFO - 2016-02-08 14:12:50,786 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36544/tests/v8_7/run.html (next: http://localhost:36544/tests/v8_7/run.html) 14:13:12 INFO - 2016-02-08 14:13:12,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 421445632 14:13:12 INFO - 2016-02-08 14:13:12,390 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: |0;Richards;172.80110592707794 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.5548790521639 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 14:13:12 INFO - 2016-02-08 14:13:12,392 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |4;RayTrace;963.3911368015414 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |5;Earley;546.448087431694 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |6;Boyer;10776.595744680852 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |7;RegExp;24095.238095238095 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |8;Splay;518.6721991701245 14:13:12 INFO - 2016-02-08 14:13:12,393 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 14:13:12 INFO - 2016-02-08 14:13:12,394 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:13:12 INFO - 2016-02-08 14:13:12,394 DEBUG : BROWSER_OUTPUT: __startTimestamp1454969592390__endTimestamp 14:13:12 INFO - 2016-02-08 14:13:12,394 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,394 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:13:12 INFO - 2016-02-08 14:13:12,394 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:13:12 INFO - 2016-02-08 14:13:12,395 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,395 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.80 Median:172.80 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,396 DEBUG : BROWSER_OUTPUT: Values: 172.8 14:13:12 INFO - 2016-02-08 14:13:12,396 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.55 Median:164.55 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: Values: 164.6 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: Values: 278.2 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,397 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: Values: 5148.7 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:963.39 Median:963.39 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: Values: 963.4 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:546.45 Median:546.45 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,398 DEBUG : BROWSER_OUTPUT: Values: 546.4 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10776.60 Median:10776.60 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: Values: 10776.6 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24095.24 Median:24095.24 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: Values: 24095.2 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,399 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.67 Median:518.67 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: Values: 518.7 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: Values: 4822.1 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:13:12 INFO - 2016-02-08 14:13:12,400 DEBUG : BROWSER_OUTPUT: 14:13:13 INFO - 2016-02-08 14:13:13,061 INFO : Browser exited with error code: 0 14:13:13 INFO - 2016-02-08 14:13:13,078 INFO : Completed test v8_7 (00:00:38) 14:13:13 INFO - 2016-02-08 14:13:13,450 INFO : Completed test suite (00:20:06) 14:13:13 INFO - 2016-02-08 14:13:13,450 DEBUG : Working with test: dromaeo_css 14:13:13 INFO - 2016-02-08 14:13:13,450 DEBUG : Generating results file: dromaeo_css 14:13:13 INFO - 2016-02-08 14:13:13,451 DEBUG : Working with test: kraken 14:13:13 INFO - 2016-02-08 14:13:13,451 DEBUG : Generating results file: kraken 14:13:13 INFO - 2016-02-08 14:13:13,452 INFO : javascript benchmark 14:13:13 INFO - 2016-02-08 14:13:13,452 DEBUG : Working with test: v8_7 14:13:13 INFO - 2016-02-08 14:13:13,452 DEBUG : Generating results file: v8_7 14:13:13 INFO - 2016-02-08 14:13:13,452 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:13 INFO - 2016-02-08 14:13:13,498 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 14:13:13 INFO - 2016-02-08 14:13:13,498 DEBUG : process_Request line: dromaeo_css 7221.21 graph.html#tests=[[72,53,35]] 14:13:13 INFO - 2016-02-08 14:13:13,498 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:13 INFO - 2016-02-08 14:13:13,524 DEBUG : process_Request line: kraken 1478.10 graph.html#tests=[[232,53,35]] 14:13:13 INFO - 2016-02-08 14:13:13,524 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:13 INFO - 2016-02-08 14:13:13,557 DEBUG : process_Request line: v8_7 23175.10 graph.html#tests=[[230,53,35]] 14:13:13 INFO - 2016-02-08 14:13:13,559 INFO : javascript benchmark 14:13:13 INFO - 2016-02-08 14:13:13,563 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3315.088350703557, 3379.138319728469, 3407.7614566980305, 3414.078198886301, 3446.6553344665535, 5462.0441422751055, 5590.161475778636, 5602.075657516505, 5609.2988376452895, 5629.071203251458, 5583.804566840151, 5632.0, 5644.830655080344, 5654.0, 5655.4910058094765, 4893.926591101136, 5091.23631455281, 5134.691918484884, 5190.844274671747, 5258.605604579653, 5054.570361519257, 5076.517730815566, 5080.949190508103, 5090.440051594322, 5091.414487333967, 4971.825986090469, 5035.899282014358, 5094.566961808251, 5100.974495127519, 5101.974490127544, 5124.615653825959, 5135.974320128413, 5196.714180720059, 5205.063088644042, 5213.791448342062, 5017.598592112622, 5084.262781896604, 5086.4659210783075, 5114.028334616411, 5135.794568217267, 5208.5572726318305, 5310.389305229871, 5320.5211530962015, 5379.623426360156, 5398.946010539884, 5946.8810623787285, 6062.878742425127, 6064.545159113084, 6068.362821903725, 6083.0, 6090.086487026937, 6093.512518998469, 6121.785737499166, 6124.958757011319, 6125.571210015256, 5461.644993075437, 5526.861828454321, 5552.250446189753, 5615.298087739033, 5620.634658747168, 6021.849453763691, 6059.1820104286235, 6061.727222275008, 6062.696865156725, 6065.727042283108, 5886.941130588725, 5890.676012819336, 5902.6458412495385, 5904.498117659961, 5908.113782932594, 5786.537077033827, 5871.266091738533, 5965.194698715618, 6042.697865106815, 6073.1497590337385, 6061.969690151521, 6080.817575472743, 6080.847978800565, 6085.908711369245, 6088.360722124113, 5798.710064496759, 6048.818535443944, 6072.787452439232, 6074.726637301332, 6075.726592303357, 4445.73325600465, 4542.886427839265, 4593.19619066662, 4593.839215627437, 4621.907561848811, 4053.2298863215897, 4078.0824314528995, 4093.9795301023305, 4105.712600117963, 4108.301588729923, 5431.158170483582, 5527.668339899619, 5679.801206957736, 5680.5171560417, 5688.63023903445, 5982.0727787193055, 6044.546659000593, 6069.757209711562, 6103.05402662588, 6112.602680825732, 5659.320881494247, 5661.716914154275, 5663.8867222656145, 5666.206731057655, 5666.914996275059, 4816.373871396696, 4898.191798353303, 4931.0630980113665, 4970.527799859007, 4992.725400102957, 6268.717907694165, 6272.686365681698, 6273.278572964167, 6274.811755647338, 6288.182536270256, 6059.21230240066, 6063.5452341073715, 6064.241969753781, 6064.302605200459, 6078.5441091919165, 5944.73248703818, 6105.450509453993, 6119.724612392364, 6203.472704820141, 6266.843328916813, 5960.135780311917, 6021.789237376671, 6052.727627256872, 6061.666608336407, 6071.241094863142, 6121.387861213843, 6138.416850399205, 6153.323134455296, 6153.415425534746, 6159.414855588712, 5718.771249149988, 5769.798057067983, 5850.64896106235, 5870.735816888165, 5907.40925907423, 5794.7102644866745, 5856.238688970407, 5869.7945571904775, 5885.411458854081, 5892.086726557391, 5546.251256080377, 5789.421057894346, 5799.3040835100055, 5816.76732930678, 5821.534277257894, 5698.0598201296325, 5755.827325180251, 5855.765769369348, 5869.7945571904775, 5896.056630939029, 5769.567282453917, 5803.82588522345, 5850.912236316373, 5859.531237500904, 5860.38465961085], "unit": "ms", "name": "dojo.html", "value": 5527.138917742762}, {"lowerIsBetter": false, "replicates": [630.0769372868747, 635.4471609699563, 635.7329921432997, 638.2659941067772, 645.5642441352086, 40138.19723605526, 40654.79672601633, 40895.0, 40924.79537602308, 40929.38605920914, 46151.0, 46471.30293045607, 46577.30134047992, 46583.76708116463, 46768.76615616926, 8161.918380816205, 8281.047679516872, 8933.374663773522, 9105.68130115446, 9113.95443022784, 10668.30656007361, 10816.134709223243, 10888.564457421693, 10889.237753357229, 10903.454827258645, 10237.385756854612, 10319.793604127914, 10326.896731032668, 10330.586776528968, 10333.328333658288, 10568.260221784478, 10671.626493072705, 10679.519421626046, 10681.465926703711, 10684.839727404056, 10537.84193237102, 10648.307859989154, 10659.467026648637, 10666.466676666136, 10676.572937082507, 42235.36646950298, 42626.147477050596, 42748.358774618406, 42752.0, 42773.57226427758, 3124.125244931423, 3184.41088398647, 3227.7579181561478, 3271.8691252349877, 3330.2673411849596, 32703.50944735831, 32829.0, 33057.6694233057, 33223.16942076467, 33227.33545329104, 4263.680223983214, 4324.372965919955, 4387.692861499696, 4417.182821178092, 4423.358613001097, 303455.0, 304451.0, 306536.0, 307381.0, 310500.4474977633, 57960.42039579635, 65753.67123164449, 66156.33843661597, 66203.68287109928, 66255.66872165704, 49550.50449495531, 50807.23789143166, 75171.0, 77198.61400692961, 77249.0, 18327.0, 18406.0, 18450.07749612514, 18457.0, 18600.069996500122, 14019.859801401855, 14092.506762263272, 14094.154350738989, 14100.0, 14100.435982560582, 20641.0, 20909.790902090783, 20968.685469717966, 21064.894675526524, 21095.578088438146, 7664.348530374869, 7753.689852405841, 7831.725889593837, 7894.960525197337, 7925.762227133196, 992.1467537917385, 1029.7940411917646, 1068.6847380022912, 1078.719532921446, 1090.607381342716, 29351.55972660412, 29556.704432955394, 29590.556141657893, 30550.847245763627, 30634.69365306363, 1115.642994241851, 1160.5357856857324, 1169.8479197704414, 1194.8745381734793, 1203.7231436769591, 13697.794533082011, 15292.311845966959, 15374.385024599114, 15669.764953525706, 16423.096729679743, 346227.0, 350887.0, 351083.0, 351748.0, 352619.0, 57548.71225643845, 57758.42241577614, 57811.421885780604, 57862.421375786544, 57882.131768023515, 1286.414681319997, 1341.081359268904, 1443.1052747296744, 1478.0909740509724, 1482.021865568741, 27277.86361068182, 27454.0, 27711.722882770915, 27887.0, 28230.15309540717, 41338.79330603328, 41470.377944330256, 41812.0, 41889.0, 41918.58081419147, 198338.0, 200380.0, 201785.0, 202051.0, 202103.0, 31500.36999259956, 32140.19649508781, 32198.35603287968, 32213.0, 32321.35357292794, 43066.56933430626, 43220.78389608032, 44037.559624403344, 44087.55912440835, 44184.0, 36520.45219321659, 36987.26025479529, 37562.24875502529, 37969.0, 37987.43018854775, 36689.26621467609, 36798.080047999014, 37544.249115018094, 37750.43374349442, 37784.62215377921, 36341.63658363382, 37209.25581488409, 37266.8136659315, 37368.43947340846, 37383.0, 33119.66880331166, 33720.49419258762, 34133.65866341305, 34459.82770086134, 34784.0, 24409.877950610135, 25982.74017259803, 27066.729332707208, 27535.586966195122, 28587.14238572846], "unit": "ms", "name": "ext.html", "value": 19645.318117076677}, {"lowerIsBetter": false, "replicates": [369.8132443116228, 373.5722597625719, 373.771999080561, 374.6085340818844, 375.4480913057805, 15579.065256084614, 15588.142652154127, 17405.12974351282, 18826.435206943795, 19462.805371946295, 10592.152627789777, 17080.402185923496, 17227.82772172278, 17250.82749172508, 17563.12184390782, 5087.49125087491, 5104.66819656723, 5220.164773636219, 5223.764930578133, 5246.842594722146, 4008.3386241270155, 4116.547179810218, 5592.748326325304, 5719.942800572004, 5732.168835518847, 5675.148727690838, 5689.345725241588, 5711.543076553887, 5711.685857277848, 5716.828495145152, 5309.469053094679, 5433.565314774809, 5457.890842183174, 5461.208124821878, 5461.617686761928, 5258.605604579634, 5265.368155821326, 5298.788048478056, 5421.268128802601, 5463.2078348639225, 20925.430592705456, 21112.15551377943, 21123.0, 21570.784292157034, 21597.0, 2279.4871153990384, 2300.332903457995, 2303.37808791627, 2329.0, 2350.6003979323555, 9923.90076099237, 9979.0, 9994.9500252499, 10119.949400253025, 10287.897121028844, 1909.3603642779685, 1927.60484100759, 1964.1161477335113, 2007.9598408031757, 2023.8482113841521, 64362.678186609235, 64735.676321618565, 64837.35162648407, 66226.3377366225, 66806.66596667033, 11029.503672334604, 11139.275947063416, 11197.0, 11237.943810280896, 11288.774224515464, 14777.261136943325, 14837.10977341363, 14876.628084297763, 14881.0, 14932.477363292233, 8487.957560212159, 8548.700795472128, 8596.140385961478, 8662.653493860174, 8664.176903194186, 8421.831563368698, 8436.156384361515, 8436.957815211008, 8459.069502354736, 8508.617112229964, 4688.109259240733, 4688.531146885284, 4706.223473126965, 4711.3639658646325, 4783.56947874686, 1760.2726322471597, 1804.2151664026192, 1850.148931491502, 1947.221111555361, 1953.2284747524648, 897.4435849773182, 958.4249450329746, 1007.6171054999054, 1043.7495001199657, 1044.1333693034762, 14190.645233869236, 16130.596735081483, 17505.387311444294, 17508.737368939477, 17641.7353739694, 954.117441366733, 956.9952150239204, 968.1335204991493, 1003.4481035430484, 1011.2668315471225, 9694.854577181348, 9958.477197435692, 9968.900310996942, 10247.538860751283, 10329.225308101923, 585576.0, 612167.0, 626473.0, 626611.0, 629245.0, 76660.61669691616, 79152.60423697844, 79247.20752792513, 81026.59486702646, 81895.5905220482, 1106.5463160104157, 1109.439732934879, 1152.302856771641, 1160.7794519041356, 1161.59344229519, 15578.29897654631, 15891.0, 15983.44057957966, 16002.439914602934, 16129.193540323171, 35310.646893530735, 35996.64003360038, 36028.639713602526, 36067.27865442729, 37075.8146209278, 43297.13405731805, 44007.119857603306, 44111.0, 44515.0, 48674.0, 10196.0, 10424.270301078852, 10428.634997775041, 10525.052745252964, 10590.682279531626, 17807.109644517463, 17845.10774461298, 18155.546111346794, 18444.07779611041, 18737.71893421627, 14411.495597654031, 15010.324535396152, 15051.397944082551, 15095.169765662993, 15594.220288985733, 14025.29873506341, 14791.852081479477, 14906.32921518556, 14921.776173357626, 14923.701525969636, 11643.53425862956, 12079.094067944763, 13437.0, 15875.0, 15929.442469513511, 9118.635254589743, 9443.291753118407, 9458.668946586837, 9793.755156121155, 10201.84697229557, 14594.781078284046, 14834.035787673767, 14854.777178342118, 14896.180710061051, 15349.693006140038], "unit": "ms", "name": "jquery.html", "value": 9240.619258917463}, {"lowerIsBetter": false, "replicates": [1547.8297387287396, 1556.2841093097168, 1744.5289771761616, 1798.785819571789, 1831.441410369837, 7738.651760670769, 7986.520808751479, 7994.720184793533, 7996.0, 7999.4800337977995, 7812.921870781291, 7900.328472079866, 7906.802329941755, 7908.92091079089, 7913.2086791320835, 2279.623862062758, 2287.862728236307, 2333.649952507129, 2334.5214231082587, 2335.1710142899283, 2339.040993192791, 2370.111208296889, 2370.8340416170877, 2371.9169829055986, 2371.95256094878, 2069.048237810609, 2107.2203284784573, 2271.432141964509, 2295.231097582312, 2361.0, 2304.2626359564947, 2314.652802079693, 2316.0388438797877, 2327.7323107842476, 2341.5785158671433, 2271.716035495563, 2301.4131396493954, 2318.826088043387, 2319.826013049011, 2323.5352929414016, 6967.721291148348, 7104.25405332443, 7555.2067032961295, 7710.113336966265, 7712.498687585289, 4736.407949006374, 4789.353437285991, 4790.257510085942, 4791.904161916777, 4828.203346447832, 3026.1678038539576, 3100.1319630503494, 3146.0719087869134, 3146.8583913723937, 3160.936781264362, 979.4759803505161, 986.7582442301682, 990.4601991914424, 996.2179688944217, 1032.7418145463635, 10343.275970682056, 10470.685879423629, 10472.947635261851, 10473.0, 10474.26680132391, 4132.194222126656, 4134.524529679065, 4221.894452638647, 4242.66058715302, 4252.532221455637, 8896.510691912006, 8952.194302512806, 8960.148785865333, 8962.551872406353, 8985.550722463851, 4666.323383109498, 4715.104130215248, 4718.834840780556, 4723.102610503994, 4723.83466578675, 4377.474703035656, 4378.321360189176, 4383.167198232326, 4383.671224658164, 4388.0, 3512.4204506256183, 3574.249407624376, 3594.191306955914, 3606.441001644749, 3611.8013509256716, 1076.725435014082, 1080.378782200238, 1090.8636420447444, 1096.616184335492, 1098.8351747237818, 933.5332333833084, 962.6101428921298, 1066.594694016269, 1088.6407485529755, 1090.2858627598935, 7329.9267007329245, 7357.0, 7357.558546487228, 7362.742304019441, 7377.594232317167, 507.6573313013701, 507.83241530294913, 514.4264145477765, 515.2142981952477, 517.503196930943, 5900.498457631149, 5975.611585246945, 6055.848603784941, 6060.878782424327, 6095.177151084636, 9068.8639670405, 9254.768630784285, 9372.297077719062, 9380.437173769596, 9392.201662858597, 9076.273898088137, 9109.863352049724, 9274.489903055262, 9276.536173191313, 9282.071792820663, 7197.640117994184, 7307.817304567428, 7345.338919497271, 7350.705971761176, 7366.521176123642, 6874.759383421556, 6947.756828510978, 6980.930190698028, 7002.474814388839, 7029.156501219886, 8057.0734365548715, 8154.510729356258, 8381.832363352576, 8383.916160838558, 8391.538465384463, 8330.208630180123, 8522.659093636184, 8526.062133165222, 8539.274161696077, 8681.565921704016, 6758.357955994173, 6780.966095169492, 6785.728570857308, 6856.040154378291, 6864.279250678607, 7473.588952607659, 7526.209747976603, 7570.545767253982, 7596.050493688289, 7637.274458926393, 7090.893636595559, 7100.822479438056, 7172.641367931478, 7185.425165986604, 7317.707291708272, 6986.476014298846, 7044.260352663102, 7086.610236437045, 7122.60825654594, 7169.928300716926, 7156.320149585781, 7182.389496892613, 7211.350978411968, 7213.062301900719, 7218.566885986857, 6761.154855643044, 6787.796366108827, 6854.520183587101, 6878.0, 6882.414994725505, 6099.9390006099375, 6239.438450539473, 6530.118434011348, 6591.604503729792, 6611.0], "unit": "ms", "name": "mootools.html", "value": 4397.270615852598}, {"lowerIsBetter": false, "replicates": [343.1917833502104, 344.7948470659958, 345.8409131799372, 352.5821901047258, 353.9946900796489, 6010.849728756783, 6089.695515224232, 6140.416660417259, 6148.907766383508, 6160.353162917896, 5761.107028410603, 5878.1476685880525, 5939.227900372956, 5998.310194327653, 6018.6689732064715, 4651.325557794118, 4676.321933319684, 4692.8122875084955, 4694.90610187796, 4700.6004489618335, 4674.111918735446, 4691.366665500148, 4691.624670026406, 4695.694779839299, 4698.624110071186, 4491.932621010687, 4531.297648864432, 4572.0, 4643.187442197619, 4671.696339737906, 4627.07458508298, 4643.373144625466, 4650.046740418206, 4656.952185758211, 4660.137874493195, 4111.691623128248, 4116.670666346685, 4117.094239267356, 4117.608827161444, 4125.422440858282, 5708.400617935098, 5722.7424765885635, 5733.082706766939, 5735.971320143414, 5746.511546518551, 5238.449962753933, 5399.62202645815, 5401.513863752281, 5442.863928401782, 5451.536619387357, 6384.361563843625, 6394.58435201715, 6395.456386207178, 6395.77614783485, 6396.776112836028, 4543.954560454386, 4548.0221752323405, 4549.158405694924, 4552.68131230814, 4556.612687921531, 6466.062420948983, 6543.378379053982, 6606.867862642768, 6610.008498725181, 6625.370589793962, 4512.458504979358, 4514.503404625489, 4516.864494065183, 4517.683762136685, 4518.0, 4556.476005259371, 4569.017661202791, 4573.588377046081, 4574.199515084847, 4577.427821522309, 5303.628745987821, 5303.893922121536, 5308.071087559739, 5309.5752339812725, 5314.441983591667, 6330.3669633036325, 6438.678066096676, 6442.26058964077, 6454.096426500294, 6459.515536334699, 1632.2491653839368, 1643.753436984438, 1644.9095299758628, 1645.3336398758522, 1645.8765592580605, 1090.536521978172, 1114.6043154680135, 1115.1914861725347, 1137.0505627800715, 1142.5144313666658, 6249.6562689051625, 6252.062190671436, 6261.499080073583, 6264.310925798159, 6272.372762723691, 6633.933660663428, 6661.966690166518, 6666.566673166229, 6670.699818508178, 6678.465722742169, 6024.789132380346, 6116.755329786848, 6229.470495007975, 6327.209098862642, 6332.588381755171, 3564.055525285801, 3576.159602493412, 3580.6393570443065, 3581.9641803582153, 3582.46263060543, 6943.409810166192, 6947.166340039126, 6947.305269473113, 6951.7914462566205, 6966.3730264276455, 6611.074449577063, 6854.485913556503, 6855.622940738307, 6865.759698410631, 6865.9313406866295, 6958.130233720785, 6961.895571566431, 6964.895526567106, 6973.442124629916, 6975.407090397373, 6570.671466426564, 6693.497987651043, 6699.598024118569, 6703.66481675924, 6706.865862682816, 6597.868042639217, 6598.802035938929, 6611.702473388806, 6614.603123812587, 6621.205455345389, 6964.756233531802, 6974.7210111597, 6976.197737260077, 6979.790606281819, 6979.965100174467, 4550.499445061107, 4565.0413413183605, 4571.657125715651, 4572.085582883503, 4576.153411618861, 6549.377809108127, 6697.0, 6700.865982680417, 6705.195376554844, 6706.865862682816, 6481.287058423664, 6483.157189565326, 6485.221773387224, 6488.188976377953, 6489.545731798728, 6349.016321481393, 6463.935360646334, 6481.7731379403385, 6482.611043337415, 6491.4806815455595, 6363.300036996019, 6393.840153996187, 6398.488120950406, 6398.936010639834, 6405.4058106466955, 6508.9349106508325, 6521.380468855451, 6523.934760652332, 6525.0, 6534.4772418205475, 6189.1025801257665, 6371.299157092623, 6383.585066970632, 6396.232452105777, 6400.839979000562], "unit": "ms", "name": "prototype.html", "value": 4875.951913368413}, {"lowerIsBetter": false, "replicates": [792.8612492813758, 794.9999999999999, 809.2271880354263, 838.4508147163602, 878.5431575580702, 13410.329483525822, 13507.932460337697, 13551.322433878317, 13574.728505429886, 13605.319734013297, 12652.746945061093, 12670.746585068293, 12742.23546587203, 12754.80867786984, 12767.233965962048, 736.8378956629533, 744.5644298085626, 862.9482231066156, 866.0516734176067, 877.8112705768259, 879.9560021998907, 881.5944665453899, 883.1168831168832, 886.9068747781487, 887.0508555845248, 769.5921161784263, 868.9478631282112, 916.1479823763897, 920.8664743612172, 923.7505873414174, 774.7598244544181, 893.5978809535735, 909.4361495872602, 911.1389736698856, 911.1981456318398, 675.6115233740619, 676.8781619308522, 677.4918810891832, 678.108287601807, 680.2890978927034, 12603.117781755282, 12671.683207919876, 12675.239485630891, 12692.492300307977, 12729.872701272961, 12256.325902075383, 12632.17890837102, 12686.238825670489, 14089.225092619901, 14260.786088208684, 10376.533056012497, 10876.782464350748, 10970.232083754141, 11288.266262692981, 11337.206395552315, 3833.731638785286, 3838.1747924196434, 3860.247251785903, 3890.591487893787, 3975.026118600961, 48330.99999999965, 48984.0, 49084.50915490871, 49277.26084108741, 50246.0, 10173.643922462677, 10186.236032297607, 10204.591816327413, 10321.122704570045, 10418.374897506174, 16332.183390830649, 16370.754438683429, 16378.181090945405, 16392.098434586213, 16396.016239025696, 7919.485233459806, 8008.119106898236, 8110.107888132301, 8140.389470789714, 8215.178482151738, 4606.170889239902, 4793.592544633745, 4846.5153484651255, 4876.68720218507, 4888.071266459361, 2974.5538169274782, 2990.1777011321624, 2999.0403071017067, 3001.0996700989617, 3003.4743919813945, 550.5265471694339, 566.2751677852356, 566.7194738604417, 573.0859279449272, 579.2383016333508, 596.4691424632081, 630.8675926711563, 659.864727730814, 693.8889777635554, 733.6625152429942, 8289.58552072394, 8289.95855020721, 8485.278751306085, 8790.912090879137, 8792.912070879338, 674.9223839258548, 683.7401787320787, 694.0560837261321, 722.3967986731034, 734.4711807498593, 4119.361498967664, 4452.8218871245435, 4604.493505714436, 4608.493065762764, 4633.096546173531, 52582.47417525776, 52732.73633631807, 52809.47190528122, 52959.0, 52992.73503632457, 47972.28041579379, 54537.0, 54774.178387324224, 55143.72428137914, 55805.72097139488, 47328.763356183685, 49174.75412622842, 49190.50809491931, 49228.75385623049, 50183.74908125436, 9096.0, 9112.316576256675, 9355.53222338894, 9497.667581634609, 9620.278479114235, 35883.28233435369, 36283.0, 36943.81528092342, 37181.62818371782, 37377.25245495129, 43395.132097357244, 43432.34851477167, 47264.7636761814, 47540.52459475361, 47685.52314476811, 11669.824952625548, 11688.824667630162, 12025.818818983707, 12229.205101668364, 12277.570285039981, 13201.867981320063, 13211.075224734177, 13365.198088114745, 13465.528706495226, 13658.521951731642, 12831.679208019874, 12863.871361286641, 12883.0, 12932.547360842325, 13405.463781448632, 11959.880401195876, 12006.879931200925, 12042.819357709466, 12222.20555663879, 12588.244705317711, 12311.199772015148, 12618.936905315415, 12626.747465050832, 12783.93608031954, 13126.212427254395, 10707.357558546511, 10753.946230268799, 10945.671629851116, 10983.39591322485, 10995.945020274847, 10243.180545556188, 10345.896541034494, 10768.0847127995, 10875.401852898167, 10880.510377033212], "unit": "ms", "name": "yui.html", "value": 6590.489562995587}], "name": "dromaeo_css", "value": 7221.214179568244}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 108.0, 110.0, 110.0, 100.0, 109.0, 112.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 106.7}, {"lowerIsBetter": true, "replicates": [153.0, 124.0, 146.0, 162.0, 121.0, 147.0, 161.0, 123.0, 169.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [158.0, 160.0, 161.0, 160.0, 161.0, 161.0, 164.0, 159.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 77.0, 73.0, 150.0, 73.0, 71.0, 71.0, 71.0, 157.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 138.0, 92.0, 92.0, 92.0, 137.0, 93.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 57.0, 57.0, 57.0, 58.0, 59.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 79.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.1}, {"lowerIsBetter": true, "replicates": [109.0, 117.0, 116.0, 107.0, 121.0, 114.0, 134.0, 122.0, 114.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [149.0, 134.0, 141.0, 147.0, 147.0, 135.0, 143.0, 142.0, 143.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 62.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1478.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.80110592707794], "unit": "score", "name": "Richards", "value": 204.29267399999998}, {"lowerIsBetter": false, "replicates": [164.5548790521639], "unit": "score", "name": "DeltaBlue", "value": 401.79908599999993}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [963.3911368015414], "unit": "score", "name": "RayTrace", "value": 768.1085820000003}, {"lowerIsBetter": false, "replicates": [546.448087431694], "unit": "score", "name": "Earley", "value": 1219.6272900000001}, {"lowerIsBetter": false, "replicates": [10776.595744680852], "unit": "score", "name": "Boyer", "value": 61.84355577492594}, {"lowerIsBetter": false, "replicates": [24095.238095238095], "unit": "score", "name": "RegExp", "value": 37.80767786561265}, {"lowerIsBetter": false, "replicates": [518.6721991701245], "unit": "score", "name": "Splay", "value": 157.114648}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23175.103474601012}]} 14:13:13 INFO - RETURN: dromaeo_css: 7221.21 14:13:13 INFO - RETURN: kraken: 1478.10 14:13:13 INFO - RETURN: v8_7: 23175.10 14:13:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23175.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1478.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7221.21"}}} 14:13:13 INFO - Return code: 0 14:13:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:13:13 INFO - # TBPL SUCCESS # 14:13:13 INFO - Running post-action listener: _resource_record_post_action 14:13:13 INFO - Running post-run listener: _resource_record_post_run 14:13:14 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 602112; Write bytes: 279175168; Read time: 180; Write time: 147672 14:13:14 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13553664; Read time: 0; Write time: 3892 14:13:14 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 602112; Write bytes: 265621504; Read time: 180; Write time: 143780 14:13:14 INFO - Running post-run listener: _upload_blobber_files 14:13:14 INFO - Blob upload gear active. 14:13:14 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:13:14 INFO - Copying logs to upload dir... 14:13:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.027839 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-08 14:13:14.682550) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:14.685654) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010033 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454958684/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-08 14:13:14.737426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:14.737777) ========= 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=6dbc10da6d83fee962c624be000001a8-1454965597.558012-1776419243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 14:13:14.787025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 14:13:14.787383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 14:13:14.787688) ========= ========= Total master_lag: 0.25 =========