builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1454015065.29 results: success (0) buildid: 20160128102727 builduid: ed03e7efca0949f591e7db9d5e0c8df5 revision: 1241ef0ab5da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.292952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.293671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.294178) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004894 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.343805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.344154) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.375539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.375842) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027873 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.423249) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.423554) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:25.423893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 13:04:25.424158) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-28 13:04:26-- 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% 230M=0s 2016-01-28 13:04:26 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150217 ========= master_lag: 0.95 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-28 13:04:26.525314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:26.525978) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.205765 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:26.742996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:26.743334) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1241ef0ab5da --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 1241ef0ab5da --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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-28 13:04:27,755 Setting DEBUG logging. 2016-01-28 13:04:27,755 attempt 1/10 2016-01-28 13:04:27,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1241ef0ab5da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 13:04:28,186 unpacking tar archive at: mozilla-beta-1241ef0ab5da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:27.477664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:27.478016) ========= echo 1241ef0ab5da in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1241ef0ab5da'] 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1241ef0ab5da program finished with exit code 0 elapsedTime=0.004763 script_repo_revision: '1241ef0ab5da' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:27.528219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:27.528550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 13:04:27.538375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-28 13:04:27.538683) ========= /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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:04:28 INFO - MultiFileLogger online at 20160128 13:04:28 in /builds/slave/test-pgo 13:04:28 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:04:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:04:28 INFO - {'append_to_log': False, 13:04:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:04:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:04:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:04:28 INFO - 'branch': 'Mozilla-Beta', 13:04:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:28 INFO - 'config_files': ('talos/linux_config.py',), 13:04:28 INFO - 'default_actions': ('clobber', 13:04:28 INFO - 'read-buildbot-config', 13:04:28 INFO - 'download-and-extract', 13:04:28 INFO - 'populate-webroot', 13:04:28 INFO - 'create-virtualenv', 13:04:28 INFO - 'install', 13:04:28 INFO - 'run-tests'), 13:04:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:28 INFO - 'download_minidump_stackwalk': True, 13:04:28 INFO - 'download_symbols': 'ondemand', 13:04:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:28 INFO - 'installer_path': 'installer.exe', 13:04:28 INFO - 'log_level': 'info', 13:04:28 INFO - 'log_name': 'talos', 13:04:28 INFO - 'log_to_console': True, 13:04:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:04:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:04:28 INFO - 'opt_config_files': (), 13:04:28 INFO - 'pip_index': False, 13:04:28 INFO - 'sps_profile': False, 13:04:28 INFO - 'sps_profile_interval': 0, 13:04:28 INFO - 'suite': 'dromaeojs', 13:04:28 INFO - 'system_bits': '32', 13:04:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:28 INFO - 'title': 'talos-linux64-ix-050', 13:04:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:28 INFO - 'use_talos_json': True, 13:04:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:04:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:28 INFO - 'work_dir': 'build'} 13:04:28 INFO - ##### 13:04:28 INFO - ##### Running clobber step. 13:04:28 INFO - ##### 13:04:28 INFO - Running pre-action listener: _resource_record_pre_action 13:04:28 INFO - Running main action method: clobber 13:04:28 INFO - rmtree: /builds/slave/test-pgo/build 13:04:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:04:29 INFO - Running post-action listener: _resource_record_post_action 13:04:29 INFO - ##### 13:04:29 INFO - ##### Running read-buildbot-config step. 13:04:29 INFO - ##### 13:04:29 INFO - Running pre-action listener: _resource_record_pre_action 13:04:29 INFO - Running main action method: read_buildbot_config 13:04:29 INFO - Using buildbot properties: 13:04:29 INFO - { 13:04:29 INFO - "properties": { 13:04:29 INFO - "buildnumber": 91, 13:04:29 INFO - "product": "firefox", 13:04:29 INFO - "script_repo_revision": "production", 13:04:29 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:04:29 INFO - "repository": "", 13:04:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:04:29 INFO - "buildid": "20160128102727", 13:04:29 INFO - "slavename": "talos-linux64-ix-050", 13:04:29 INFO - "pgo_build": "True", 13:04:29 INFO - "basedir": "/builds/slave/test-pgo", 13:04:29 INFO - "project": "", 13:04:29 INFO - "platform": "ubuntu64_hw", 13:04:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:04:29 INFO - "slavebuilddir": "test", 13:04:29 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:04:29 INFO - "branch": "mozilla-beta", 13:04:29 INFO - "repo_path": "releases/mozilla-beta", 13:04:29 INFO - "stage_platform": "linux64-pgo", 13:04:29 INFO - "builduid": "ed03e7efca0949f591e7db9d5e0c8df5", 13:04:29 INFO - "revision": "1241ef0ab5da" 13:04:29 INFO - }, 13:04:29 INFO - "sourcestamp": { 13:04:29 INFO - "repository": "", 13:04:29 INFO - "hasPatch": false, 13:04:29 INFO - "project": "", 13:04:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:04:29 INFO - "changes": [ 13:04:29 INFO - { 13:04:29 INFO - "category": null, 13:04:29 INFO - "files": [ 13:04:29 INFO - { 13:04:29 INFO - "url": null, 13:04:29 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2" 13:04:29 INFO - } 13:04:29 INFO - ], 13:04:29 INFO - "repository": "", 13:04:29 INFO - "rev": "1241ef0ab5da", 13:04:29 INFO - "who": "sendchange", 13:04:29 INFO - "when": 1454014944, 13:04:29 INFO - "number": 7531207, 13:04:29 INFO - "comments": "Bug 1243612 - promptCount is undefined on beta. r=jaws a=sledru", 13:04:29 INFO - "project": "", 13:04:29 INFO - "at": "Thu 28 Jan 2016 13:02:24", 13:04:29 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 13:04:29 INFO - "revlink": "", 13:04:29 INFO - "properties": [ 13:04:29 INFO - [ 13:04:29 INFO - "buildid", 13:04:29 INFO - "20160128102727", 13:04:29 INFO - "Change" 13:04:29 INFO - ], 13:04:29 INFO - [ 13:04:29 INFO - "builduid", 13:04:29 INFO - "ed03e7efca0949f591e7db9d5e0c8df5", 13:04:29 INFO - "Change" 13:04:29 INFO - ], 13:04:29 INFO - [ 13:04:29 INFO - "pgo_build", 13:04:29 INFO - "True", 13:04:29 INFO - "Change" 13:04:29 INFO - ] 13:04:29 INFO - ], 13:04:29 INFO - "revision": "1241ef0ab5da" 13:04:29 INFO - } 13:04:29 INFO - ], 13:04:29 INFO - "revision": "1241ef0ab5da" 13:04:29 INFO - } 13:04:29 INFO - } 13:04:29 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2. 13:04:29 INFO - Running post-action listener: _resource_record_post_action 13:04:29 INFO - ##### 13:04:29 INFO - ##### Running download-and-extract step. 13:04:29 INFO - ##### 13:04:29 INFO - Running pre-action listener: _resource_record_pre_action 13:04:29 INFO - Running main action method: download_and_extract 13:04:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:04: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:04:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/test_packages.json 13:04:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:04:29 INFO - Downloaded 1270 bytes. 13:04:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:04:29 INFO - Using the following test package requirements: 13:04:29 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:04:29 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:04:29 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'jsshell-linux-x86_64.zip'], 13:04:29 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:04:29 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:04:29 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 13:04:29 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 13:04:29 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:04:29 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 13:04:29 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 13:04:29 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:04:29 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:04: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:04:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:04:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:38 INFO - Downloaded 21580964 bytes. 13:04:38 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:04:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:04:38 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:04:39 INFO - Return code: 0 13:04:39 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:04:39 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:04:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:04:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:39 INFO - Downloaded 21580964 bytes. 13:04:39 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:04:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 13:04:39 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:04:40 INFO - Return code: 0 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:04:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:04:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:43 INFO - Downloaded 11132038 bytes. 13:04:43 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:04:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 13:04:43 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:04:43 INFO - Return code: 0 13:04:43 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:04:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:04:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/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:04:56 INFO - Downloaded 57946183 bytes. 13:04:56 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:04:56 INFO - mkdir: /builds/slave/test-pgo/properties 13:04:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:04:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:04:56 INFO - Contents: 13:04:56 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2 13:04:56 INFO - Running post-action listener: _resource_record_post_action 13:04:56 INFO - Running post-action listener: set_extra_try_arguments 13:04:56 INFO - ##### 13:04:56 INFO - ##### Running populate-webroot step. 13:04:56 INFO - ##### 13:04:56 INFO - Running pre-action listener: _resource_record_pre_action 13:04:56 INFO - Running main action method: populate_webroot 13:04:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:56 INFO - '--tppagecycles', 13:04:56 INFO - '7'], 13:04:56 INFO - 'tests': ['tsvgm']}}, 13:04:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:04:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:04:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'tests': ['damp', 'tps']}, 13:04:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['damp', 'tps']}, 13:04:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:04:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:56 INFO - 'other': {'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'other_l64': {'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'other_nol64': {'tests': ['a11yr', 13:04:56 INFO - 'ts_paint', 13:04:56 INFO - 'tpaint', 13:04:56 INFO - 'sessionrestore', 13:04:56 INFO - 'sessionrestore_no_auto_restore']}, 13:04:56 INFO - 'svgr': {'tests': ['tsvgx', 13:04:56 INFO - 'tsvgr_opacity', 13:04:56 INFO - 'tart', 13:04:56 INFO - 'tscrollx', 13:04:56 INFO - 'cart']}, 13:04:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['tsvgx', 13:04:56 INFO - 'tsvgr_opacity', 13:04:56 INFO - 'tart', 13:04:56 INFO - 'tscrollx', 13:04:56 INFO - 'cart']}, 13:04:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'tests': ['tp5o']}, 13:04:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'talos_options': ['--e10s'], 13:04:56 INFO - 'tests': ['tp5o']}, 13:04:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'talos_options': ['--xperf_path', 13:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:56 INFO - 'tests': ['tp5n']}, 13:04:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:56 INFO - 'talos_options': ['--e10s', 13:04:56 INFO - '--xperf_path', 13:04:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:56 INFO - 'tests': ['tp5n']}}, 13:04:56 INFO - 'talos.zip': {'path': '', 13:04:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:56 INFO - Running post-action listener: _resource_record_post_action 13:04:56 INFO - ##### 13:04:56 INFO - ##### Running create-virtualenv step. 13:04:56 INFO - ##### 13:04:56 INFO - Running pre-action listener: _resource_record_pre_action 13:04:56 INFO - Running main action method: create_virtualenv 13:04:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:04:56 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:04:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:04:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:56 INFO - Using real prefix '/usr' 13:04:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:04:57 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:59 INFO - Installing pip.................done. 13:04:59 INFO - Return code: 0 13:04:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:04:59 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:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:04:59 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:04:59 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:04:59 INFO - Using env: {'DISPLAY': ':0', 13:04:59 INFO - 'HOME': '/home/cltbld', 13:04:59 INFO - 'LANG': 'en_US.UTF-8', 13:04:59 INFO - 'LANGUAGE': 'en_US:en', 13:04:59 INFO - 'LOGNAME': 'cltbld', 13:04:59 INFO - 'MAIL': '/var/mail/cltbld', 13:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:59 INFO - 'MOZ_NO_REMOTE': '1', 13:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:59 INFO - 'NO_EM_RESTART': '1', 13:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:59 INFO - 'SHELL': '/bin/bash', 13:04:59 INFO - 'SHLVL': '1', 13:04:59 INFO - 'TERM': 'linux', 13:04:59 INFO - 'TMOUT': '86400', 13:04:59 INFO - 'USER': 'cltbld', 13:04:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:59 INFO - '_': '/tools/buildbot/bin/python'} 13:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:59 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:04:59 INFO - Cleaning up... 13:04:59 INFO - Return code: 0 13:04:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:04:59 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:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:59 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:04:59 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:04:59 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:04:59 INFO - Using env: {'DISPLAY': ':0', 13:04:59 INFO - 'HOME': '/home/cltbld', 13:04:59 INFO - 'LANG': 'en_US.UTF-8', 13:04:59 INFO - 'LANGUAGE': 'en_US:en', 13:04:59 INFO - 'LOGNAME': 'cltbld', 13:04:59 INFO - 'MAIL': '/var/mail/cltbld', 13:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:59 INFO - 'MOZ_NO_REMOTE': '1', 13:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:04:59 INFO - 'NO_EM_RESTART': '1', 13:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 13:04:59 INFO - 'SHELL': '/bin/bash', 13:04:59 INFO - 'SHLVL': '1', 13:04:59 INFO - 'TERM': 'linux', 13:04:59 INFO - 'TMOUT': '86400', 13:04:59 INFO - 'USER': 'cltbld', 13:04:59 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:59 INFO - '_': '/tools/buildbot/bin/python'} 13:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:59 INFO - Downloading/unpacking psutil>=0.7.1 13:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:04:59 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:05:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:05:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:01 INFO - Installing collected packages: psutil 13:05:01 INFO - Running setup.py install for psutil 13:05:01 INFO - building 'psutil._psutil_linux' extension 13:05:01 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:05:03 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:05:03 INFO - building 'psutil._psutil_posix' extension 13:05:03 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:05:03 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:05:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:05:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:05:03 INFO - Successfully installed psutil 13:05:03 INFO - Cleaning up... 13:05:03 INFO - Return code: 0 13:05:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:03 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:03 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:05:03 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:05:03 INFO - Using env: {'DISPLAY': ':0', 13:05:03 INFO - 'HOME': '/home/cltbld', 13:05:03 INFO - 'LANG': 'en_US.UTF-8', 13:05:03 INFO - 'LANGUAGE': 'en_US:en', 13:05:03 INFO - 'LOGNAME': 'cltbld', 13:05:03 INFO - 'MAIL': '/var/mail/cltbld', 13:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:03 INFO - 'MOZ_NO_REMOTE': '1', 13:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:03 INFO - 'NO_EM_RESTART': '1', 13:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:03 INFO - 'SHELL': '/bin/bash', 13:05:03 INFO - 'SHLVL': '1', 13:05:03 INFO - 'TERM': 'linux', 13:05:03 INFO - 'TMOUT': '86400', 13:05:03 INFO - 'USER': 'cltbld', 13:05:03 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:03 INFO - '_': '/tools/buildbot/bin/python'} 13:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:05:03 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:05:03 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:05:03 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:05:03 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:05:03 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:05:03 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:05:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:05:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:05:05 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:05:05 INFO - Installing collected packages: mozsystemmonitor 13:05:05 INFO - Running setup.py install for mozsystemmonitor 13:05:05 INFO - Successfully installed mozsystemmonitor 13:05:05 INFO - Cleaning up... 13:05:05 INFO - Return code: 0 13:05:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:05: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:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:05 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:05 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:05:05 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:05:05 INFO - Using env: {'DISPLAY': ':0', 13:05:05 INFO - 'HOME': '/home/cltbld', 13:05:05 INFO - 'LANG': 'en_US.UTF-8', 13:05:05 INFO - 'LANGUAGE': 'en_US:en', 13:05:05 INFO - 'LOGNAME': 'cltbld', 13:05:05 INFO - 'MAIL': '/var/mail/cltbld', 13:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:05 INFO - 'MOZ_NO_REMOTE': '1', 13:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:05 INFO - 'NO_EM_RESTART': '1', 13:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:05 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:05 INFO - 'SHELL': '/bin/bash', 13:05:05 INFO - 'SHLVL': '1', 13:05:05 INFO - 'TERM': 'linux', 13:05:05 INFO - 'TMOUT': '86400', 13:05:05 INFO - 'USER': 'cltbld', 13:05:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:05 INFO - '_': '/tools/buildbot/bin/python'} 13:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:05 INFO - Downloading/unpacking blobuploader==1.2.4 13:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:05 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:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:05:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:05:07 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:05:07 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:05:07 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:05:07 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:05:07 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:05:07 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:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:08 INFO - Downloading docopt-0.6.1.tar.gz 13:05:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:05:08 INFO - Installing collected packages: blobuploader, requests, docopt 13:05:08 INFO - Running setup.py install for blobuploader 13:05:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:05:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:05:08 INFO - Running setup.py install for requests 13:05:08 INFO - Running setup.py install for docopt 13:05:08 INFO - Successfully installed blobuploader requests docopt 13:05:08 INFO - Cleaning up... 13:05:08 INFO - Return code: 0 13:05:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:08 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:08 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:05:08 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:05:08 INFO - Using env: {'DISPLAY': ':0', 13:05:08 INFO - 'HOME': '/home/cltbld', 13:05:08 INFO - 'LANG': 'en_US.UTF-8', 13:05:08 INFO - 'LANGUAGE': 'en_US:en', 13:05:08 INFO - 'LOGNAME': 'cltbld', 13:05:08 INFO - 'MAIL': '/var/mail/cltbld', 13:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:08 INFO - 'MOZ_NO_REMOTE': '1', 13:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:08 INFO - 'NO_EM_RESTART': '1', 13:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:08 INFO - 'SHELL': '/bin/bash', 13:05:08 INFO - 'SHLVL': '1', 13:05:08 INFO - 'TERM': 'linux', 13:05:08 INFO - 'TMOUT': '86400', 13:05:08 INFO - 'USER': 'cltbld', 13:05:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:08 INFO - '_': '/tools/buildbot/bin/python'} 13:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:09 INFO - Running setup.py (path:/tmp/pip-oDFaLd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:09 INFO - Running setup.py (path:/tmp/pip-GHc4ro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:09 INFO - Running setup.py (path:/tmp/pip-ZTSLt5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:09 INFO - Running setup.py (path:/tmp/pip-0dXtRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:09 INFO - Running setup.py (path:/tmp/pip-xJAzyU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:09 INFO - Running setup.py (path:/tmp/pip-TOaHTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:09 INFO - Running setup.py (path:/tmp/pip-LX8jJb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:09 INFO - Running setup.py (path:/tmp/pip-h_0gTG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:09 INFO - Running setup.py (path:/tmp/pip-OpjQwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:09 INFO - Running setup.py (path:/tmp/pip-MVznYD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:09 INFO - Running setup.py (path:/tmp/pip-_VxpCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:10 INFO - Running setup.py (path:/tmp/pip-j0qxGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:10 INFO - Running setup.py (path:/tmp/pip-cGJFMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:10 INFO - Running setup.py (path:/tmp/pip-0Z0boc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:10 INFO - Running setup.py (path:/tmp/pip-3xlY1C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:10 INFO - Running setup.py (path:/tmp/pip-DfQFfx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:10 INFO - Running setup.py (path:/tmp/pip-A6MBNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:05:10 INFO - Running setup.py install for manifestparser 13:05:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:05:10 INFO - Running setup.py install for mozcrash 13:05:10 INFO - Running setup.py install for mozdebug 13:05:10 INFO - Running setup.py install for mozdevice 13:05:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:05:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:05:10 INFO - Running setup.py install for mozfile 13:05:10 INFO - Running setup.py install for mozhttpd 13:05:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozinfo 13:05:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozInstall 13:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozleak 13:05:11 INFO - Running setup.py install for mozlog 13:05:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for moznetwork 13:05:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozprocess 13:05:11 INFO - Running setup.py install for mozprofile 13:05:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozrunner 13:05:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:05:11 INFO - Running setup.py install for mozscreenshot 13:05:11 INFO - Running setup.py install for moztest 13:05:12 INFO - Running setup.py install for mozversion 13:05:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:05:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:05:12 INFO - Cleaning up... 13:05:12 INFO - Return code: 0 13:05:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:12 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:12 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:05:12 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:05:12 INFO - Using env: {'DISPLAY': ':0', 13:05:12 INFO - 'HOME': '/home/cltbld', 13:05:12 INFO - 'LANG': 'en_US.UTF-8', 13:05:12 INFO - 'LANGUAGE': 'en_US:en', 13:05:12 INFO - 'LOGNAME': 'cltbld', 13:05:12 INFO - 'MAIL': '/var/mail/cltbld', 13:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:12 INFO - 'MOZ_NO_REMOTE': '1', 13:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:12 INFO - 'NO_EM_RESTART': '1', 13:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:12 INFO - 'SHELL': '/bin/bash', 13:05:12 INFO - 'SHLVL': '1', 13:05:12 INFO - 'TERM': 'linux', 13:05:12 INFO - 'TMOUT': '86400', 13:05:12 INFO - 'USER': 'cltbld', 13:05:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:12 INFO - '_': '/tools/buildbot/bin/python'} 13:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:12 INFO - Running setup.py (path:/tmp/pip-UHrrnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:12 INFO - Running setup.py (path:/tmp/pip-14LC6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:12 INFO - Running setup.py (path:/tmp/pip-Fve0eX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:12 INFO - Running setup.py (path:/tmp/pip-_zh_bK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:12 INFO - Running setup.py (path:/tmp/pip-iAHO0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:12 INFO - Running setup.py (path:/tmp/pip-QO_kSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:12 INFO - Running setup.py (path:/tmp/pip-fB0jLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:12 INFO - Running setup.py (path:/tmp/pip-sZDTlI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:05:12 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:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:12 INFO - Running setup.py (path:/tmp/pip-b6_kxM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:13 INFO - Running setup.py (path:/tmp/pip-1cm4dF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:13 INFO - Running setup.py (path:/tmp/pip-Qa5YbV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:13 INFO - Running setup.py (path:/tmp/pip-6_OisO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:13 INFO - Running setup.py (path:/tmp/pip-KxZ1jt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:13 INFO - Running setup.py (path:/tmp/pip-R6bI8c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:13 INFO - Running setup.py (path:/tmp/pip-Jfjo3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:13 INFO - Running setup.py (path:/tmp/pip-tvygM4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:05:13 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:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:13 INFO - Running setup.py (path:/tmp/pip-vGrQBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 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:05:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:15 INFO - Downloading blessings-1.6.tar.gz 13:05:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:05:15 INFO - Installing collected packages: blessings 13:05:15 INFO - Running setup.py install for blessings 13:05:15 INFO - Successfully installed blessings 13:05:15 INFO - Cleaning up... 13:05:15 INFO - Return code: 0 13:05:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:05:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:05:15 INFO - Reading from file tmpfile_stdout 13:05:15 INFO - Current package versions: 13:05:15 INFO - argparse == 1.2.1 13:05:15 INFO - blessings == 1.6 13:05:15 INFO - blobuploader == 1.2.4 13:05:15 INFO - docopt == 0.6.1 13:05:15 INFO - manifestparser == 1.1 13:05:15 INFO - mozInstall == 1.12 13:05:15 INFO - mozcrash == 0.16 13:05:15 INFO - mozdebug == 0.1 13:05:15 INFO - mozdevice == 0.47 13:05:15 INFO - mozfile == 1.2 13:05:15 INFO - mozhttpd == 0.7 13:05:15 INFO - mozinfo == 0.9 13:05:15 INFO - mozleak == 0.1 13:05:15 INFO - mozlog == 3.1 13:05:15 INFO - moznetwork == 0.27 13:05:15 INFO - mozprocess == 0.22 13:05:15 INFO - mozprofile == 0.27 13:05:15 INFO - mozrunner == 6.11 13:05:15 INFO - mozscreenshot == 0.1 13:05:15 INFO - mozsystemmonitor == 0.0 13:05:15 INFO - moztest == 0.7 13:05:15 INFO - mozversion == 1.4 13:05:15 INFO - psutil == 3.1.1 13:05:15 INFO - requests == 1.2.3 13:05:15 INFO - wsgiref == 0.1.2 13:05:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:05:15 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:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:15 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:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:15 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:15 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:05:15 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:05:15 INFO - Using env: {'DISPLAY': ':0', 13:05:15 INFO - 'HOME': '/home/cltbld', 13:05:15 INFO - 'LANG': 'en_US.UTF-8', 13:05:15 INFO - 'LANGUAGE': 'en_US:en', 13:05:15 INFO - 'LOGNAME': 'cltbld', 13:05:15 INFO - 'MAIL': '/var/mail/cltbld', 13:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:15 INFO - 'MOZ_NO_REMOTE': '1', 13:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:15 INFO - 'NO_EM_RESTART': '1', 13:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:15 INFO - 'SHELL': '/bin/bash', 13:05:15 INFO - 'SHLVL': '1', 13:05:15 INFO - 'TERM': 'linux', 13:05:15 INFO - 'TMOUT': '86400', 13:05:15 INFO - 'USER': 'cltbld', 13:05:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:15 INFO - '_': '/tools/buildbot/bin/python'} 13:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 INFO - Cleaning up... 13:05:16 INFO - Return code: 0 13:05:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:05:16 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:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:16 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:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:16 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 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:16 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:05:16 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:05:16 INFO - Using env: {'DISPLAY': ':0', 13:05:16 INFO - 'HOME': '/home/cltbld', 13:05:16 INFO - 'LANG': 'en_US.UTF-8', 13:05:16 INFO - 'LANGUAGE': 'en_US:en', 13:05:16 INFO - 'LOGNAME': 'cltbld', 13:05:16 INFO - 'MAIL': '/var/mail/cltbld', 13:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:16 INFO - 'MOZ_NO_REMOTE': '1', 13:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:16 INFO - 'NO_EM_RESTART': '1', 13:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:16 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:16 INFO - 'SHELL': '/bin/bash', 13:05:16 INFO - 'SHLVL': '1', 13:05:16 INFO - 'TERM': 'linux', 13:05:16 INFO - 'TMOUT': '86400', 13:05:16 INFO - 'USER': 'cltbld', 13:05:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:16 INFO - '_': '/tools/buildbot/bin/python'} 13:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:16 INFO - Downloading/unpacking jsonschema 13:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:16 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:05:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:05:18 INFO - Downloading/unpacking functools32 (from jsonschema) 13:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:05:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:05:18 INFO - warning: no files found matching '*.txt' 13:05:18 INFO - no previously-included directories found matching 'build' 13:05:18 INFO - no previously-included directories found matching 'dist' 13:05:18 INFO - no previously-included directories found matching '.git*' 13:05:18 INFO - Installing collected packages: jsonschema, functools32 13:05:18 INFO - Running setup.py install for functools32 13:05:18 INFO - warning: no files found matching '*.txt' 13:05:18 INFO - no previously-included directories found matching 'build' 13:05:18 INFO - no previously-included directories found matching 'dist' 13:05:18 INFO - no previously-included directories found matching '.git*' 13:05:18 INFO - Successfully installed jsonschema functools32 13:05:18 INFO - Cleaning up... 13:05:18 INFO - Return code: 0 13:05:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:05: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:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05: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:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:05:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6c37ec0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d17600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, '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-1454014584.860473-1272326920', '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:05:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 13:05:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:05:18 INFO - Using env: {'DISPLAY': ':0', 13:05:18 INFO - 'HOME': '/home/cltbld', 13:05:18 INFO - 'LANG': 'en_US.UTF-8', 13:05:18 INFO - 'LANGUAGE': 'en_US:en', 13:05:18 INFO - 'LOGNAME': 'cltbld', 13:05:18 INFO - 'MAIL': '/var/mail/cltbld', 13:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:18 INFO - 'MOZ_NO_REMOTE': '1', 13:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:18 INFO - 'NO_EM_RESTART': '1', 13:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:18 INFO - 'SHELL': '/bin/bash', 13:05:18 INFO - 'SHLVL': '1', 13:05:18 INFO - 'TERM': 'linux', 13:05:18 INFO - 'TMOUT': '86400', 13:05:18 INFO - 'USER': 'cltbld', 13:05:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:18 INFO - '_': '/tools/buildbot/bin/python'} 13:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:05:18 INFO - Downloading/unpacking flake8 13:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:05:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:05:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:05:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:21 INFO - no previously-included directories found matching 'docs/_build' 13:05:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:05:21 INFO - Running setup.py install for pep8 13:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:05:21 INFO - no previously-included directories found matching 'docs/_build' 13:05:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:05:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:05:21 INFO - Cleaning up... 13:05:21 INFO - Return code: 0 13:05:21 INFO - Running post-action listener: _resource_record_post_action 13:05:21 INFO - Running post-action listener: _start_resource_monitoring 13:05:21 INFO - Starting resource monitoring. 13:05:21 INFO - ##### 13:05:21 INFO - ##### Running install step. 13:05:21 INFO - ##### 13:05:21 INFO - Running pre-action listener: _resource_record_pre_action 13:05:21 INFO - Running main action method: install 13:05:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:05:21 INFO - Reading from file tmpfile_stdout 13:05:21 INFO - Detecting whether we're running mozinstall >=1.0... 13:05:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:05:21 INFO - Reading from file tmpfile_stdout 13:05:21 INFO - Output received: 13:05:21 INFO - Usage: mozinstall [options] installer 13:05:21 INFO - Options: 13:05:21 INFO - -h, --help show this help message and exit 13:05:21 INFO - -d DEST, --destination=DEST 13:05:21 INFO - Directory to install application into. [default: 13:05:21 INFO - "/builds/slave/test-pgo"] 13:05:21 INFO - --app=APP Application being installed. [default: firefox] 13:05:21 INFO - mkdir: /builds/slave/test-pgo/build/application 13:05:21 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:05:21 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:05:36 INFO - Reading from file tmpfile_stdout 13:05:36 INFO - Output received: 13:05:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:05:36 INFO - Running post-action listener: _resource_record_post_action 13:05:36 INFO - ##### 13:05:36 INFO - ##### Running run-tests step. 13:05:36 INFO - ##### 13:05:36 INFO - Running pre-action listener: _resource_record_pre_action 13:05:36 INFO - Running main action method: run_tests 13:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:05:36 INFO - Python 2.7.3 13:05:36 INFO - Return code: 0 13:05:36 INFO - grabbing minidump binary from tooltool 13:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:05:36 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 0x1da6350>, '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 0x1da7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1da76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:05:36 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:05:36 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:05:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:36 INFO - Return code: 0 13:05:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:05:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:05:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:05:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:05:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:05:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:05:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:05:37 INFO - Return code: 0 13:05:37 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/1454005647/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:05:37 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/1454005647/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost 13:05:37 INFO - Using env: {'DISPLAY': ':0', 13:05:37 INFO - 'HOME': '/home/cltbld', 13:05:37 INFO - 'LANG': 'en_US.UTF-8', 13:05:37 INFO - 'LANGUAGE': 'en_US:en', 13:05:37 INFO - 'LOGNAME': 'cltbld', 13:05:37 INFO - 'MAIL': '/var/mail/cltbld', 13:05:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:05:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:37 INFO - 'MOZ_NO_REMOTE': '1', 13:05:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:05:37 INFO - 'NO_EM_RESTART': '1', 13:05:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:05:37 INFO - 'PWD': '/builds/slave/test-pgo', 13:05:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:05:37 INFO - 'SHELL': '/bin/bash', 13:05:37 INFO - 'SHLVL': '1', 13:05:37 INFO - 'TERM': 'linux', 13:05:37 INFO - 'TMOUT': '86400', 13:05:37 INFO - 'USER': 'cltbld', 13:05:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454014584.860473-1272326920', 13:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:37 INFO - '_': '/tools/buildbot/bin/python'} 13:05:37 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/1454005647/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost'] with output_timeout 3600 13:05:37 INFO - mozversion INFO | application_buildid: 20160128102727 13:05:37 INFO - mozversion INFO | application_changeset: 1241ef0ab5da5497f9d9db13c5a21a88bc2a4337 13:05:37 INFO - mozversion INFO | application_display_name: Nightly 13:05:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:37 INFO - mozversion INFO | application_name: Firefox 13:05:37 INFO - mozversion INFO | application_remotingname: firefox 13:05:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:37 INFO - mozversion INFO | application_vendor: Mozilla 13:05:37 INFO - mozversion INFO | application_version: 45.0 13:05:37 INFO - mozversion INFO | platform_buildid: 20160128102727 13:05:37 INFO - mozversion INFO | platform_changeset: 1241ef0ab5da5497f9d9db13c5a21a88bc2a4337 13:05:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:37 INFO - mozversion INFO | platform_version: 45.0 13:05:37 INFO - 2016-01-28 13:05:37,958 DEBUG : using testdate: 1454015137 13:05:37 INFO - 2016-01-28 13:05:37,958 DEBUG : actual date: 1454015137 13:05:37 INFO - 2016-01-28 13:05:37,967 INFO : starting webserver on 'localhost:37616' 13:05:37 INFO - 2016-01-28 13:05:37,967 INFO : Starting test suite talos-linux64-ix-050 13:05:37 INFO - 2016-01-28 13:05:37,967 INFO : Starting test dromaeo_css 13:05:37 INFO - 2016-01-28 13:05:37,967 DEBUG : operating with platform_type : linux_ 13:05:37 INFO - 2016-01-28 13:05:37,968 INFO : Initialising browser for dromaeo_css test... 13:05:38 INFO - 2016-01-28 13:05:38,029 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVqXKY1/profile http://localhost:37616/getInfo.html 13:05:42 INFO - 2016-01-28 13:05:42,882 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:05:42 INFO - 2016-01-28 13:05:42,882 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:05:42 INFO - 2016-01-28 13:05:42,882 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:05:42 INFO - 2016-01-28 13:05:42,882 DEBUG : BROWSER_OUTPUT: __metrics 13:05:43 INFO - 2016-01-28 13:05:43,180 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:05:44 INFO - 2016-01-28 13:05:44,097 INFO : Browser initialized. 13:05:44 INFO - 2016-01-28 13:05:44,098 INFO : Running cycle 1/1 for dromaeo_css test... 13:05:44 INFO - 2016-01-28 13:05:44,098 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVqXKY1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:05:55 INFO - 2016-01-28 13:05:55,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 134750208 13:05:55 INFO - 2016-01-28 13:05:55,921 DEBUG : BROWSER_OUTPUT: 13:06:46 INFO - 2016-01-28 13:06:46,624 DEBUG : BROWSER_OUTPUT: 1454015206620 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:08:54 INFO - 2016-01-28 13:08:54,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37616/tests/dromaeo/cssquery-ext.html) 13:08:56 INFO - 2016-01-28 13:08:56,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 236621824 13:08:56 INFO - 2016-01-28 13:08:56,012 DEBUG : BROWSER_OUTPUT: 13:11:58 INFO - 2016-01-28 13:11:58,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-ext.html (next: http://localhost:37616/tests/dromaeo/cssquery-jquery.html) 13:11:58 INFO - 2016-01-28 13:11:58,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 220008448 13:11:58 INFO - 2016-01-28 13:11:58,612 DEBUG : BROWSER_OUTPUT: 13:15:00 INFO - 2016-01-28 13:15:00,340 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37616/tests/dromaeo/cssquery-mootools.html) 13:15:00 INFO - 2016-01-28 13:15:00,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 211689472 13:15:00 INFO - 2016-01-28 13:15:00,891 DEBUG : BROWSER_OUTPUT: 13:18:02 INFO - 2016-01-28 13:18:02,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37616/tests/dromaeo/cssquery-prototype.html) 13:18:03 INFO - 2016-01-28 13:18:03,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 196063232 13:18:03 INFO - 2016-01-28 13:18:03,208 DEBUG : BROWSER_OUTPUT: 13:21:05 INFO - 2016-01-28 13:21:05,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37616/tests/dromaeo/cssquery-yui.html) 13:21:06 INFO - 2016-01-28 13:21:06,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 197644288 13:21:06 INFO - 2016-01-28 13:21:06,161 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/dromaeo/cssquery-yui.html (next: http://localhost:37616/tests/dromaeo/cssquery-dojo.html) 13:24:08 INFO - 2016-01-28 13:24:08,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 242196480 13:24:08 INFO - 2016-01-28 13:24:08,622 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,622 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:24:08 INFO - 2016-01-28 13:24:08,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:24:08 INFO - 2016-01-28 13:24:08,623 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:24:08 INFO - 2016-01-28 13:24:08,623 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:24:08 INFO - 2016-01-28 13:24:08,624 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3281.245313577877;3291.1443024813543;3315.8342082895865;3319.634840167581;3351.9664803351966;5456.590755693324;5463.48096930791;5469.699166545844;5488.643238189515;5493.258410114633;5432.891342173154;5435.918461223085;5444.237806707064;5445.264889239951;5447.428020057896;4945.752712364385;4979.800807967686;4999.125153098212;5014.548690617844;5020.523050310215;4944.505549445063;5025.773840177182;5047.041062198189;5054.545090941814;5133.743312834362;5039.697618142924;5105.693658380491;5111.386633603973;5116.974415127919;5125.333706618135;5053.9241911371355;5109.386873575158;5113.335266415379;5122.846314610568;5124.205748109049;4890.926636100461;4952.87617809554;4989.700617962933;5022.899542009176;5026.874328141789;5351.839444816662;5360.91958620621;5362.65142765719;5377.973110134424;5404.8108316208745;5923.7926672566255;5925.111233314994;5936.376680448577;5937.139114828369;5948.375420580864;5690.886182276373;5860.7948721794955;5922.822315330547;6041.24484439445;6060.939390606081;5564.4991950724625;5566.805161819317;5568.832935011957;5570.303712035955;5578.721063946787;5782.7686892523825;6023.066424704178;6042.425969532887;6050.2437195350585;6064.393560643988;5798.33319168301;5847.298324201123;5870.9412905870395;5874.94125058744;5895.705214739246;5955.225820643289;6043.516518678495;6058.5153187745755;6059.060845568855;6067.817965461043;5708.971455142698;5851.853703657357;6002.789902353396;6007.579469437097;6024.608400453956;5816.651000939957;5873.676947767828;5877.441643043904;5892.057270836645;5909.349971503131;4514.345419914094;4574.702644328108;4619.145458090264;4619.330197121399;4653.441587009581;3999.680025597945;4040.151568170717;4079.204555111725;4082.7346222496035;4176.1230141669985;5738.741756620879;5740.712964351766;5751.626144300607;5755.9424405756245;5758.107493338455;6073.18012068374;6077.513798896078;6091.817245482643;6098.0243161094895;6099.878002439927;5447.428020057916;5485.780568777204;5565.41563135873;5565.443455654402;5745.913811292834;5223.555997740159;5235.293235413246;5237.685738855681;5238.3190185276435;5258.579313654898;6130.325664177026;6153.476954458832;6159.291681456601;6173.506119510428;6177.69111544421;5813.883722325614;5870.7945221917025;5943.91084133747;5980.923433781961;6012.428819262163;6128.50971922254;6139.017757158833;6139.140520327069;6140.600860944024;6151.6001459904965;5857.238558987475;5924.407559244041;5925.733341999534;5930.406959304035;5933.465988061095;5778.364379918122;5895.675737834289;6019.217501724747;6108.534230485914;6118.872414788915;5958.106284057426;5964.731587078505;5966.090213579874;5966.492848107786;5974.522038236843;5925.377835327228;5939.613925094855;5944.3164036136395;5947.91078133837;5956.166136740946;5586.664800112007;5687.715614219355;5712.37163911961;5790;5803.448672376117;5879.088741245114;5986.640801551921;6009.098635204754;6016.308124565731;6017.157597936205;5527.447255274601;5868.4424979626865;5875.118732190205;5880.323762767336;5889.057750759858 13:24:08 INFO - 2016-01-28 13:24:08,628 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.8905807896499;635.612276511328;638.2245571630468;649.4804156674659;680.428440110307;32318.515222271657;33298.66701332986;33308.83345583272;33309.33381332372;33435.33129337412;34518.827405863;35092.473612895825;40706.59293407072;40839.59160408395;40946.59053409465;9064.90935090649;9208.49353285569;9209.355345125843;9218.86171707425;9221;8304.377171712116;8975.910240897605;9079.228265597432;9079.727608171732;9111.362204645677;8385.748427547183;10887.346759194474;11115.72210694735;11119.72200694981;11122.165837562176;10665.84001239982;10686.46567671621;10714.517846696917;10783.245172837904;10792.244542882001;10477.580896764197;10610.045095941325;10626.14990800734;10627.628033018884;10638.308509946828;42067.36898946518;42660.57339426597;42740.78629606863;42756.57243427557;42833.57166428327;3540.3804334241404;3604.0269127335473;3659.835307411173;3949.111449923773;4015.4579131817122;32207.355852883047;32246.677533224603;32270.193245168823;32539.837300813346;33291.833540832384;4307.332363483665;4307.806148723315;4376.190404775127;4401.119776044804;4427.557244275579;281180;284068;284117;284490.9999999979;284920;57135.714321428124;58214.417855821746;61815.6909215451;70604.6469767648;72195;62592.37407625865;63060.68469657622;63197.36802631915;63355.68322158452;63432;18156.818431815514;18346.81653183478;18404.631907362047;18493.445196644123;18504.352347667766;13839.377228024763;14032.85967140336;14052.297385130703;14074.929625351808;14194.645133871736;21026.369208923756;21233.15067397287;21313.68029479559;21313.78686213118;21382.14471421157;8363.121872203452;8498.192671696303;8526.232639062515;8566.871496927552;8579.2707619853;1048.234788604323;1094.414488248783;1141.560499207811;1141.6689160143465;1158.7624536969902;29235.119581018484;29311.85344073266;29452.85273573661;29469.705302946695;30138.24654383614;1130.7568872692411;1167.3929556630674;1167.9299242045504;1168.1881092640704;1168.7896178687747;12824.487020519262;15153;15400.383984640714;15771.763423548657;15812.130332831575;322528;323983;324647;324690;324861;56722.43277567172;56827.43172568304;56931.43068569261;57041.42958570444;57121.14318285229;1192.5587532612988;1286.2346903592347;1492.44779431611;1497.9026363286353;1536.1013806922851;27050;28162.1702191085;28669.28326791847;28694.713052869203;29056.27359316034;44373.778131110426;44739.77630111828;44786.3282050776;44802.55197447984;44896;218567;219756;220036;220614;221046;32634;33904.66095339015;34007.82996085004;34055.148621284665;34363.48454773131;40152.79923600363;40808.79595602003;40991.385129222486;41035.1792964145;41498.585014149474;38003.61996380001;38552.614473854905;40471.59528404678;42419.5758042428;42640.78679606582;37361;37531.24937501289;37792.811035944644;37894.24211515809;38088.619113808505;36524.26951461009;37455.625443745215;37518.43722344222;37704.245915082094;37707;32476;33619.663803361655;33803.323933521686;34002.31995360128;34287.31425371528;23785;24054.26714071074;25372;25494.74505254998;25595.104171353913 13:24:08 INFO - 2016-01-28 13:24:08,628 DEBUG : BROWSER_OUTPUT: |2;jquery.html;369.81509245377293;372.5920117471368;376.27191384670664;378.92610940866535;379.61658724688056;17054.024628509218;19288.903555482204;19290.71063934042;19351.22595096196;19748.70376944345;17670.293188272484;18140.818591814077;18477.907610461963;18764.155612997412;18770.81229187708;4315.697901146921;4453.28747400416;5559.305086864142;5679.687617181054;5682.948654498931;5893.705314734268;6100.389961003886;6118;6135.539834512407;6145.078238264274;6001.849953751169;6122.295935967376;6142.26292844857;6157.445829875311;6163.322034576193;6043.60716553427;6082.726277317532;6116.44951954324;6146.754129834823;6164.29110652274;5519.420460851633;5520.806771763009;5524.254225679522;5530.5022547970475;5532.917006244909;21774.891125544273;21857.562848742935;21920.342389728332;21960.89019554892;21990.340289791333;2419.8911049002836;2485.527749727546;2550.8469491830365;2574.9056650923285;2704.756571908538;13567.932160339134;13658.521951731742;14110.71778564423;14140.292985350794;14215;1868.3087257714733;1880.4264699266719;1924.114907142716;1943.5529828139465;1954.1499447740136;62086.689566551875;63038.68480657567;63082.36917630811;64462.67768661126;65021.67489162571;10332.586696532206;10477;10480.318779279323;10512.316699414514;10558;12978.091533592558;13146.474141034252;13153.802692959613;13154.605361838969;13172.275524846034;8228.42401031934;8326.375521835766;8536.573171341408;8544.658213671508;8619.6983105591;8634.611442485104;8651.221390074797;8662.30701543875;8726.08376120511;8740.737777866674;5745.511631511285;6030.276366836008;6189.257289125244;6246.781362652286;6407.839804004937;1783.647899126154;1815.7457955886186;1836.6051298970517;1887.0469064518431;1917.2426891378107;969.3989726369696;975.3513913247752;1033.4884232304908;1037.7509397744486;1099.3898386395467;16500.504984850475;17383.826161738474;17975.550611234823;18297.268109275745;18578.97815620127;1051.8264486359665;1060.7613287010515;1092.3991804507489;1139.2936379444798;1149.7413082056637;9120.543972801333;10348.172146228284;10647.787044259072;10687.14502839771;10854.45727713627;571477;579041;584369;589268;594127;81757;81939;82829.58585207156;82971.17028829755;83987.16012839916;1215.6535387414544;1223.4249902545967;1229.274727910537;1230.680023193976;1232.0882546915218;17073.146342683063;17312;17434.651306974043;17514.299428022736;17803.109844507464;38135;38409.4238586427;38443;38604.2279154421;39387.60612393839;48918.51081489139;51071.74464127656;51195;51564.22653660123;53868.30351573128;10426.113780328757;10445.895541044796;10468.63359782404;10632.52153653072;10636.149108071491;19006;19464.610707786047;19611.901940490206;19659.213631454582;19776.505587360432;15775.29011194476;16180.595485112966;16184.433544825875;16385.262663179947;16588.253528591;11794.705132371759;13551.86448135506;14372.49696260626;15150.54548363551;15792.36830526766;15067.773983390038;15298.847011529742;15440.305186266869;15510.689786203988;15605.063696178266;10088.899111008795;10115.49422528856;10236.948815255875;10267.024632659886;10372.377657340583;10616.8938310619;10789.838152427563;12031.879681203076;14924.253787310374;15163.090214586719 13:24:08 INFO - 2016-01-28 13:24:08,631 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1533.7622668486388;1540.8382119877406;1696.9394128669583;1782.393986044745;1814.6461440019193;6887.827804304895;7040.753573624924;7317.853642927145;7607.54354738716;7613.581253031081;7106.5380750251325;7200.531965422244;7272.781816545499;7279.490435669505;7279.708811647541;2238.4292005538605;2268.047420083569;2274.8976296066635;2276.0326861084054;2277.146070223666;1968.3406058970263;2002.029015927274;2241.1035585765662;2288.302067869299;2310.410845234463;2195.3962660268394;2211.524522227721;2218.378853920905;2222.144474377368;2222.1777942161425;2281.235786011688;2309.041747674713;2309.9422514437188;2310.260716570698;2311.306608017588;2289.187338494827;2298.0922535598347;2308.365199570115;2308.515211805523;2308.6883270758567;7565.773026809205;7641.69433222676;7664.770056898302;7667.348275396598;7690.500117492401;4492.16894874446;4599.195140850338;4605.424321959755;4607.999999999966;4611.44662640482;3013.608230929987;3031.363413683107;3054.266975925762;3056.5720799088144;3068.3096303331795;1016.4104819204844;1042.925786439968;1046.7016900183412;1064.9946750266276;1074.135321066541;10225;10240.692779216635;10241.436720980342;10242.129418999393;10255.333403328685;4127.8968025798995;4151.252774500619;4175.64507016907;4175.874723758292;4177.227212965611;8883.244924181388;8884.111588841064;8887.244584210415;8889.73330800077;8898.555072246361;4649.023705021983;4654.534546545387;4656.208444564432;4662.860114196579;4663.27719203524;4266.530681625019;4267.701260911768;4267.722598031118;4269.060806622538;4275.679324050709;3722.7207959403154;3743.5320584926885;3750.3999360102252;3772.7359084864347;3775.0562359410146;1105.6075093341908;1149.620625193684;1199.9280043197436;1220.6216073017392;1226.5645695778048;1134.5575225661999;1137.0164807441504;1184.6327638432113;1359.7076628524915;1421.0620990146454;7015.228324884259;7046.6828992695455;7109.075820143348;7110.253423390573;7121.857562848714;1100.906422954058;1131.9434028298551;1187.7921363761307;1199.5741511763372;1213.9635810925686;5804.88390232193;5859.794907178229;5874.970625146847;5889.970550147222;5890;8595.87106193395;8957.014728379872;8974.730758077269;9009.684661036832;9071.138241867013;8857;8962.910370896338;8970.237529809909;8970.775730606787;8981.730548083568;7030.894536581955;7098.29017098286;7136.107986501687;7151.570905745568;7220.277972202738;7041.084658994298;7047.541909775849;7050.330218629222;7058.505904586629;7077.186123595852;7964.960175199087;8201.343892488705;8302.211289927447;8340.499570025819;8353.415260931677;8200.507969521848;8207.9589602054;8349.749507514784;8358.247757701836;8361.916380836114;6505.804825855232;6779.932200678128;6788.049673045876;6808.080909077211;6858.971154326891;6548.508861835287;7070.575765454089;7364.852702945804;7369.078865141857;7376.0411146550605;6068.393160683896;6477.093206950936;6485.54601177913;6695.0626912231355;6872.931270687429;6816.795496135124;6834.453243740588;6863.142107236596;6909.654517274015;6952.5480843745;6795.72817087311;6905.723771049303;6907;6908.896366554405;6910.447164226749;6398.424141827258;6433.646149461824;6435.195600549931;6440.066190402272;6443.613383197023;6355.459785918249;6435.935640643721;6450.967745161244;6524.217093948757;6555.868882622225 13:24:08 INFO - 2016-01-28 13:24:08,631 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.57264415226433;340.77168297240854;343.12674244048895;350.62308018879713;358.290584642408;6165.35263797301;6235.033569796688;6243.531735119867;6249.4687951524065;6261.3738626137365;5903.734331955062;5936.732847021884;6031.69841507924;6133.815985520441;6137.324894261627;4748.240281554952;4753.90492190156;4756.857294281177;4775.0927323808455;4776.044791041788;4515.7516336601475;4737.194676904935;4763.190257656207;4766.118268120392;4766.285057241407;4557.908841823178;4583.977080114611;4721.575058244757;4722.693024953384;4727.22000869856;4681;4711.0342379812055;4714.599259063001;4717.080169366975;4722.763861806896;4184.686148538872;4187.539370669224;4191.308434108369;4191.434156388879;4193.475815523059;5733.197352370671;5784.248047753807;5803.0134877071;5808.332041815203;5820.621659592155;5452.809151679712;5453.427390124019;5456.590755693339;5457.099578569531;5463.31708536433;6454.386833250834;6455.160829092188;6456.644884531349;6465.256495502983;6467.74129034838;4525.072360166191;4548.613367863735;4555.908881822345;4556.589906908394;4557.9772101139615;6561.442277406426;6726.663666816639;6729.629870357128;6729.798106056777;6737.3262673732725;4769.499202583748;4770.499097594703;4771.284307353924;4771.475137734916;4775.092732380836;4833.492483289204;4834.178189707688;4834.347363106006;4834.5890599299455;4835;5485.972570137204;5486.341639003345;5492.258545096361;5492.313460817398;5497.312835895513;6511;6564.540482166298;6570.901436478457;6572.145621069326;6572.737090516326;1683.5370273174974;1701.8128005919339;1703.5996540812898;1704.6420251747272;1705.8826468663046;1131.7623299107115;1160.9825852612219;1162.773259214462;1165.0097417195486;1171.3908767440882;6323.146375239284;6324.620522768557;6324.747010119544;6331;6334.904976425358;6583.9012414813815;6756.290589488131;6764.188297404343;6768.052472653832;6778.796636100925;6256.280527739277;6340.397662222082;6371.553991220663;6407.775727849503;6444.871102577922;3641.5812181599454;3698.7780733156096;3700.0934770980743;3701.11173318407;3704;6832.6925288362145;6982.1272340957385;7015.684294206773;7022.859542809218;7023.297670233038;6938.722451101899;6993.4055605274125;7014.894776578355;7050.858982820315;7054.929450705427;7058.576485410892;7072.787816365517;7073.681684324218;7074.186468556079;7078.9381592760465;6691.397774200345;6859.348361905611;6865.794026179223;6867.553609015398;6873.450123989969;6729.5625784323865;6740.494462915203;6757.831054223487;6764.763233286812;6771;7007.614581198083;7025.754098606524;7038.612876291853;7039.401650859734;7042.260562641054;4506.436695413074;4593.931091033704;4647.953520464752;4704.458987216514;4706.694064885772;6744.527883048139;6752.257251702407;6780.796576102724;6826.249112597511;6827.556208846409;6603.042558829039;6615.834604134935;6618.8345291368105;6620.933790662032;6624.867502649824;6505.21937367519;6619.669016549057;6630.336966303331;6636.0377745225705;6645.102911106938;6485.6108633482145;6504.707288172138;6504.902426463512;6506.772262970773;6508.902366464412;6643.867122657423;6652.667366631552;6653.135092437952;6656.201255849135;6656.633885136364;6285.151504546828;6388.945823938998;6489.643069631215;6492.220933488012;6506.284308726131 13:24:08 INFO - 2016-01-28 13:24:08,631 DEBUG : BROWSER_OUTPUT: |5;yui.html;842.9789255268618;872.5898827551052;896.7085697148428;905.1491597897977;928.0904713380891;15055.473058442956;15173.468928587474;15259;15321.310541025667;15329.310181041867;14082.0846644968;14137.081089729187;14169.362378692958;14199.71600567988;14227.21750303733;725.2167658928371;739.0946091038488;869.4696235296464;875.4484674654958;881.3301890563154;873.8732883731855;877.1360210192955;879.151618687966;882.1487264789477;883.2227639677108;764.6826566974698;776.9572673502955;906.1708536688922;915.4095608332655;915.5879854065664;893.8837951066353;903.9096090390941;906.7415786500882;908.3006085314337;908.9818203635923;674.5581644023173;679.8606285711418;680.1667956752988;680.6460640466979;681.2846511163308;12920.418581163776;13037.739245215043;13072.346382680924;13086.541971030969;13089.672758181026;13055.281959492224;13526.864731352758;13557.59327220185;13622;13677.521286755014;10852.728681782939;11071.944640276828;11325.773484530264;11418.200725949187;11450.083993280601;3719.4048952167796;3804.6005169457085;3810.8856734298015;3852.9422058669143;3872.9225415491533;47206.291905621445;47405.76297118527;47717;48072.51927480716;48639.99999999964;11093.334399935868;11117.328671813511;11240.718982025515;11314.773704525864;11456.94271528637;19874.50313742168;19874.60250794976;19874.801251987585;19941.401757947286;20001.499962500762;7952.801179970547;8073.798155046171;8124.675012999532;8204.917950820534;8363.247307742333;4454.710443821141;4469.932951005738;4489.281714925596;4500.729956202638;4551.2945493447905;3057.5260834570677;3099.8140111593375;3100.534919762054;3100.90697279082;3103.7827352085137;521.7547752556293;524.4781442464696;532.1963834609767;538.8410418926347;550.9862253443696;605.9515238780887;659.6240143118376;679.8504329047602;695.1658010387555;716.8924661300847;9245.306602004877;9546.18857397115;9633.373830700983;9667.129958303787;9711.951440242894;510.7650480778809;590.1884908251154;670.1054092786185;695.2734392559686;717.6626985316892;4106.301928672133;4457.888552786141;4516.299973504112;4517.435320584927;4522.954770452319;60775;61090;61401.38598614046;61419;66344;51009.744951275;51170.74414627903;51509.48490515122;51618.741906290226;52219.21671174935;47647.76176119028;48380.27429588559;48963.75518122387;49279;49974.25038624424;9181.908180918372;9201.30990175726;9418.764530886509;9563.713088607075;9775.706728798148;35472.46791298184;37046.629533705396;37428.2514349706;37672.62327376801;38656;47535.762321189555;47766;47882;48260;48281.51718482911;11223.38271395081;11403.771924561628;11682.177942170769;11922.76154476923;11944.343061131374;13292.601221963356;13385.263810490516;13586.93206533961;14150.716985660434;14688.412463501767;11481.827772583585;12011.459484323052;12439.937800310941;12939.353032348157;13159.868401316247;11658.88341116578;11962.641120766391;12087.879121208676;12100.75798484043;12483.500659973499;9795.559199835881;11429;11462.484188211718;11513.53945842157;11918.04655627565;10061.748456288651;10219.437930913871;10294.742631433974;10477.528511217166;10552.894471055499;9760.56077476501;10155;10161.542730576994;10205.795884082128;10218.489075546342 13:24:08 INFO - 2016-01-28 13:24:08,631 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,782 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016248620__endTimestamp 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5538.12 Median:5782.77 stddev:625.37 (10.8%) stddev-sans-first:601.70 13:24:08 INFO - 2016-01-28 13:24:08,632 DEBUG : BROWSER_OUTPUT: Values: 3281.2 3291.1 3315.8 3319.6 3352.0 5456.6 5463.5 5469.7 5488.6 5493.3 5432.9 5435.9 5444.2 5445.3 5447.4 4945.8 4979.8 4999.1 5014.5 5020.5 4944.5 5025.8 5047.0 5054.5 5133.7 5039.7 5105.7 5111.4 5117.0 5125.3 5053.9 5109.4 5113.3 5122.8 5124.2 4890.9 4952.9 4989.7 5022.9 5026.9 5351.8 5360.9 5362.7 5378.0 5404.8 5923.8 5925.1 5936.4 5937.1 5948.4 5690.9 5860.8 5922.8 6041.2 6060.9 5564.5 5566.8 5568.8 5570.3 5578.7 5782.8 6023.1 6042.4 6050.2 6064.4 5798.3 5847.3 5870.9 5874.9 5895.7 5955.2 6043.5 6058.5 6059.1 6067.8 5709.0 5851.9 6002.8 6007.6 6024.6 5816.7 5873.7 5877.4 5892.1 5909.3 4514.3 4574.7 4619.1 4619.3 4653.4 3999.7 4040.2 4079.2 4082.7 4176.1 5738.7 5740.7 5751.6 5755.9 5758.1 6073.2 6077.5 6091.8 6098.0 6099.9 5447.4 5485.8 5565.4 5565.4 5745.9 5223.6 5235.3 5237.7 5238.3 5258.6 6130.3 6153.5 6159.3 6173.5 6177.7 5813.9 5870.8 5943.9 5980.9 6012.4 6128.5 6139.0 6139.1 6140.6 6151.6 5857.2 5924.4 5925.7 5930.4 5933.5 5778.4 5895.7 6019.2 6108.5 6118.9 5958.1 5964.7 5966.1 5966.5 5974.5 5925.4 5939.6 5944.3 5947.9 5956.2 5586.7 5687.7 5712.4 5790.0 5803.4 5879.1 5986.6 6009.1 6016.3 6017.2 5527.4 5868.4 5875.1 5880.3 5889.1 13:24:08 INFO - 2016-01-28 13:24:08,633 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,633 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45818.55 Median:33527.50 stddev:72804.00 (217.1%) stddev-sans-first:72928.98 13:24:08 INFO - 2016-01-28 13:24:08,634 DEBUG : BROWSER_OUTPUT: Values: 575.9 635.6 638.2 649.5 680.4 32318.5 33298.7 33308.8 33309.3 33435.3 34518.8 35092.5 40706.6 40839.6 40946.6 9064.9 9208.5 9209.4 9218.9 9221.0 8304.4 8975.9 9079.2 9079.7 9111.4 8385.7 10887.3 11115.7 11119.7 11122.2 10665.8 10686.5 10714.5 10783.2 10792.2 10477.6 10610.0 10626.1 10627.6 10638.3 42067.4 42660.6 42740.8 42756.6 42833.6 3540.4 3604.0 3659.8 3949.1 4015.5 32207.4 32246.7 32270.2 32539.8 33291.8 4307.3 4307.8 4376.2 4401.1 4427.6 281180.0 284068.0 284117.0 284491.0 284920.0 57135.7 58214.4 61815.7 70604.6 72195.0 62592.4 63060.7 63197.4 63355.7 63432.0 18156.8 18346.8 18404.6 18493.4 18504.4 13839.4 14032.9 14052.3 14074.9 14194.6 21026.4 21233.2 21313.7 21313.8 21382.1 8363.1 8498.2 8526.2 8566.9 8579.3 1048.2 1094.4 1141.6 1141.7 1158.8 29235.1 29311.9 29452.9 29469.7 30138.2 1130.8 1167.4 1167.9 1168.2 1168.8 12824.5 15153.0 15400.4 15771.8 15812.1 322528.0 323983.0 324647.0 324690.0 324861.0 56722.4 56827.4 56931.4 57041.4 57121.1 1192.6 1286.2 1492.4 1497.9 1536.1 27050.0 28162.2 28669.3 28694.7 29056.3 44373.8 44739.8 44786.3 44802.6 44896.0 218567.0 219756.0 220036.0 220614.0 221046.0 32634.0 33904.7 34007.8 34055.1 34363.5 40152.8 40808.8 40991.4 41035.2 41498.6 38003.6 38552.6 40471.6 42419.6 42640.8 37361.0 37531.2 37792.8 37894.2 38088.6 36524.3 37455.6 37518.4 37704.2 37707.0 32476.0 33619.7 33803.3 34002.3 34287.3 23785.0 24054.3 25372.0 25494.7 25595.1 13:24:08 INFO - 2016-01-28 13:24:08,634 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,634 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31194.70 Median:10704.08 stddev:95265.32 (890.0%) stddev-sans-first:95504.44 13:24:08 INFO - 2016-01-28 13:24:08,634 DEBUG : BROWSER_OUTPUT: Values: 369.8 372.6 376.3 378.9 379.6 17054.0 19288.9 19290.7 19351.2 19748.7 17670.3 18140.8 18477.9 18764.2 18770.8 4315.7 4453.3 5559.3 5679.7 5682.9 5893.7 6100.4 6118.0 6135.5 6145.1 6001.8 6122.3 6142.3 6157.4 6163.3 6043.6 6082.7 6116.4 6146.8 6164.3 5519.4 5520.8 5524.3 5530.5 5532.9 21774.9 21857.6 21920.3 21960.9 21990.3 2419.9 2485.5 2550.8 2574.9 2704.8 13567.9 13658.5 14110.7 14140.3 14215.0 1868.3 1880.4 1924.1 1943.6 1954.1 62086.7 63038.7 63082.4 64462.7 65021.7 10332.6 10477.0 10480.3 10512.3 10558.0 12978.1 13146.5 13153.8 13154.6 13172.3 8228.4 8326.4 8536.6 8544.7 8619.7 8634.6 8651.2 8662.3 8726.1 8740.7 5745.5 6030.3 6189.3 6246.8 6407.8 1783.6 1815.7 1836.6 1887.0 1917.2 969.4 975.4 1033.5 1037.8 1099.4 16500.5 17383.8 17975.6 18297.3 18579.0 1051.8 1060.8 1092.4 1139.3 1149.7 9120.5 10348.2 10647.8 10687.1 10854.5 571477.0 579041.0 584369.0 589268.0 594127.0 81757.0 81939.0 82829.6 82971.2 83987.2 1215.7 1223.4 1229.3 1230.7 1232.1 17073.1 17312.0 17434.7 17514.3 17803.1 38135.0 38409.4 38443.0 38604.2 39387.6 48918.5 51071.7 51195.0 51564.2 53868.3 10426.1 10445.9 10468.6 10632.5 10636.1 19006.0 19464.6 19611.9 19659.2 19776.5 15775.3 16180.6 16184.4 16385.3 16588.3 11794.7 13551.9 14372.5 15150.5 15792.4 15067.8 15298.8 15440.3 15510.7 15605.1 10088.9 10115.5 10236.9 10267.0 10372.4 10616.9 10789.8 12031.9 14924.3 15163.1 13:24:08 INFO - 2016-01-28 13:24:08,634 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,635 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5331.33 Median:6211.93 stddev:2686.54 (43.2%) stddev-sans-first:2678.91 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: Values: 1533.8 1540.8 1696.9 1782.4 1814.6 6887.8 7040.8 7317.9 7607.5 7613.6 7106.5 7200.5 7272.8 7279.5 7279.7 2238.4 2268.0 2274.9 2276.0 2277.1 1968.3 2002.0 2241.1 2288.3 2310.4 2195.4 2211.5 2218.4 2222.1 2222.2 2281.2 2309.0 2309.9 2310.3 2311.3 2289.2 2298.1 2308.4 2308.5 2308.7 7565.8 7641.7 7664.8 7667.3 7690.5 4492.2 4599.2 4605.4 4608.0 4611.4 3013.6 3031.4 3054.3 3056.6 3068.3 1016.4 1042.9 1046.7 1065.0 1074.1 10225.0 10240.7 10241.4 10242.1 10255.3 4127.9 4151.3 4175.6 4175.9 4177.2 8883.2 8884.1 8887.2 8889.7 8898.6 4649.0 4654.5 4656.2 4662.9 4663.3 4266.5 4267.7 4267.7 4269.1 4275.7 3722.7 3743.5 3750.4 3772.7 3775.1 1105.6 1149.6 1199.9 1220.6 1226.6 1134.6 1137.0 1184.6 1359.7 1421.1 7015.2 7046.7 7109.1 7110.3 7121.9 1100.9 1131.9 1187.8 1199.6 1214.0 5804.9 5859.8 5875.0 5890.0 5890.0 8595.9 8957.0 8974.7 9009.7 9071.1 8857.0 8962.9 8970.2 8970.8 8981.7 7030.9 7098.3 7136.1 7151.6 7220.3 7041.1 7047.5 7050.3 7058.5 7077.2 7965.0 8201.3 8302.2 8340.5 8353.4 8200.5 8208.0 8349.7 8358.2 8361.9 6505.8 6779.9 6788.0 6808.1 6859.0 6548.5 7070.6 7364.9 7369.1 7376.0 6068.4 6477.1 6485.5 6695.1 6872.9 6816.8 6834.5 6863.1 6909.7 6952.5 6795.7 6905.7 6907.0 6908.9 6910.4 6398.4 6433.6 6435.2 6440.1 6443.6 6355.5 6435.9 6451.0 6524.2 6555.9 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5503.24 Median:6273.26 stddev:1648.78 (26.3%) stddev-sans-first:1607.09 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: Values: 332.6 340.8 343.1 350.6 358.3 6165.4 6235.0 6243.5 6249.5 6261.4 5903.7 5936.7 6031.7 6133.8 6137.3 4748.2 4753.9 4756.9 4775.1 4776.0 4515.8 4737.2 4763.2 4766.1 4766.3 4557.9 4584.0 4721.6 4722.7 4727.2 4681.0 4711.0 4714.6 4717.1 4722.8 4184.7 4187.5 4191.3 4191.4 4193.5 5733.2 5784.2 5803.0 5808.3 5820.6 5452.8 5453.4 5456.6 5457.1 5463.3 6454.4 6455.2 6456.6 6465.3 6467.7 4525.1 4548.6 4555.9 4556.6 4558.0 6561.4 6726.7 6729.6 6729.8 6737.3 4769.5 4770.5 4771.3 4771.5 4775.1 4833.5 4834.2 4834.3 4834.6 4835.0 5486.0 5486.3 5492.3 5492.3 5497.3 6511.0 6564.5 6570.9 6572.1 6572.7 1683.5 1701.8 1703.6 1704.6 1705.9 1131.8 1161.0 1162.8 1165.0 1171.4 6323.1 6324.6 6324.7 6331.0 6334.9 6583.9 6756.3 6764.2 6768.1 6778.8 6256.3 6340.4 6371.6 6407.8 6444.9 3641.6 3698.8 3700.1 3701.1 3704.0 6832.7 6982.1 7015.7 7022.9 7023.3 6938.7 6993.4 7014.9 7050.9 7054.9 7058.6 7072.8 7073.7 7074.2 7078.9 6691.4 6859.3 6865.8 6867.6 6873.5 6729.6 6740.5 6757.8 6764.8 6771.0 7007.6 7025.8 7038.6 7039.4 7042.3 4506.4 4593.9 4648.0 4704.5 4706.7 6744.5 6752.3 6780.8 6826.2 6827.6 6603.0 6615.8 6618.8 6620.9 6624.9 6505.2 6619.7 6630.3 6636.0 6645.1 6485.6 6504.7 6504.9 6506.8 6508.9 6643.9 6652.7 6653.1 6656.2 6656.6 6285.2 6388.9 6489.6 6492.2 6506.3 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14590.56 Median:4520.20 stddev:16658.66 (368.5%) stddev-sans-first:16673.40 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: Values: 843.0 872.6 896.7 905.1 928.1 15055.5 15173.5 15259.0 15321.3 15329.3 14082.1 14137.1 14169.4 14199.7 14227.2 725.2 739.1 869.5 875.4 881.3 873.9 877.1 879.2 882.1 883.2 764.7 777.0 906.2 915.4 915.6 893.9 903.9 906.7 908.3 909.0 674.6 679.9 680.2 680.6 681.3 12920.4 13037.7 13072.3 13086.5 13089.7 13055.3 13526.9 13557.6 13622.0 13677.5 10852.7 11071.9 11325.8 11418.2 11450.1 3719.4 3804.6 3810.9 3852.9 3872.9 47206.3 47405.8 47717.0 48072.5 48640.0 11093.3 11117.3 11240.7 11314.8 11456.9 19874.5 19874.6 19874.8 19941.4 20001.5 7952.8 8073.8 8124.7 8204.9 8363.2 4454.7 4469.9 4489.3 4500.7 4551.3 3057.5 3099.8 3100.5 3100.9 3103.8 521.8 524.5 532.2 538.8 551.0 606.0 659.6 679.9 695.2 716.9 9245.3 9546.2 9633.4 9667.1 9712.0 510.8 590.2 670.1 695.3 717.7 4106.3 4457.9 4516.3 4517.4 4523.0 60775.0 61090.0 61401.4 61419.0 66344.0 51009.7 51170.7 51509.5 51618.7 52219.2 47647.8 48380.3 48963.8 49279.0 49974.3 9181.9 9201.3 9418.8 9563.7 9775.7 35472.5 37046.6 37428.3 37672.6 38656.0 47535.8 47766.0 47882.0 48260.0 48281.5 11223.4 11403.8 11682.2 11922.8 11944.3 13292.6 13385.3 13586.9 14150.7 14688.4 11481.8 12011.5 12439.9 12939.4 13159.9 11658.9 11962.6 12087.9 12100.8 12483.5 9795.6 11429.0 11462.5 11513.5 11918.0 10061.7 10219.4 10294.7 10477.5 10552.9 9760.6 10155.0 10161.5 10205.8 10218.5 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:24:08 INFO - 2016-01-28 13:24:08,636 DEBUG : BROWSER_OUTPUT: 13:24:09 INFO - 2016-01-28 13:24:09,185 INFO : Browser exited with error code: 0 13:24:09 INFO - 2016-01-28 13:24:09,201 INFO : Completed test dromaeo_css (00:18:31) 13:24:09 INFO - 2016-01-28 13:24:09,201 INFO : Starting test kraken 13:24:09 INFO - 2016-01-28 13:24:09,201 DEBUG : operating with platform_type : linux_ 13:24:09 INFO - 2016-01-28 13:24:09,202 INFO : Initialising browser for kraken test... 13:24:09 INFO - 2016-01-28 13:24:09,208 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMtgPVz/profile http://localhost:37616/getInfo.html 13:24:13 INFO - 2016-01-28 13:24:13,351 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:24:13 INFO - 2016-01-28 13:24:13,351 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:24:13 INFO - 2016-01-28 13:24:13,351 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:24:13 INFO - 2016-01-28 13:24:13,351 DEBUG : BROWSER_OUTPUT: __metrics 13:24:13 INFO - 2016-01-28 13:24:13,508 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:24:14 INFO - 2016-01-28 13:24:14,216 INFO : Browser initialized. 13:24:14 INFO - 2016-01-28 13:24:14,216 INFO : Running cycle 1/1 for kraken test... 13:24:14 INFO - 2016-01-28 13:24:14,217 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMtgPVz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:24:25 INFO - 2016-01-28 13:24:25,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 134787072 13:24:25 INFO - 2016-01-28 13:24:25,983 DEBUG : BROWSER_OUTPUT: 13:24:28 INFO - 2016-01-28 13:24:28,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37616/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:29 INFO - 2016-01-28 13:24:29,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 166203392 13:24:29 INFO - 2016-01-28 13:24:29,001 DEBUG : BROWSER_OUTPUT: 13:24:31 INFO - 2016-01-28 13:24:31,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37616/tests/kraken/driver.html?testName=audio-dft) 13:24:32 INFO - 2016-01-28 13:24:32,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 163573760 13:24:32 INFO - 2016-01-28 13:24:32,156 DEBUG : BROWSER_OUTPUT: 13:24:34 INFO - 2016-01-28 13:24:34,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37616/tests/kraken/driver.html?testName=audio-fft) 13:24:35 INFO - 2016-01-28 13:24:35,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 160337920 13:24:35 INFO - 2016-01-28 13:24:35,501 DEBUG : BROWSER_OUTPUT: 13:24:37 INFO - 2016-01-28 13:24:37,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37616/tests/kraken/driver.html?testName=audio-oscillator) 13:24:38 INFO - 2016-01-28 13:24:38,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 161173504 13:24:38 INFO - 2016-01-28 13:24:38,020 DEBUG : BROWSER_OUTPUT: 13:24:40 INFO - 2016-01-28 13:24:40,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:40 INFO - 2016-01-28 13:24:40,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 161079296 13:24:40 INFO - 2016-01-28 13:24:40,757 DEBUG : BROWSER_OUTPUT: 13:24:43 INFO - 2016-01-28 13:24:43,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37616/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:44 INFO - 2016-01-28 13:24:44,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 160784384 13:24:44 INFO - 2016-01-28 13:24:44,158 DEBUG : BROWSER_OUTPUT: 13:24:47 INFO - 2016-01-28 13:24:47,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37616/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:48 INFO - 2016-01-28 13:24:48,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 160628736 13:24:48 INFO - 2016-01-28 13:24:48,091 DEBUG : BROWSER_OUTPUT: 13:24:50 INFO - 2016-01-28 13:24:50,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37616/tests/kraken/driver.html?testName=json-parse-financial) 13:24:51 INFO - 2016-01-28 13:24:51,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 159662080 13:24:51 INFO - 2016-01-28 13:24:51,314 DEBUG : BROWSER_OUTPUT: 13:24:52 INFO - 2016-01-28 13:24:52,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:53 INFO - 2016-01-28 13:24:53,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 168124416 13:24:53 INFO - 2016-01-28 13:24:53,396 DEBUG : BROWSER_OUTPUT: 13:24:55 INFO - 2016-01-28 13:24:55,125 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:55 INFO - 2016-01-28 13:24:55,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 164765696 13:24:55 INFO - 2016-01-28 13:24:55,714 DEBUG : BROWSER_OUTPUT: 13:24:57 INFO - 2016-01-28 13:24:57,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:58 INFO - 2016-01-28 13:24:58,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 171343872 13:24:58 INFO - 2016-01-28 13:24:58,266 DEBUG : BROWSER_OUTPUT: 13:25:00 INFO - 2016-01-28 13:25:00,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:25:01 INFO - 2016-01-28 13:25:01,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 177516544 13:25:01 INFO - 2016-01-28 13:25:01,169 DEBUG : BROWSER_OUTPUT: 13:25:03 INFO - 2016-01-28 13:25:03,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:25:04 INFO - 2016-01-28 13:25:04,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 174542848 13:25:04 INFO - 2016-01-28 13:25:04,234 DEBUG : BROWSER_OUTPUT: 13:25:05 INFO - 2016-01-28 13:25:05,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37616/tests/kraken/driver.html?testName=ai-astar) 13:25:06 INFO - 2016-01-28 13:25:06,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 233345024 13:25:06 INFO - 2016-01-28 13:25:06,118 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,119 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:25:06 INFO - 2016-01-28 13:25:06,119 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:25:06 INFO - 2016-01-28 13:25:06,120 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:25:06 INFO - 2016-01-28 13:25:06,120 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:25:06 INFO - 2016-01-28 13:25:06,120 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;111;110;111;101;110;110;109 13:25:06 INFO - 2016-01-28 13:25:06,120 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;121;148;155;128;153;153;122;163;125 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;159;158;160;158;159;162;163;159 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;71;154;71;71;70;71;155;74 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;137;92;93;93;136;91;92;131 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;109;109;108;109 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;146;147;145;146;145;145;145;144 13:25:06 INFO - 2016-01-28 13:25:06,121 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;95;96;95;95 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;59;60;57;56;57;56;55;56 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;64;65;64;64;65;64;64;65 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;76;78;86;78;78;77;79;78;78 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;110;113;112;116;113;111;121;116;119 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;144;144;144;146;135;143;143;143;134 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;65;63;64;63;64;63;64;65 13:25:06 INFO - 2016-01-28 13:25:06,123 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,865 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016306119__endTimestamp 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:25:06 INFO - 2016-01-28 13:25:06,124 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.17 (2.9%) stddev-sans-first:3.36 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 111.0 110.0 111.0 101.0 110.0 110.0 109.0 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:151.50 stddev:15.91 (10.5%) stddev-sans-first:16.59 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: Values: 150.0 121.0 148.0 155.0 128.0 153.0 153.0 122.0 163.0 125.0 13:25:06 INFO - 2016-01-28 13:25:06,125 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,126 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.50 stddev:1.70 (1.1%) stddev-sans-first:1.76 13:25:06 INFO - 2016-01-28 13:25:06,126 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 159.0 158.0 160.0 158.0 159.0 162.0 163.0 159.0 13:25:06 INFO - 2016-01-28 13:25:06,126 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,127 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.80 Median:71.00 stddev:35.17 (49.5%) stddev-sans-first:36.71 13:25:06 INFO - 2016-01-28 13:25:06,127 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 154.0 71.0 71.0 70.0 71.0 155.0 74.0 13:25:06 INFO - 2016-01-28 13:25:06,127 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,127 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:92.00 stddev:20.54 (22.3%) stddev-sans-first:21.24 13:25:06 INFO - 2016-01-28 13:25:06,127 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 137.0 92.0 93.0 93.0 136.0 91.0 92.0 131.0 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.45 (1.0%) stddev-sans-first:1.01 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 146.0 147.0 145.0 146.0 145.0 145.0 145.0 144.0 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,128 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:25:06 INFO - 2016-01-28 13:25:06,129 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 13:25:06 INFO - 2016-01-28 13:25:06,129 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,129 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:1.55 (2.7%) stddev-sans-first:1.62 13:25:06 INFO - 2016-01-28 13:25:06,129 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 59.0 60.0 57.0 56.0 57.0 56.0 55.0 56.0 13:25:06 INFO - 2016-01-28 13:25:06,129 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,130 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 13:25:06 INFO - 2016-01-28 13:25:06,130 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.00 stddev:2.76 (3.5%) stddev-sans-first:2.87 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 78.0 86.0 78.0 78.0 77.0 79.0 78.0 78.0 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.40 Median:114.50 stddev:3.53 (3.1%) stddev-sans-first:3.71 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: Values: 113.0 110.0 113.0 112.0 116.0 113.0 111.0 121.0 116.0 119.0 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.00 stddev:4.06 (2.8%) stddev-sans-first:4.24 13:25:06 INFO - 2016-01-28 13:25:06,131 DEBUG : BROWSER_OUTPUT: Values: 144.0 144.0 144.0 144.0 146.0 135.0 143.0 143.0 143.0 134.0 13:25:06 INFO - 2016-01-28 13:25:06,132 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,132 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 13:25:06 INFO - 2016-01-28 13:25:06,132 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 63.0 64.0 63.0 64.0 63.0 64.0 65.0 13:25:06 INFO - 2016-01-28 13:25:06,132 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:25:06 INFO - 2016-01-28 13:25:06,132 DEBUG : BROWSER_OUTPUT: 13:25:06 INFO - 2016-01-28 13:25:06,837 INFO : Browser exited with error code: 0 13:25:06 INFO - 2016-01-28 13:25:06,889 INFO : Completed test kraken (00:00:57) 13:25:06 INFO - 2016-01-28 13:25:06,889 INFO : Starting test v8_7 13:25:06 INFO - 2016-01-28 13:25:06,889 DEBUG : operating with platform_type : linux_ 13:25:06 INFO - 2016-01-28 13:25:06,889 INFO : Initialising browser for v8_7 test... 13:25:06 INFO - 2016-01-28 13:25:06,895 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjGpqPc/profile http://localhost:37616/getInfo.html 13:25:10 INFO - 2016-01-28 13:25:10,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:25:10 INFO - 2016-01-28 13:25:10,712 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:25:10 INFO - 2016-01-28 13:25:10,712 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:25:10 INFO - 2016-01-28 13:25:10,712 DEBUG : BROWSER_OUTPUT: __metrics 13:25:10 INFO - 2016-01-28 13:25:10,849 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:25:11 INFO - 2016-01-28 13:25:11,900 INFO : Browser initialized. 13:25:11 INFO - 2016-01-28 13:25:11,900 INFO : Running cycle 1/1 for v8_7 test... 13:25:11 INFO - 2016-01-28 13:25:11,900 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjGpqPc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:25:23 INFO - 2016-01-28 13:25:23,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 134561792 13:25:23 INFO - 2016-01-28 13:25:23,682 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37616/tests/v8_7/run.html (next: http://localhost:37616/tests/v8_7/run.html) 13:25:45 INFO - 2016-01-28 13:25:45,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 425279488 13:25:45 INFO - 2016-01-28 13:25:45,304 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: |0;Richards;168.23687752355318 13:25:45 INFO - 2016-01-28 13:25:45,305 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.80567139282735 13:25:45 INFO - 2016-01-28 13:25:45,306 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.623542476402 13:25:45 INFO - 2016-01-28 13:25:45,306 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 13:25:45 INFO - 2016-01-28 13:25:45,306 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 13:25:45 INFO - 2016-01-28 13:25:45,306 DEBUG : BROWSER_OUTPUT: |5;Earley;540.8328826392644 13:25:45 INFO - 2016-01-28 13:25:45,306 DEBUG : BROWSER_OUTPUT: |6;Boyer;10589.473684210527 13:25:45 INFO - 2016-01-28 13:25:45,307 DEBUG : BROWSER_OUTPUT: |7;RegExp;24238.095238095237 13:25:45 INFO - 2016-01-28 13:25:45,307 DEBUG : BROWSER_OUTPUT: |8;Splay;530.5039787798408 13:25:45 INFO - 2016-01-28 13:25:45,307 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:25:45 INFO - 2016-01-28 13:25:45,307 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: __startTimestamp1454016345303__endTimestamp 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,308 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.24 Median:168.24 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,309 DEBUG : BROWSER_OUTPUT: Values: 168.2 13:25:45 INFO - 2016-01-28 13:25:45,309 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,309 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,309 DEBUG : BROWSER_OUTPUT: Values: 166.8 13:25:45 INFO - 2016-01-28 13:25:45,309 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,310 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,310 DEBUG : BROWSER_OUTPUT: Values: 277.6 13:25:45 INFO - 2016-01-28 13:25:45,310 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,310 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,311 DEBUG : BROWSER_OUTPUT: Values: 5164.9 13:25:45 INFO - 2016-01-28 13:25:45,311 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,311 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,311 DEBUG : BROWSER_OUTPUT: Values: 949.7 13:25:45 INFO - 2016-01-28 13:25:45,311 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,312 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:540.83 Median:540.83 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,312 DEBUG : BROWSER_OUTPUT: Values: 540.8 13:25:45 INFO - 2016-01-28 13:25:45,312 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,312 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10589.47 Median:10589.47 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,312 DEBUG : BROWSER_OUTPUT: Values: 10589.5 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24238.10 Median:24238.10 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: Values: 24238.1 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:530.50 Median:530.50 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: Values: 530.5 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:25:45 INFO - 2016-01-28 13:25:45,313 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:25:45 INFO - 2016-01-28 13:25:45,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:25:45 INFO - 2016-01-28 13:25:45,314 DEBUG : BROWSER_OUTPUT: 13:25:45 INFO - 2016-01-28 13:25:45,998 INFO : Browser exited with error code: 0 13:25:46 INFO - 2016-01-28 13:25:46,012 INFO : Completed test v8_7 (00:00:39) 13:25:46 INFO - 2016-01-28 13:25:46,374 INFO : Completed test suite (00:20:08) 13:25:46 INFO - 2016-01-28 13:25:46,374 DEBUG : Working with test: dromaeo_css 13:25:46 INFO - 2016-01-28 13:25:46,374 DEBUG : Generating results file: dromaeo_css 13:25:46 INFO - 2016-01-28 13:25:46,375 DEBUG : Working with test: kraken 13:25:46 INFO - 2016-01-28 13:25:46,376 DEBUG : Generating results file: kraken 13:25:46 INFO - 2016-01-28 13:25:46,376 INFO : javascript benchmark 13:25:46 INFO - 2016-01-28 13:25:46,376 DEBUG : Working with test: v8_7 13:25:46 INFO - 2016-01-28 13:25:46,376 DEBUG : Generating results file: v8_7 13:25:46 INFO - 2016-01-28 13:25:46,377 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:46 INFO - 2016-01-28 13:25:46,429 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:25:46 INFO - 2016-01-28 13:25:46,430 DEBUG : process_Request line: dromaeo_css 7314.33 graph.html#tests=[[72,53,35]] 13:25:46 INFO - 2016-01-28 13:25:46,430 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:46 INFO - 2016-01-28 13:25:46,466 DEBUG : process_Request line: kraken 1473.10 graph.html#tests=[[232,53,35]] 13:25:46 INFO - 2016-01-28 13:25:46,466 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:25:46 INFO - 2016-01-28 13:25:46,502 DEBUG : process_Request line: v8_7 23230.67 graph.html#tests=[[230,53,35]] 13:25:46 INFO - 2016-01-28 13:25:46,503 INFO : javascript benchmark 13:25:46 INFO - 2016-01-28 13:25:46,507 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3281.245313577877, 3291.1443024813543, 3315.8342082895865, 3319.634840167581, 3351.9664803351966, 5456.590755693324, 5463.48096930791, 5469.699166545844, 5488.643238189515, 5493.258410114633, 5432.891342173154, 5435.918461223085, 5444.237806707064, 5445.264889239951, 5447.428020057896, 4945.752712364385, 4979.800807967686, 4999.125153098212, 5014.548690617844, 5020.523050310215, 4944.505549445063, 5025.773840177182, 5047.041062198189, 5054.545090941814, 5133.743312834362, 5039.697618142924, 5105.693658380491, 5111.386633603973, 5116.974415127919, 5125.333706618135, 5053.9241911371355, 5109.386873575158, 5113.335266415379, 5122.846314610568, 5124.205748109049, 4890.926636100461, 4952.87617809554, 4989.700617962933, 5022.899542009176, 5026.874328141789, 5351.839444816662, 5360.91958620621, 5362.65142765719, 5377.973110134424, 5404.8108316208745, 5923.7926672566255, 5925.111233314994, 5936.376680448577, 5937.139114828369, 5948.375420580864, 5690.886182276373, 5860.7948721794955, 5922.822315330547, 6041.24484439445, 6060.939390606081, 5564.4991950724625, 5566.805161819317, 5568.832935011957, 5570.303712035955, 5578.721063946787, 5782.7686892523825, 6023.066424704178, 6042.425969532887, 6050.2437195350585, 6064.393560643988, 5798.33319168301, 5847.298324201123, 5870.9412905870395, 5874.94125058744, 5895.705214739246, 5955.225820643289, 6043.516518678495, 6058.5153187745755, 6059.060845568855, 6067.817965461043, 5708.971455142698, 5851.853703657357, 6002.789902353396, 6007.579469437097, 6024.608400453956, 5816.651000939957, 5873.676947767828, 5877.441643043904, 5892.057270836645, 5909.349971503131, 4514.345419914094, 4574.702644328108, 4619.145458090264, 4619.330197121399, 4653.441587009581, 3999.680025597945, 4040.151568170717, 4079.204555111725, 4082.7346222496035, 4176.1230141669985, 5738.741756620879, 5740.712964351766, 5751.626144300607, 5755.9424405756245, 5758.107493338455, 6073.18012068374, 6077.513798896078, 6091.817245482643, 6098.0243161094895, 6099.878002439927, 5447.428020057916, 5485.780568777204, 5565.41563135873, 5565.443455654402, 5745.913811292834, 5223.555997740159, 5235.293235413246, 5237.685738855681, 5238.3190185276435, 5258.579313654898, 6130.325664177026, 6153.476954458832, 6159.291681456601, 6173.506119510428, 6177.69111544421, 5813.883722325614, 5870.7945221917025, 5943.91084133747, 5980.923433781961, 6012.428819262163, 6128.50971922254, 6139.017757158833, 6139.140520327069, 6140.600860944024, 6151.6001459904965, 5857.238558987475, 5924.407559244041, 5925.733341999534, 5930.406959304035, 5933.465988061095, 5778.364379918122, 5895.675737834289, 6019.217501724747, 6108.534230485914, 6118.872414788915, 5958.106284057426, 5964.731587078505, 5966.090213579874, 5966.492848107786, 5974.522038236843, 5925.377835327228, 5939.613925094855, 5944.3164036136395, 5947.91078133837, 5956.166136740946, 5586.664800112007, 5687.715614219355, 5712.37163911961, 5790.0, 5803.448672376117, 5879.088741245114, 5986.640801551921, 6009.098635204754, 6016.308124565731, 6017.157597936205, 5527.447255274601, 5868.4424979626865, 5875.118732190205, 5880.323762767336, 5889.057750759858], "unit": "ms", "name": "dojo.html", "value": 5496.912498504965}, {"lowerIsBetter": false, "replicates": [575.8905807896499, 635.612276511328, 638.2245571630468, 649.4804156674659, 680.428440110307, 32318.515222271657, 33298.66701332986, 33308.83345583272, 33309.33381332372, 33435.33129337412, 34518.827405863, 35092.473612895825, 40706.59293407072, 40839.59160408395, 40946.59053409465, 9064.90935090649, 9208.49353285569, 9209.355345125843, 9218.86171707425, 9221.0, 8304.377171712116, 8975.910240897605, 9079.228265597432, 9079.727608171732, 9111.362204645677, 8385.748427547183, 10887.346759194474, 11115.72210694735, 11119.72200694981, 11122.165837562176, 10665.84001239982, 10686.46567671621, 10714.517846696917, 10783.245172837904, 10792.244542882001, 10477.580896764197, 10610.045095941325, 10626.14990800734, 10627.628033018884, 10638.308509946828, 42067.36898946518, 42660.57339426597, 42740.78629606863, 42756.57243427557, 42833.57166428327, 3540.3804334241404, 3604.0269127335473, 3659.835307411173, 3949.111449923773, 4015.4579131817122, 32207.355852883047, 32246.677533224603, 32270.193245168823, 32539.837300813346, 33291.833540832384, 4307.332363483665, 4307.806148723315, 4376.190404775127, 4401.119776044804, 4427.557244275579, 281180.0, 284068.0, 284117.0, 284490.9999999979, 284920.0, 57135.714321428124, 58214.417855821746, 61815.6909215451, 70604.6469767648, 72195.0, 62592.37407625865, 63060.68469657622, 63197.36802631915, 63355.68322158452, 63432.0, 18156.818431815514, 18346.81653183478, 18404.631907362047, 18493.445196644123, 18504.352347667766, 13839.377228024763, 14032.85967140336, 14052.297385130703, 14074.929625351808, 14194.645133871736, 21026.369208923756, 21233.15067397287, 21313.68029479559, 21313.78686213118, 21382.14471421157, 8363.121872203452, 8498.192671696303, 8526.232639062515, 8566.871496927552, 8579.2707619853, 1048.234788604323, 1094.414488248783, 1141.560499207811, 1141.6689160143465, 1158.7624536969902, 29235.119581018484, 29311.85344073266, 29452.85273573661, 29469.705302946695, 30138.24654383614, 1130.7568872692411, 1167.3929556630674, 1167.9299242045504, 1168.1881092640704, 1168.7896178687747, 12824.487020519262, 15153.0, 15400.383984640714, 15771.763423548657, 15812.130332831575, 322528.0, 323983.0, 324647.0, 324690.0, 324861.0, 56722.43277567172, 56827.43172568304, 56931.43068569261, 57041.42958570444, 57121.14318285229, 1192.5587532612988, 1286.2346903592347, 1492.44779431611, 1497.9026363286353, 1536.1013806922851, 27050.0, 28162.1702191085, 28669.28326791847, 28694.713052869203, 29056.27359316034, 44373.778131110426, 44739.77630111828, 44786.3282050776, 44802.55197447984, 44896.0, 218567.0, 219756.0, 220036.0, 220614.0, 221046.0, 32634.0, 33904.66095339015, 34007.82996085004, 34055.148621284665, 34363.48454773131, 40152.79923600363, 40808.79595602003, 40991.385129222486, 41035.1792964145, 41498.585014149474, 38003.61996380001, 38552.614473854905, 40471.59528404678, 42419.5758042428, 42640.78679606582, 37361.0, 37531.24937501289, 37792.811035944644, 37894.24211515809, 38088.619113808505, 36524.26951461009, 37455.625443745215, 37518.43722344222, 37704.245915082094, 37707.0, 32476.0, 33619.663803361655, 33803.323933521686, 34002.31995360128, 34287.31425371528, 23785.0, 24054.26714071074, 25372.0, 25494.74505254998, 25595.104171353913], "unit": "ms", "name": "ext.html", "value": 19473.733047071903}, {"lowerIsBetter": false, "replicates": [369.81509245377293, 372.5920117471368, 376.27191384670664, 378.92610940866535, 379.61658724688056, 17054.024628509218, 19288.903555482204, 19290.71063934042, 19351.22595096196, 19748.70376944345, 17670.293188272484, 18140.818591814077, 18477.907610461963, 18764.155612997412, 18770.81229187708, 4315.697901146921, 4453.28747400416, 5559.305086864142, 5679.687617181054, 5682.948654498931, 5893.705314734268, 6100.389961003886, 6118.0, 6135.539834512407, 6145.078238264274, 6001.849953751169, 6122.295935967376, 6142.26292844857, 6157.445829875311, 6163.322034576193, 6043.60716553427, 6082.726277317532, 6116.44951954324, 6146.754129834823, 6164.29110652274, 5519.420460851633, 5520.806771763009, 5524.254225679522, 5530.5022547970475, 5532.917006244909, 21774.891125544273, 21857.562848742935, 21920.342389728332, 21960.89019554892, 21990.340289791333, 2419.8911049002836, 2485.527749727546, 2550.8469491830365, 2574.9056650923285, 2704.756571908538, 13567.932160339134, 13658.521951731742, 14110.71778564423, 14140.292985350794, 14215.0, 1868.3087257714733, 1880.4264699266719, 1924.114907142716, 1943.5529828139465, 1954.1499447740136, 62086.689566551875, 63038.68480657567, 63082.36917630811, 64462.67768661126, 65021.67489162571, 10332.586696532206, 10477.0, 10480.318779279323, 10512.316699414514, 10558.0, 12978.091533592558, 13146.474141034252, 13153.802692959613, 13154.605361838969, 13172.275524846034, 8228.42401031934, 8326.375521835766, 8536.573171341408, 8544.658213671508, 8619.6983105591, 8634.611442485104, 8651.221390074797, 8662.30701543875, 8726.08376120511, 8740.737777866674, 5745.511631511285, 6030.276366836008, 6189.257289125244, 6246.781362652286, 6407.839804004937, 1783.647899126154, 1815.7457955886186, 1836.6051298970517, 1887.0469064518431, 1917.2426891378107, 969.3989726369696, 975.3513913247752, 1033.4884232304908, 1037.7509397744486, 1099.3898386395467, 16500.504984850475, 17383.826161738474, 17975.550611234823, 18297.268109275745, 18578.97815620127, 1051.8264486359665, 1060.7613287010515, 1092.3991804507489, 1139.2936379444798, 1149.7413082056637, 9120.543972801333, 10348.172146228284, 10647.787044259072, 10687.14502839771, 10854.45727713627, 571477.0, 579041.0, 584369.0, 589268.0, 594127.0, 81757.0, 81939.0, 82829.58585207156, 82971.17028829755, 83987.16012839916, 1215.6535387414544, 1223.4249902545967, 1229.274727910537, 1230.680023193976, 1232.0882546915218, 17073.146342683063, 17312.0, 17434.651306974043, 17514.299428022736, 17803.109844507464, 38135.0, 38409.4238586427, 38443.0, 38604.2279154421, 39387.60612393839, 48918.51081489139, 51071.74464127656, 51195.0, 51564.22653660123, 53868.30351573128, 10426.113780328757, 10445.895541044796, 10468.63359782404, 10632.52153653072, 10636.149108071491, 19006.0, 19464.610707786047, 19611.901940490206, 19659.213631454582, 19776.505587360432, 15775.29011194476, 16180.595485112966, 16184.433544825875, 16385.262663179947, 16588.253528591, 11794.705132371759, 13551.86448135506, 14372.49696260626, 15150.54548363551, 15792.36830526766, 15067.773983390038, 15298.847011529742, 15440.305186266869, 15510.689786203988, 15605.063696178266, 10088.899111008795, 10115.49422528856, 10236.948815255875, 10267.024632659886, 10372.377657340583, 10616.8938310619, 10789.838152427563, 12031.879681203076, 14924.253787310374, 15163.090214586719], "unit": "ms", "name": "jquery.html", "value": 9721.593408979697}, {"lowerIsBetter": false, "replicates": [1533.7622668486388, 1540.8382119877406, 1696.9394128669583, 1782.393986044745, 1814.6461440019193, 6887.827804304895, 7040.753573624924, 7317.853642927145, 7607.54354738716, 7613.581253031081, 7106.5380750251325, 7200.531965422244, 7272.781816545499, 7279.490435669505, 7279.708811647541, 2238.4292005538605, 2268.047420083569, 2274.8976296066635, 2276.0326861084054, 2277.146070223666, 1968.3406058970263, 2002.029015927274, 2241.1035585765662, 2288.302067869299, 2310.410845234463, 2195.3962660268394, 2211.524522227721, 2218.378853920905, 2222.144474377368, 2222.1777942161425, 2281.235786011688, 2309.041747674713, 2309.9422514437188, 2310.260716570698, 2311.306608017588, 2289.187338494827, 2298.0922535598347, 2308.365199570115, 2308.515211805523, 2308.6883270758567, 7565.773026809205, 7641.69433222676, 7664.770056898302, 7667.348275396598, 7690.500117492401, 4492.16894874446, 4599.195140850338, 4605.424321959755, 4607.999999999966, 4611.44662640482, 3013.608230929987, 3031.363413683107, 3054.266975925762, 3056.5720799088144, 3068.3096303331795, 1016.4104819204844, 1042.925786439968, 1046.7016900183412, 1064.9946750266276, 1074.135321066541, 10225.0, 10240.692779216635, 10241.436720980342, 10242.129418999393, 10255.333403328685, 4127.8968025798995, 4151.252774500619, 4175.64507016907, 4175.874723758292, 4177.227212965611, 8883.244924181388, 8884.111588841064, 8887.244584210415, 8889.73330800077, 8898.555072246361, 4649.023705021983, 4654.534546545387, 4656.208444564432, 4662.860114196579, 4663.27719203524, 4266.530681625019, 4267.701260911768, 4267.722598031118, 4269.060806622538, 4275.679324050709, 3722.7207959403154, 3743.5320584926885, 3750.3999360102252, 3772.7359084864347, 3775.0562359410146, 1105.6075093341908, 1149.620625193684, 1199.9280043197436, 1220.6216073017392, 1226.5645695778048, 1134.5575225661999, 1137.0164807441504, 1184.6327638432113, 1359.7076628524915, 1421.0620990146454, 7015.228324884259, 7046.6828992695455, 7109.075820143348, 7110.253423390573, 7121.857562848714, 1100.906422954058, 1131.9434028298551, 1187.7921363761307, 1199.5741511763372, 1213.9635810925686, 5804.88390232193, 5859.794907178229, 5874.970625146847, 5889.970550147222, 5890.0, 8595.87106193395, 8957.014728379872, 8974.730758077269, 9009.684661036832, 9071.138241867013, 8857.0, 8962.910370896338, 8970.237529809909, 8970.775730606787, 8981.730548083568, 7030.894536581955, 7098.29017098286, 7136.107986501687, 7151.570905745568, 7220.277972202738, 7041.084658994298, 7047.541909775849, 7050.330218629222, 7058.505904586629, 7077.186123595852, 7964.960175199087, 8201.343892488705, 8302.211289927447, 8340.499570025819, 8353.415260931677, 8200.507969521848, 8207.9589602054, 8349.749507514784, 8358.247757701836, 8361.916380836114, 6505.804825855232, 6779.932200678128, 6788.049673045876, 6808.080909077211, 6858.971154326891, 6548.508861835287, 7070.575765454089, 7364.852702945804, 7369.078865141857, 7376.0411146550605, 6068.393160683896, 6477.093206950936, 6485.54601177913, 6695.0626912231355, 6872.931270687429, 6816.795496135124, 6834.453243740588, 6863.142107236596, 6909.654517274015, 6952.5480843745, 6795.72817087311, 6905.723771049303, 6907.0, 6908.896366554405, 6910.447164226749, 6398.424141827258, 6433.646149461824, 6435.195600549931, 6440.066190402272, 6443.613383197023, 6355.459785918249, 6435.935640643721, 6450.967745161244, 6524.217093948757, 6555.868882622225], "unit": "ms", "name": "mootools.html", "value": 4435.496056171382}, {"lowerIsBetter": false, "replicates": [332.57264415226433, 340.77168297240854, 343.12674244048895, 350.62308018879713, 358.290584642408, 6165.35263797301, 6235.033569796688, 6243.531735119867, 6249.4687951524065, 6261.3738626137365, 5903.734331955062, 5936.732847021884, 6031.69841507924, 6133.815985520441, 6137.324894261627, 4748.240281554952, 4753.90492190156, 4756.857294281177, 4775.0927323808455, 4776.044791041788, 4515.7516336601475, 4737.194676904935, 4763.190257656207, 4766.118268120392, 4766.285057241407, 4557.908841823178, 4583.977080114611, 4721.575058244757, 4722.693024953384, 4727.22000869856, 4681.0, 4711.0342379812055, 4714.599259063001, 4717.080169366975, 4722.763861806896, 4184.686148538872, 4187.539370669224, 4191.308434108369, 4191.434156388879, 4193.475815523059, 5733.197352370671, 5784.248047753807, 5803.0134877071, 5808.332041815203, 5820.621659592155, 5452.809151679712, 5453.427390124019, 5456.590755693339, 5457.099578569531, 5463.31708536433, 6454.386833250834, 6455.160829092188, 6456.644884531349, 6465.256495502983, 6467.74129034838, 4525.072360166191, 4548.613367863735, 4555.908881822345, 4556.589906908394, 4557.9772101139615, 6561.442277406426, 6726.663666816639, 6729.629870357128, 6729.798106056777, 6737.3262673732725, 4769.499202583748, 4770.499097594703, 4771.284307353924, 4771.475137734916, 4775.092732380836, 4833.492483289204, 4834.178189707688, 4834.347363106006, 4834.5890599299455, 4835.0, 5485.972570137204, 5486.341639003345, 5492.258545096361, 5492.313460817398, 5497.312835895513, 6511.0, 6564.540482166298, 6570.901436478457, 6572.145621069326, 6572.737090516326, 1683.5370273174974, 1701.8128005919339, 1703.5996540812898, 1704.6420251747272, 1705.8826468663046, 1131.7623299107115, 1160.9825852612219, 1162.773259214462, 1165.0097417195486, 1171.3908767440882, 6323.146375239284, 6324.620522768557, 6324.747010119544, 6331.0, 6334.904976425358, 6583.9012414813815, 6756.290589488131, 6764.188297404343, 6768.052472653832, 6778.796636100925, 6256.280527739277, 6340.397662222082, 6371.553991220663, 6407.775727849503, 6444.871102577922, 3641.5812181599454, 3698.7780733156096, 3700.0934770980743, 3701.11173318407, 3704.0, 6832.6925288362145, 6982.1272340957385, 7015.684294206773, 7022.859542809218, 7023.297670233038, 6938.722451101899, 6993.4055605274125, 7014.894776578355, 7050.858982820315, 7054.929450705427, 7058.576485410892, 7072.787816365517, 7073.681684324218, 7074.186468556079, 7078.9381592760465, 6691.397774200345, 6859.348361905611, 6865.794026179223, 6867.553609015398, 6873.450123989969, 6729.5625784323865, 6740.494462915203, 6757.831054223487, 6764.763233286812, 6771.0, 7007.614581198083, 7025.754098606524, 7038.612876291853, 7039.401650859734, 7042.260562641054, 4506.436695413074, 4593.931091033704, 4647.953520464752, 4704.458987216514, 4706.694064885772, 6744.527883048139, 6752.257251702407, 6780.796576102724, 6826.249112597511, 6827.556208846409, 6603.042558829039, 6615.834604134935, 6618.8345291368105, 6620.933790662032, 6624.867502649824, 6505.21937367519, 6619.669016549057, 6630.336966303331, 6636.0377745225705, 6645.102911106938, 6485.6108633482145, 6504.707288172138, 6504.902426463512, 6506.772262970773, 6508.902366464412, 6643.867122657423, 6652.667366631552, 6653.135092437952, 6656.201255849135, 6656.633885136364, 6285.151504546828, 6388.945823938998, 6489.643069631215, 6492.220933488012, 6506.284308726131], "unit": "ms", "name": "prototype.html", "value": 4969.748765433372}, {"lowerIsBetter": false, "replicates": [842.9789255268618, 872.5898827551052, 896.7085697148428, 905.1491597897977, 928.0904713380891, 15055.473058442956, 15173.468928587474, 15259.0, 15321.310541025667, 15329.310181041867, 14082.0846644968, 14137.081089729187, 14169.362378692958, 14199.71600567988, 14227.21750303733, 725.2167658928371, 739.0946091038488, 869.4696235296464, 875.4484674654958, 881.3301890563154, 873.8732883731855, 877.1360210192955, 879.151618687966, 882.1487264789477, 883.2227639677108, 764.6826566974698, 776.9572673502955, 906.1708536688922, 915.4095608332655, 915.5879854065664, 893.8837951066353, 903.9096090390941, 906.7415786500882, 908.3006085314337, 908.9818203635923, 674.5581644023173, 679.8606285711418, 680.1667956752988, 680.6460640466979, 681.2846511163308, 12920.418581163776, 13037.739245215043, 13072.346382680924, 13086.541971030969, 13089.672758181026, 13055.281959492224, 13526.864731352758, 13557.59327220185, 13622.0, 13677.521286755014, 10852.728681782939, 11071.944640276828, 11325.773484530264, 11418.200725949187, 11450.083993280601, 3719.4048952167796, 3804.6005169457085, 3810.8856734298015, 3852.9422058669143, 3872.9225415491533, 47206.291905621445, 47405.76297118527, 47717.0, 48072.51927480716, 48639.99999999964, 11093.334399935868, 11117.328671813511, 11240.718982025515, 11314.773704525864, 11456.94271528637, 19874.50313742168, 19874.60250794976, 19874.801251987585, 19941.401757947286, 20001.499962500762, 7952.801179970547, 8073.798155046171, 8124.675012999532, 8204.917950820534, 8363.247307742333, 4454.710443821141, 4469.932951005738, 4489.281714925596, 4500.729956202638, 4551.2945493447905, 3057.5260834570677, 3099.8140111593375, 3100.534919762054, 3100.90697279082, 3103.7827352085137, 521.7547752556293, 524.4781442464696, 532.1963834609767, 538.8410418926347, 550.9862253443696, 605.9515238780887, 659.6240143118376, 679.8504329047602, 695.1658010387555, 716.8924661300847, 9245.306602004877, 9546.18857397115, 9633.373830700983, 9667.129958303787, 9711.951440242894, 510.7650480778809, 590.1884908251154, 670.1054092786185, 695.2734392559686, 717.6626985316892, 4106.301928672133, 4457.888552786141, 4516.299973504112, 4517.435320584927, 4522.954770452319, 60775.0, 61090.0, 61401.38598614046, 61419.0, 66344.0, 51009.744951275, 51170.74414627903, 51509.48490515122, 51618.741906290226, 52219.21671174935, 47647.76176119028, 48380.27429588559, 48963.75518122387, 49279.0, 49974.25038624424, 9181.908180918372, 9201.30990175726, 9418.764530886509, 9563.713088607075, 9775.706728798148, 35472.46791298184, 37046.629533705396, 37428.2514349706, 37672.62327376801, 38656.0, 47535.762321189555, 47766.0, 47882.0, 48260.0, 48281.51718482911, 11223.38271395081, 11403.771924561628, 11682.177942170769, 11922.76154476923, 11944.343061131374, 13292.601221963356, 13385.263810490516, 13586.93206533961, 14150.716985660434, 14688.412463501767, 11481.827772583585, 12011.459484323052, 12439.937800310941, 12939.353032348157, 13159.868401316247, 11658.88341116578, 11962.641120766391, 12087.879121208676, 12100.75798484043, 12483.500659973499, 9795.559199835881, 11429.0, 11462.484188211718, 11513.53945842157, 11918.04655627565, 10061.748456288651, 10219.437930913871, 10294.742631433974, 10477.528511217166, 10552.894471055499, 9760.56077476501, 10155.0, 10161.542730576994, 10205.795884082128, 10218.489075546342], "unit": "ms", "name": "yui.html", "value": 6674.593628900249}], "name": "dromaeo_css", "value": 7314.3292482077895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 111.0, 110.0, 111.0, 101.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [150.0, 121.0, 148.0, 155.0, 128.0, 153.0, 153.0, 122.0, 163.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 159.0, 158.0, 160.0, 158.0, 159.0, 162.0, 163.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 154.0, 71.0, 71.0, 70.0, 71.0, 155.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 137.0, 92.0, 93.0, 93.0, 136.0, 91.0, 92.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 59.0, 60.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 78.0, 86.0, 78.0, 78.0, 77.0, 79.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.5}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 113.0, 112.0, 116.0, 113.0, 111.0, 121.0, 116.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.4}, {"lowerIsBetter": true, "replicates": [144.0, 144.0, 144.0, 144.0, 146.0, 135.0, 143.0, 143.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1473.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.23687752355318], "unit": "score", "name": "Richards", "value": 209.83508800000004}, {"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "DeltaBlue", "value": 396.37741000000017}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [540.8328826392644], "unit": "score", "name": "Earley", "value": 1232.290087}, {"lowerIsBetter": false, "replicates": [10589.473684210527], "unit": "score", "name": "Boyer", "value": 62.93636679920471}, {"lowerIsBetter": false, "replicates": [24238.095238095237], "unit": "score", "name": "RegExp", "value": 37.5848428290766}, {"lowerIsBetter": false, "replicates": [530.5039787798408], "unit": "score", "name": "Splay", "value": 153.61053499999994}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23230.67087501954}]} 13:25:46 INFO - RETURN: dromaeo_css: 7314.33 13:25:46 INFO - RETURN: kraken: 1473.10 13:25:46 INFO - RETURN: v8_7: 23230.67 13:25:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23230.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7314.33"}}} 13:25:46 INFO - Return code: 0 13:25:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:25:46 INFO - # TBPL SUCCESS # 13:25:46 INFO - Running post-action listener: _resource_record_post_action 13:25:46 INFO - Running post-run listener: _resource_record_post_run 13:25:47 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 7950336; Write bytes: 403275776; Read time: 2204; Write time: 308000 13:25:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5701632; Read time: 0; Write time: 1316 13:25:47 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 6213632; Write bytes: 397574144; Read time: 2140; Write time: 306684 13:25:47 INFO - Running post-run listener: _upload_blobber_files 13:25:47 INFO - Blob upload gear active. 13:25:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:25:47 INFO - Copying logs to upload dir... 13:25:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.263832 ========= master_lag: 0.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-28 13:25:47.791819) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:25:47.795746) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009859 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454005647/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-28 13:25:47.847349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:25:47.847673) ========= 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-1454014584.860473-1272326920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 13:25:47.897151) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 13:25:47.897485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 13:25:47.897782) ========= ========= Total master_lag: 2.16 =========