builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1455761915.13 results: success (0) buildid: 20160217155825 builduid: 137dd563c2474c6a95413f32a940170e revision: 64374309d490 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.127007) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.127496) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.127798) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.151266) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.151567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.165052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.165413) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.214455) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.214755) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.215112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.215379) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 18:18:35-- 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% 218M=0s 2016-02-17 18:18:35 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.399716) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.400234) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019142 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.450872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:35.451266) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 64374309d490 --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 64374309d490 --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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 18:18:35,805 Setting DEBUG logging. 2016-02-17 18:18:35,805 attempt 1/10 2016-02-17 18:18:35,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/64374309d490?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 18:18:36,077 unpacking tar archive at: mozilla-beta-64374309d490/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:36.048965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:36.049339) ========= echo 64374309d490 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'64374309d490'] 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 64374309d490 program finished with exit code 0 elapsedTime=0.004660 script_repo_revision: '64374309d490' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:36.099664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:36.100003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 18:18:36.110022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-17 18:18:36.110420) ========= /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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:36 INFO - MultiFileLogger online at 20160217 18:18:36 in /builds/slave/test-pgo 18:18:36 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 18:18:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:18:36 INFO - {'append_to_log': False, 18:18:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:18:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:18:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:18:36 INFO - 'branch': 'Mozilla-Beta', 18:18:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:36 INFO - 'config_files': ('talos/linux_config.py',), 18:18:36 INFO - 'default_actions': ('clobber', 18:18:36 INFO - 'read-buildbot-config', 18:18:36 INFO - 'download-and-extract', 18:18:36 INFO - 'populate-webroot', 18:18:36 INFO - 'create-virtualenv', 18:18:36 INFO - 'install', 18:18:36 INFO - 'run-tests'), 18:18:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:36 INFO - 'download_minidump_stackwalk': True, 18:18:36 INFO - 'download_symbols': 'ondemand', 18:18:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:36 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:36 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:36 INFO - 'installer_path': 'installer.exe', 18:18:36 INFO - 'log_level': 'info', 18:18:36 INFO - 'log_name': 'talos', 18:18:36 INFO - 'log_to_console': True, 18:18:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:36 INFO - 'opt_config_files': (), 18:18:36 INFO - 'pip_index': False, 18:18:36 INFO - 'sps_profile': False, 18:18:36 INFO - 'sps_profile_interval': 0, 18:18:36 INFO - 'suite': 'dromaeojs', 18:18:36 INFO - 'system_bits': '32', 18:18:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:36 INFO - 'title': 'talos-linux64-ix-056', 18:18:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:36 INFO - 'use_talos_json': True, 18:18:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:18:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:36 INFO - 'work_dir': 'build'} 18:18:36 INFO - ##### 18:18:36 INFO - ##### Running clobber step. 18:18:36 INFO - ##### 18:18:36 INFO - Running pre-action listener: _resource_record_pre_action 18:18:36 INFO - Running main action method: clobber 18:18:36 INFO - rmtree: /builds/slave/test-pgo/build 18:18:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:18:37 INFO - Running post-action listener: _resource_record_post_action 18:18:37 INFO - ##### 18:18:37 INFO - ##### Running read-buildbot-config step. 18:18:37 INFO - ##### 18:18:37 INFO - Running pre-action listener: _resource_record_pre_action 18:18:37 INFO - Running main action method: read_buildbot_config 18:18:37 INFO - Using buildbot properties: 18:18:37 INFO - { 18:18:37 INFO - "properties": { 18:18:37 INFO - "buildnumber": 113, 18:18:37 INFO - "product": "firefox", 18:18:37 INFO - "script_repo_revision": "production", 18:18:37 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:18:37 INFO - "repository": "", 18:18:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:18:37 INFO - "buildid": "20160217155825", 18:18:37 INFO - "slavename": "talos-linux64-ix-056", 18:18:37 INFO - "pgo_build": "True", 18:18:37 INFO - "basedir": "/builds/slave/test-pgo", 18:18:37 INFO - "project": "", 18:18:37 INFO - "platform": "ubuntu64_hw", 18:18:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:18:37 INFO - "slavebuilddir": "test", 18:18:37 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:18:37 INFO - "branch": "mozilla-beta", 18:18:37 INFO - "repo_path": "releases/mozilla-beta", 18:18:37 INFO - "stage_platform": "linux64-pgo", 18:18:37 INFO - "builduid": "137dd563c2474c6a95413f32a940170e", 18:18:37 INFO - "revision": "64374309d490" 18:18:37 INFO - }, 18:18:37 INFO - "sourcestamp": { 18:18:37 INFO - "repository": "", 18:18:37 INFO - "hasPatch": false, 18:18:37 INFO - "project": "", 18:18:37 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 18:18:37 INFO - "changes": [ 18:18:37 INFO - { 18:18:37 INFO - "category": null, 18:18:37 INFO - "files": [ 18:18:37 INFO - { 18:18:37 INFO - "url": null, 18:18:37 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2" 18:18:37 INFO - } 18:18:37 INFO - ], 18:18:37 INFO - "repository": "", 18:18:37 INFO - "rev": "64374309d490", 18:18:37 INFO - "who": "sendchange", 18:18:37 INFO - "when": 1455761877, 18:18:37 INFO - "number": 7619767, 18:18:37 INFO - "comments": "Bug 1245866 - A better buffer size check in nsIDNService::IDNA2008ToUnicode, r=jfkthame a=abillings", 18:18:37 INFO - "project": "", 18:18:37 INFO - "at": "Wed 17 Feb 2016 18:17:57", 18:18:37 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 18:18:37 INFO - "revlink": "", 18:18:37 INFO - "properties": [ 18:18:37 INFO - [ 18:18:37 INFO - "buildid", 18:18:37 INFO - "20160217155825", 18:18:37 INFO - "Change" 18:18:37 INFO - ], 18:18:37 INFO - [ 18:18:37 INFO - "builduid", 18:18:37 INFO - "137dd563c2474c6a95413f32a940170e", 18:18:37 INFO - "Change" 18:18:37 INFO - ], 18:18:37 INFO - [ 18:18:37 INFO - "pgo_build", 18:18:37 INFO - "True", 18:18:37 INFO - "Change" 18:18:37 INFO - ] 18:18:37 INFO - ], 18:18:37 INFO - "revision": "64374309d490" 18:18:37 INFO - } 18:18:37 INFO - ], 18:18:37 INFO - "revision": "64374309d490" 18:18:37 INFO - } 18:18:37 INFO - } 18:18:37 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2. 18:18:37 INFO - Running post-action listener: _resource_record_post_action 18:18:37 INFO - ##### 18:18:37 INFO - ##### Running download-and-extract step. 18:18:37 INFO - ##### 18:18:37 INFO - Running pre-action listener: _resource_record_pre_action 18:18:37 INFO - Running main action method: download_and_extract 18:18:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/test_packages.json 18:18:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:18:37 INFO - Downloaded 1270 bytes. 18:18:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:18:37 INFO - Using the following test package requirements: 18:18:37 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 18:18:37 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:37 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'jsshell-linux-x86_64.zip'], 18:18:37 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:37 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 18:18:37 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 18:18:37 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 18:18:37 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:37 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 18:18:37 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 18:18:37 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:37 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:37 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.common.tests.zip 18:18:37 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:38 INFO - Downloaded 22255750 bytes. 18:18: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 18:18:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 18:18: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 18:18:39 INFO - Return code: 0 18:18: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 18:18: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')]} 18:18:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.common.tests.zip 18:18:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:39 INFO - Downloaded 22255750 bytes. 18:18: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 18:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 18:18: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 18:18:40 INFO - Return code: 0 18:18: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')]} 18:18:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 18:18:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:43 INFO - Downloaded 11132038 bytes. 18:18: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 18:18:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 18:18: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 18:18:43 INFO - Return code: 0 18:18: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')]} 18:18:43 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2 18:18:43 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/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 18:18:46 INFO - Downloaded 58336158 bytes. 18:18:46 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2 18:18:46 INFO - mkdir: /builds/slave/test-pgo/properties 18:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:18:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:18:46 INFO - Contents: 18:18:46 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2 18:18:46 INFO - Running post-action listener: _resource_record_post_action 18:18:46 INFO - Running post-action listener: set_extra_try_arguments 18:18:46 INFO - ##### 18:18:46 INFO - ##### Running populate-webroot step. 18:18:46 INFO - ##### 18:18:46 INFO - Running pre-action listener: _resource_record_pre_action 18:18:46 INFO - Running main action method: populate_webroot 18:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:46 INFO - '--tppagecycles', 18:18:46 INFO - '7'], 18:18:46 INFO - 'tests': ['tsvgm']}}, 18:18:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:18:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:18:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'tests': ['damp', 'tps']}, 18:18:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['damp', 'tps']}, 18:18:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:46 INFO - 'other': {'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'other_l64': {'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'other_nol64': {'tests': ['a11yr', 18:18:46 INFO - 'ts_paint', 18:18:46 INFO - 'tpaint', 18:18:46 INFO - 'sessionrestore', 18:18:46 INFO - 'sessionrestore_no_auto_restore']}, 18:18:46 INFO - 'svgr': {'tests': ['tsvgx', 18:18:46 INFO - 'tsvgr_opacity', 18:18:46 INFO - 'tart', 18:18:46 INFO - 'tscrollx', 18:18:46 INFO - 'cart']}, 18:18:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['tsvgx', 18:18:46 INFO - 'tsvgr_opacity', 18:18:46 INFO - 'tart', 18:18:46 INFO - 'tscrollx', 18:18:46 INFO - 'cart']}, 18:18:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'tests': ['tp5o']}, 18:18:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'talos_options': ['--e10s'], 18:18:46 INFO - 'tests': ['tp5o']}, 18:18:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'talos_options': ['--xperf_path', 18:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:46 INFO - 'tests': ['tp5n']}, 18:18:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:46 INFO - 'talos_options': ['--e10s', 18:18:46 INFO - '--xperf_path', 18:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:46 INFO - 'tests': ['tp5n']}}, 18:18:46 INFO - 'talos.zip': {'path': '', 18:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:46 INFO - Running post-action listener: _resource_record_post_action 18:18:46 INFO - ##### 18:18:46 INFO - ##### Running create-virtualenv step. 18:18:46 INFO - ##### 18:18:46 INFO - Running pre-action listener: _resource_record_pre_action 18:18:46 INFO - Running main action method: create_virtualenv 18:18:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:18:46 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 18:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:46 INFO - Using real prefix '/usr' 18:18:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:49 INFO - Installing pip.................done. 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:18:49 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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'DISPLAY': ':0', 18:18:49 INFO - 'HOME': '/home/cltbld', 18:18:49 INFO - 'LANG': 'en_US.UTF-8', 18:18:49 INFO - 'LANGUAGE': 'en_US:en', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MAIL': '/var/mail/cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SHLVL': '1', 18:18:49 INFO - 'TERM': 'linux', 18:18:49 INFO - 'TMOUT': '86400', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - '_': '/tools/buildbot/bin/python'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 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 18:18:49 INFO - Cleaning up... 18:18:49 INFO - Return code: 0 18:18:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:18:49 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')]} 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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')]} 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:49 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:18:49 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 18:18:49 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 18:18:49 INFO - Using env: {'DISPLAY': ':0', 18:18:49 INFO - 'HOME': '/home/cltbld', 18:18:49 INFO - 'LANG': 'en_US.UTF-8', 18:18:49 INFO - 'LANGUAGE': 'en_US:en', 18:18:49 INFO - 'LOGNAME': 'cltbld', 18:18:49 INFO - 'MAIL': '/var/mail/cltbld', 18:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:49 INFO - 'MOZ_NO_REMOTE': '1', 18:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:49 INFO - 'NO_EM_RESTART': '1', 18:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:49 INFO - 'SHELL': '/bin/bash', 18:18:49 INFO - 'SHLVL': '1', 18:18:49 INFO - 'TERM': 'linux', 18:18:49 INFO - 'TMOUT': '86400', 18:18:49 INFO - 'USER': 'cltbld', 18:18:49 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:49 INFO - '_': '/tools/buildbot/bin/python'} 18:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:49 INFO - Downloading/unpacking psutil>=0.7.1 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:51 INFO - Installing collected packages: psutil 18:18:51 INFO - Running setup.py install for psutil 18:18:51 INFO - building 'psutil._psutil_linux' extension 18:18:51 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 18:18:51 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 18:18:51 INFO - building 'psutil._psutil_posix' extension 18:18:51 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 18:18:52 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 18:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:52 INFO - Successfully installed psutil 18:18:52 INFO - Cleaning up... 18:18:52 INFO - Return code: 0 18:18:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:52 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:18:52 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 18:18:52 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 18:18:52 INFO - Using env: {'DISPLAY': ':0', 18:18:52 INFO - 'HOME': '/home/cltbld', 18:18:52 INFO - 'LANG': 'en_US.UTF-8', 18:18:52 INFO - 'LANGUAGE': 'en_US:en', 18:18:52 INFO - 'LOGNAME': 'cltbld', 18:18:52 INFO - 'MAIL': '/var/mail/cltbld', 18:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:52 INFO - 'MOZ_NO_REMOTE': '1', 18:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:52 INFO - 'NO_EM_RESTART': '1', 18:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:52 INFO - 'SHELL': '/bin/bash', 18:18:52 INFO - 'SHLVL': '1', 18:18:52 INFO - 'TERM': 'linux', 18:18:52 INFO - 'TMOUT': '86400', 18:18:52 INFO - 'USER': 'cltbld', 18:18:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:52 INFO - '_': '/tools/buildbot/bin/python'} 18:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:52 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 18:18:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:18:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:18:54 INFO - Installing collected packages: mozsystemmonitor 18:18:54 INFO - Running setup.py install for mozsystemmonitor 18:18:54 INFO - Successfully installed mozsystemmonitor 18:18:54 INFO - Cleaning up... 18:18:54 INFO - Return code: 0 18:18:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:54 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:18:54 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 18:18:54 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 18:18:54 INFO - Using env: {'DISPLAY': ':0', 18:18:54 INFO - 'HOME': '/home/cltbld', 18:18:54 INFO - 'LANG': 'en_US.UTF-8', 18:18:54 INFO - 'LANGUAGE': 'en_US:en', 18:18:54 INFO - 'LOGNAME': 'cltbld', 18:18:54 INFO - 'MAIL': '/var/mail/cltbld', 18:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:54 INFO - 'MOZ_NO_REMOTE': '1', 18:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:54 INFO - 'NO_EM_RESTART': '1', 18:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:54 INFO - 'SHELL': '/bin/bash', 18:18:54 INFO - 'SHLVL': '1', 18:18:54 INFO - 'TERM': 'linux', 18:18:54 INFO - 'TMOUT': '86400', 18:18:54 INFO - 'USER': 'cltbld', 18:18:54 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:54 INFO - '_': '/tools/buildbot/bin/python'} 18:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:18:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:57 INFO - Downloading docopt-0.6.1.tar.gz 18:18:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:57 INFO - Running setup.py install for blobuploader 18:18:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:18:57 INFO - Running setup.py install for requests 18:18:57 INFO - Running setup.py install for docopt 18:18:57 INFO - Successfully installed blobuploader requests docopt 18:18:57 INFO - Cleaning up... 18:18:57 INFO - Return code: 0 18:18:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:18:57 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')]} 18:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:57 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')]} 18:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:57 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:18:57 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 18:18:57 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 18:18:57 INFO - Using env: {'DISPLAY': ':0', 18:18:57 INFO - 'HOME': '/home/cltbld', 18:18:57 INFO - 'LANG': 'en_US.UTF-8', 18:18:57 INFO - 'LANGUAGE': 'en_US:en', 18:18:57 INFO - 'LOGNAME': 'cltbld', 18:18:57 INFO - 'MAIL': '/var/mail/cltbld', 18:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:57 INFO - 'MOZ_NO_REMOTE': '1', 18:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:57 INFO - 'NO_EM_RESTART': '1', 18:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:18:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:18:57 INFO - 'SHELL': '/bin/bash', 18:18:57 INFO - 'SHLVL': '1', 18:18:57 INFO - 'TERM': 'linux', 18:18:57 INFO - 'TMOUT': '86400', 18:18:57 INFO - 'USER': 'cltbld', 18:18:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:57 INFO - '_': '/tools/buildbot/bin/python'} 18:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:18:58 INFO - Running setup.py (path:/tmp/pip-JdbXR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:18:58 INFO - Running setup.py (path:/tmp/pip-3XvxHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:18:58 INFO - Running setup.py (path:/tmp/pip-m_E77z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:18:58 INFO - Running setup.py (path:/tmp/pip-ItD12s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:18:58 INFO - Running setup.py (path:/tmp/pip-DeZsDa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:18:58 INFO - Running setup.py (path:/tmp/pip-cElODz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:18:58 INFO - Running setup.py (path:/tmp/pip-PMMMrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:18:58 INFO - Running setup.py (path:/tmp/pip-f_i5xC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:18:58 INFO - Running setup.py (path:/tmp/pip-QFfLp3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:18:58 INFO - Running setup.py (path:/tmp/pip-_CnNB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:18:58 INFO - Running setup.py (path:/tmp/pip-NMTV0E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:18:58 INFO - Running setup.py (path:/tmp/pip-YuWBlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:18:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:18:58 INFO - Running setup.py (path:/tmp/pip-oFhcGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:18:59 INFO - Running setup.py (path:/tmp/pip-aUDPiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:18:59 INFO - Running setup.py (path:/tmp/pip-kz10u2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:18:59 INFO - Running setup.py (path:/tmp/pip-pQx1w3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:18:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:18:59 INFO - Running setup.py (path:/tmp/pip-v_YQsm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:18:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:59 INFO - Running setup.py install for manifestparser 18:18:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:18:59 INFO - Running setup.py install for mozcrash 18:18:59 INFO - Running setup.py install for mozdebug 18:18:59 INFO - Running setup.py install for mozdevice 18:18:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:18:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:18:59 INFO - Running setup.py install for mozfile 18:18:59 INFO - Running setup.py install for mozhttpd 18:18:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:18:59 INFO - Running setup.py install for mozinfo 18:18:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:18:59 INFO - Running setup.py install for mozInstall 18:19:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Running setup.py install for mozleak 18:19:00 INFO - Running setup.py install for mozlog 18:19:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Running setup.py install for moznetwork 18:19:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Running setup.py install for mozprocess 18:19:00 INFO - Running setup.py install for mozprofile 18:19:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Running setup.py install for mozrunner 18:19:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:19:00 INFO - Running setup.py install for mozscreenshot 18:19:00 INFO - Running setup.py install for moztest 18:19:00 INFO - Running setup.py install for mozversion 18:19:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:19:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:19:01 INFO - Cleaning up... 18:19:01 INFO - Return code: 0 18:19:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:01 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:19:01 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 18:19:01 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 18:19:01 INFO - Using env: {'DISPLAY': ':0', 18:19:01 INFO - 'HOME': '/home/cltbld', 18:19:01 INFO - 'LANG': 'en_US.UTF-8', 18:19:01 INFO - 'LANGUAGE': 'en_US:en', 18:19:01 INFO - 'LOGNAME': 'cltbld', 18:19:01 INFO - 'MAIL': '/var/mail/cltbld', 18:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:01 INFO - 'MOZ_NO_REMOTE': '1', 18:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:01 INFO - 'NO_EM_RESTART': '1', 18:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:01 INFO - 'SHELL': '/bin/bash', 18:19:01 INFO - 'SHLVL': '1', 18:19:01 INFO - 'TERM': 'linux', 18:19:01 INFO - 'TMOUT': '86400', 18:19:01 INFO - 'USER': 'cltbld', 18:19:01 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:01 INFO - '_': '/tools/buildbot/bin/python'} 18:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:01 INFO - Running setup.py (path:/tmp/pip-6XsmpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:01 INFO - Running setup.py (path:/tmp/pip-DtJWEO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:01 INFO - Running setup.py (path:/tmp/pip-qk9MCl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:01 INFO - Running setup.py (path:/tmp/pip-4nHJks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:01 INFO - Running setup.py (path:/tmp/pip-hiOr4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:01 INFO - Running setup.py (path:/tmp/pip-phFwb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:01 INFO - Running setup.py (path:/tmp/pip-mV7rv0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:01 INFO - Running setup.py (path:/tmp/pip-zlKY4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:01 INFO - Running setup.py (path:/tmp/pip-goalDs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:19:01 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)) 18:19:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:01 INFO - Running setup.py (path:/tmp/pip-5K9BEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:02 INFO - Running setup.py (path:/tmp/pip-Wffmlf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:02 INFO - Running setup.py (path:/tmp/pip-jLbXt9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:02 INFO - Running setup.py (path:/tmp/pip-1gyKWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:02 INFO - Running setup.py (path:/tmp/pip-iX5oUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:02 INFO - Running setup.py (path:/tmp/pip-FkUk5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:02 INFO - Running setup.py (path:/tmp/pip-Yk8TJO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:19:02 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)) 18:19:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:02 INFO - Running setup.py (path:/tmp/pip-LRAgDx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 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)) 18:19:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:02 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 18:19:04 INFO - Downloading blessings-1.6.tar.gz 18:19:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:19:04 INFO - Installing collected packages: blessings 18:19:04 INFO - Running setup.py install for blessings 18:19:04 INFO - Successfully installed blessings 18:19:04 INFO - Cleaning up... 18:19:04 INFO - Return code: 0 18:19:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:19:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:19:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:19:04 INFO - Reading from file tmpfile_stdout 18:19:04 INFO - Current package versions: 18:19:04 INFO - argparse == 1.2.1 18:19:04 INFO - blessings == 1.6 18:19:04 INFO - blobuploader == 1.2.4 18:19:04 INFO - docopt == 0.6.1 18:19:04 INFO - manifestparser == 1.1 18:19:04 INFO - mozInstall == 1.12 18:19:04 INFO - mozcrash == 0.16 18:19:04 INFO - mozdebug == 0.1 18:19:04 INFO - mozdevice == 0.47 18:19:04 INFO - mozfile == 1.2 18:19:04 INFO - mozhttpd == 0.7 18:19:04 INFO - mozinfo == 0.9 18:19:04 INFO - mozleak == 0.1 18:19:04 INFO - mozlog == 3.1 18:19:04 INFO - moznetwork == 0.27 18:19:04 INFO - mozprocess == 0.22 18:19:04 INFO - mozprofile == 0.27 18:19:04 INFO - mozrunner == 6.11 18:19:04 INFO - mozscreenshot == 0.1 18:19:04 INFO - mozsystemmonitor == 0.0 18:19:04 INFO - moztest == 0.7 18:19:04 INFO - mozversion == 1.4 18:19:04 INFO - psutil == 3.1.1 18:19:04 INFO - requests == 1.2.3 18:19:04 INFO - wsgiref == 0.1.2 18:19:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:19:04 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 18:19:04 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 18:19:04 INFO - Using env: {'DISPLAY': ':0', 18:19:04 INFO - 'HOME': '/home/cltbld', 18:19:04 INFO - 'LANG': 'en_US.UTF-8', 18:19:04 INFO - 'LANGUAGE': 'en_US:en', 18:19:04 INFO - 'LOGNAME': 'cltbld', 18:19:04 INFO - 'MAIL': '/var/mail/cltbld', 18:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:04 INFO - 'MOZ_NO_REMOTE': '1', 18:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:04 INFO - 'NO_EM_RESTART': '1', 18:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:04 INFO - 'SHELL': '/bin/bash', 18:19:04 INFO - 'SHLVL': '1', 18:19:04 INFO - 'TERM': 'linux', 18:19:04 INFO - 'TMOUT': '86400', 18:19:04 INFO - 'USER': 'cltbld', 18:19:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:04 INFO - '_': '/tools/buildbot/bin/python'} 18:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 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)) 18:19:05 INFO - Cleaning up... 18:19:05 INFO - Return code: 0 18:19:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:19: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')]} 18:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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')]} 18:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:19: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', 'jsonschema'] in /builds/slave/test-pgo/build 18:19: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 jsonschema 18:19:05 INFO - Using env: {'DISPLAY': ':0', 18:19:05 INFO - 'HOME': '/home/cltbld', 18:19:05 INFO - 'LANG': 'en_US.UTF-8', 18:19:05 INFO - 'LANGUAGE': 'en_US:en', 18:19:05 INFO - 'LOGNAME': 'cltbld', 18:19:05 INFO - 'MAIL': '/var/mail/cltbld', 18:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:05 INFO - 'MOZ_NO_REMOTE': '1', 18:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:05 INFO - 'NO_EM_RESTART': '1', 18:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:05 INFO - 'SHELL': '/bin/bash', 18:19:05 INFO - 'SHLVL': '1', 18:19:05 INFO - 'TERM': 'linux', 18:19:05 INFO - 'TMOUT': '86400', 18:19:05 INFO - 'USER': 'cltbld', 18:19:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:05 INFO - '_': '/tools/buildbot/bin/python'} 18:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:05 INFO - Downloading/unpacking jsonschema 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:19:07 INFO - Downloading/unpacking functools32 (from jsonschema) 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:19:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:19:07 INFO - warning: no files found matching '*.txt' 18:19:07 INFO - no previously-included directories found matching 'build' 18:19:07 INFO - no previously-included directories found matching 'dist' 18:19:07 INFO - no previously-included directories found matching '.git*' 18:19:07 INFO - Installing collected packages: jsonschema, functools32 18:19:07 INFO - Running setup.py install for functools32 18:19:07 INFO - warning: no files found matching '*.txt' 18:19:07 INFO - no previously-included directories found matching 'build' 18:19:07 INFO - no previously-included directories found matching 'dist' 18:19:07 INFO - no previously-included directories found matching '.git*' 18:19:07 INFO - Successfully installed jsonschema functools32 18:19:07 INFO - Cleaning up... 18:19:07 INFO - Return code: 0 18:19:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:19:07 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')]} 18:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:07 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')]} 18:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:19:07 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 0x7f05bf5c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, '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': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', '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 18:19:07 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 18:19:07 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 18:19:07 INFO - Using env: {'DISPLAY': ':0', 18:19:07 INFO - 'HOME': '/home/cltbld', 18:19:07 INFO - 'LANG': 'en_US.UTF-8', 18:19:07 INFO - 'LANGUAGE': 'en_US:en', 18:19:07 INFO - 'LOGNAME': 'cltbld', 18:19:07 INFO - 'MAIL': '/var/mail/cltbld', 18:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:07 INFO - 'MOZ_NO_REMOTE': '1', 18:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:07 INFO - 'NO_EM_RESTART': '1', 18:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:07 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:07 INFO - 'SHELL': '/bin/bash', 18:19:07 INFO - 'SHLVL': '1', 18:19:07 INFO - 'TERM': 'linux', 18:19:07 INFO - 'TMOUT': '86400', 18:19:07 INFO - 'USER': 'cltbld', 18:19:07 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:07 INFO - '_': '/tools/buildbot/bin/python'} 18:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:19:07 INFO - Downloading/unpacking flake8 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19: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 18:19:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:19:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:19:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:19:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:10 INFO - no previously-included directories found matching 'docs/_build' 18:19:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:19:10 INFO - Running setup.py install for pep8 18:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:19:10 INFO - no previously-included directories found matching 'docs/_build' 18:19:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:19:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:19:10 INFO - Cleaning up... 18:19:10 INFO - Return code: 0 18:19:10 INFO - Running post-action listener: _resource_record_post_action 18:19:10 INFO - Running post-action listener: _start_resource_monitoring 18:19:10 INFO - Starting resource monitoring. 18:19:10 INFO - ##### 18:19:10 INFO - ##### Running install step. 18:19:10 INFO - ##### 18:19:10 INFO - Running pre-action listener: _resource_record_pre_action 18:19:10 INFO - Running main action method: install 18:19:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:19:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:19:10 INFO - Reading from file tmpfile_stdout 18:19:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:19:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:19:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:19:10 INFO - Reading from file tmpfile_stdout 18:19:10 INFO - Output received: 18:19:10 INFO - Usage: mozinstall [options] installer 18:19:10 INFO - Options: 18:19:10 INFO - -h, --help show this help message and exit 18:19:10 INFO - -d DEST, --destination=DEST 18:19:10 INFO - Directory to install application into. [default: 18:19:10 INFO - "/builds/slave/test-pgo"] 18:19:10 INFO - --app=APP Application being installed. [default: firefox] 18:19:10 INFO - mkdir: /builds/slave/test-pgo/build/application 18:19:10 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'] 18:19:10 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 18:19:25 INFO - Reading from file tmpfile_stdout 18:19:25 INFO - Output received: 18:19:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:19:25 INFO - Running post-action listener: _resource_record_post_action 18:19:25 INFO - ##### 18:19:25 INFO - ##### Running run-tests step. 18:19:25 INFO - ##### 18:19:25 INFO - Running pre-action listener: _resource_record_pre_action 18:19:25 INFO - Running main action method: run_tests 18:19:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:19:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:19:25 INFO - Python 2.7.3 18:19:25 INFO - Return code: 0 18:19:25 INFO - grabbing minidump binary from tooltool 18:19:25 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')]} 18:19:25 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 0x2ac6350>, '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 0x2ac7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:19:25 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 18:19:25 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 18:19:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:25 INFO - Return code: 0 18:19:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:19:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:19:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:19:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:19:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:19:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:19:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:19:26 INFO - Return code: 0 18:19:26 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/1455753505/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:19:26 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/1455753505/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 18:19:26 INFO - Using env: {'DISPLAY': ':0', 18:19:26 INFO - 'HOME': '/home/cltbld', 18:19:26 INFO - 'LANG': 'en_US.UTF-8', 18:19:26 INFO - 'LANGUAGE': 'en_US:en', 18:19:26 INFO - 'LOGNAME': 'cltbld', 18:19:26 INFO - 'MAIL': '/var/mail/cltbld', 18:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:26 INFO - 'MOZ_NO_REMOTE': '1', 18:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:26 INFO - 'NO_EM_RESTART': '1', 18:19:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:19:26 INFO - 'PWD': '/builds/slave/test-pgo', 18:19:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:19:26 INFO - 'SHELL': '/bin/bash', 18:19:26 INFO - 'SHLVL': '1', 18:19:26 INFO - 'TERM': 'linux', 18:19:26 INFO - 'TMOUT': '86400', 18:19:26 INFO - 'USER': 'cltbld', 18:19:26 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1455761914.640400-305560378', 18:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:26 INFO - '_': '/tools/buildbot/bin/python'} 18:19:26 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/1455753505/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 18:19:26 INFO - mozversion INFO | application_buildid: 20160217155825 18:19:26 INFO - mozversion INFO | application_changeset: 64374309d4902c99a14c2f56dda7805aacb9dbf4 18:19:26 INFO - mozversion INFO | application_display_name: Nightly 18:19:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:26 INFO - mozversion INFO | application_name: Firefox 18:19:26 INFO - mozversion INFO | application_remotingname: firefox 18:19:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:19:26 INFO - mozversion INFO | application_vendor: Mozilla 18:19:26 INFO - mozversion INFO | application_version: 45.0 18:19:26 INFO - mozversion INFO | platform_buildid: 20160217155825 18:19:26 INFO - mozversion INFO | platform_changeset: 64374309d4902c99a14c2f56dda7805aacb9dbf4 18:19:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:19:26 INFO - mozversion INFO | platform_version: 45.0 18:19:26 INFO - 2016-02-17 18:19:26,797 DEBUG : using testdate: 1455761966 18:19:26 INFO - 2016-02-17 18:19:26,797 DEBUG : actual date: 1455761966 18:19:26 INFO - 2016-02-17 18:19:26,806 INFO : starting webserver on 'localhost:60756' 18:19:26 INFO - 2016-02-17 18:19:26,807 INFO : Starting test suite talos-linux64-ix-056 18:19:26 INFO - 2016-02-17 18:19:26,807 INFO : Starting test dromaeo_css 18:19:26 INFO - 2016-02-17 18:19:26,807 DEBUG : operating with platform_type : linux_ 18:19:26 INFO - 2016-02-17 18:19:26,808 INFO : Initialising browser for dromaeo_css test... 18:19:26 INFO - 2016-02-17 18:19:26,824 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptlJ7ht/profile http://localhost:60756/getInfo.html 18:19:31 INFO - 2016-02-17 18:19:31,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:19:31 INFO - 2016-02-17 18:19:31,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:19:31 INFO - 2016-02-17 18:19:31,171 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:19:31 INFO - 2016-02-17 18:19:31,171 DEBUG : BROWSER_OUTPUT: __metrics 18:19:31 INFO - 2016-02-17 18:19:31,340 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] 18:19:32 INFO - 2016-02-17 18:19:32,144 INFO : Browser initialized. 18:19:32 INFO - 2016-02-17 18:19:32,145 INFO : Running cycle 1/1 for dromaeo_css test... 18:19:32 INFO - 2016-02-17 18:19:32,145 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptlJ7ht/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:19:43 INFO - 2016-02-17 18:19:43,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 133672960 18:19:43 INFO - 2016-02-17 18:19:43,833 DEBUG : BROWSER_OUTPUT: 18:20:34 INFO - 2016-02-17 18:20:34,596 DEBUG : BROWSER_OUTPUT: 1455762034593 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] 18:22:42 INFO - 2016-02-17 18:22:42,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60756/tests/dromaeo/cssquery-ext.html) 18:22:43 INFO - 2016-02-17 18:22:43,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 217501696 18:22:43 INFO - 2016-02-17 18:22:43,784 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2016-02-17 18:25:45,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-ext.html (next: http://localhost:60756/tests/dromaeo/cssquery-jquery.html) 18:25:46 INFO - 2016-02-17 18:25:46,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 217513984 18:25:46 INFO - 2016-02-17 18:25:46,482 DEBUG : BROWSER_OUTPUT: 18:28:48 INFO - 2016-02-17 18:28:48,266 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60756/tests/dromaeo/cssquery-mootools.html) 18:28:48 INFO - 2016-02-17 18:28:48,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 217710592 18:28:48 INFO - 2016-02-17 18:28:48,833 DEBUG : BROWSER_OUTPUT: 18:31:50 INFO - 2016-02-17 18:31:50,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60756/tests/dromaeo/cssquery-prototype.html) 18:31:51 INFO - 2016-02-17 18:31:51,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 199180288 18:31:51 INFO - 2016-02-17 18:31:51,068 DEBUG : BROWSER_OUTPUT: 18:34:53 INFO - 2016-02-17 18:34:53,400 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60756/tests/dromaeo/cssquery-yui.html) 18:34:53 INFO - 2016-02-17 18:34:53,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 203145216 18:34:53 INFO - 2016-02-17 18:34:53,962 DEBUG : BROWSER_OUTPUT: 18:37:55 INFO - 2016-02-17 18:37:55,964 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/dromaeo/cssquery-yui.html (next: http://localhost:60756/tests/dromaeo/cssquery-dojo.html) 18:37:56 INFO - 2016-02-17 18:37:56,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 235778048 18:37:56 INFO - 2016-02-17 18:37:56,214 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,215 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:37:56 INFO - 2016-02-17 18:37:56,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:37:56 INFO - 2016-02-17 18:37:56,216 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:37:56 INFO - 2016-02-17 18:37:56,216 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:37:56 INFO - 2016-02-17 18:37:56,219 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3273.345330933813;3342.314825460781;3375.054984604312;3382.2220889195482;3402.370561446133;5518.117101263799;5544.16837474379;5551.9722401388035;5576.498115169634;5579.302587176603;5547.44525547446;5585.05054140796;5588.580856435773;5589.8602534936645;5590.468905453975;4902.068606964665;5038.7984480620735;5053.519915608012;5098.847034588968;5170.870728231786;5083.898322033557;5090.821821236257;5126.769295381698;5157.123289040854;5161.045206636784;4904.313396124546;4959.330490383788;5024.4724303948105;5033.2450132480235;5042.773075211624;5086.97456512717;5109.795608175668;5113.718745468997;5114.872128196787;5133.409657889353;4824.179889418807;5041.571466425322;5045.949540504585;5093.847184584469;5114.360704911886;5263.921041184385;5298.867528311785;5314.681119132826;5331.573474122061;5342.011727830364;5991.820245392645;5997.1304160896425;6029;6032.185654936615;6040.939590604082;5786.68173250471;5814.447627475383;6048.516118710537;6052.878942421171;6065.575409721321;5478.616496845222;5537.280153580049;5543.833684989457;5550.195221692832;5575.972120139414;6040.395960403925;6049.213602231682;6054.091886217103;6055.697215139226;6055.909161362583;5663.178839068394;5720.771169153188;5770.16332631766;5897.705114744245;5904.439078287642;5921.73352199152;5928.940710592925;5932.614380065368;5933;6017.608855424383;5829;5871.794487192928;5873.794417195463;5875.089361149029;5883.264591926009;5723.59934804568;5836.299644042657;5891.587588868738;5931.347551769302;6059.48494377974;4558.361829343895;4562.406887104721;4564.064366804863;4566.452025756864;4586.128635559233;4080.1431699342875;4089.652379547772;4089.9182016359505;4094.733842300241;4111.835526578963;5390.703511306916;5470.972645136829;5530.198121272473;5564.304461942257;5581.246531718166;5977.342492325927;6115.785947491817;6130.754769809158;6131.386861313922;6135.509159267248;5693.9430605693415;5713.8285851424525;5726.656400615976;5727.026405511073;5729.656220626775;5056.089903817275;5134.512221338967;5145.3568303962;5277.868053298622;5280.867978300574;6162.352952939877;6165.414285642857;6169.2288463942;6171.290301615282;6175.3515880831865;6029.51763858899;6034.6982650867285;6037.735849056534;6042.879142417215;6070.908936366046;6057.363976782551;6069.0592958091565;6120.357362476876;6128.167033931239;6171.506279497719;5978.910316345171;5981.491573216325;6026.126211699367;6033.336333003454;6035;6087.269527656709;6088.756449741961;6095.420935011167;6098.390160983866;6098.969505152446;5536.972315138399;5711.600187986801;5778.537716982547;5886.852828679317;5917.408259174048;5846.444587764156;5846.532277417711;5854.736536855937;5856.824295271149;5902.793402230901;5502.80740174092;5765.91351129725;5766.365699773106;5766.884662306814;5770.221020162225;5786.652800831964;5795.855103622274;5818.883622327615;5862.530997520274;5898.292204935436;5670.631408958405;5811.418858114154;5836.795712150054;5841.532677385884;5844.47399734026 18:37:56 INFO - 2016-02-17 18:37:56,223 DEBUG : BROWSER_OUTPUT: |1;ext.html;582.522331688016;583.8423625621083;589.7110415896209;596.4423264247927;603.7796204385398;41496.17007659845;41878;41896;41952.58047419525;41956.37065444013;46909;47152.76423617886;47545.52454475454;47569.524304756946;47636.76181619087;8041.597920104001;8120.715774947878;9089.136532029446;9259.398139120969;10366.844497332546;10719.78560428791;10800.72998175044;10840.13278937683;10854.620088296911;10856.565737370496;10836.620718274862;10936.234463587552;10941.398223097727;10945;10953.17851161162;10786.514606842711;10878.891211087866;10887.237893347468;10890.183236257233;10895.891041089568;10542.420166890817;10690.78618427627;10697.572097116106;10699.83950240747;10701.304415212986;42451.36322955158;42772.57227427748;42853.57146428527;42890.142197156194;42969.140617187484;3526.3828829954655;3589.7128229741556;3631.400818864884;3688.6311368863167;3922.1371298314325;31059.534106988413;31194.532082018788;31305.37389252202;31591.684083159103;32111.83944080288;4057.9188416231805;4132.648724858391;4146.66826653867;4146.813393397304;4162.105147393295;282921;283373;283930;284932;371809.1409542962;49080.26379604309;74213.25786742063;75398;75424;75443.62278188574;67232.6638366805;67855;67871.66064169648;67893.66053169801;67896.62361817312;17092.91453542749;17100.315987360365;17195.484135475956;17243.137843108045;17260.482185534453;13000.284984325765;13160.60518184456;13168.275744833934;13168.473261069641;13191.802122968164;22278.331650050524;22385.77614223837;22388.104475820786;22448.438789030406;22452.438689032904;8378.916210837935;8556.101609331055;8556.40105192643;8730.65077396897;8732.126787321344;1034.6585626743308;1078.8597482327248;1079.1528650009705;1081.9945900270607;1124.9144575484697;30571.8471407646;30803.537946930814;31062.91279805196;31435.52846707301;31525.52711709326;1140.1164097824253;1164.1967042740482;1178.4284621958343;1182.0897908610323;1221.993890030562;14642.926785366219;15229.543113706606;15381.307841147176;15690.137042462775;16569.585760356087;427486;433479;433806;434215;434417;53860.46139538633;53967.73016134894;54290.728546357015;54294.72852635712;54321.45678543164;1383.9377228024764;1413.5543715016422;1458.1979911048882;1521.186165401527;1526.96182595436;29606.407871842013;30122.54816177715;33822;34619.13452163716;35024.29951401009;52961.735191323794;53445.7327713359;53630.195547067604;53649;53765.924681506935;308171;308596;309122;310916;311632;44559;44905.77547112243;45164.54835451603;45490;45612.77193614011;49688.75155624199;51504.22743658923;55309.1703624454;55589.44410556005;56481;38772.80613596914;39491;39706.80146599249;40227.1954560913;40316.59683403128;45373;45651;46007;46437.303440447744;47122;39659.270998414984;40521.79739101286;40546.59453405428;40552.797236013634;40810.59189408187;34710;35945.64054359423;35959.10102247465;36099.458508121876;36241.818790905876;26855.060072897355;27296.590551142144;27406.314842128308;27803.44393112086;27998 18:37:56 INFO - 2016-02-17 18:37:56,226 DEBUG : BROWSER_OUTPUT: |2;jquery.html;372.42274474564437;378.9526309211349;379.0485880440095;380.12950343712896;383.28708602000273;15408.075515469052;17279.52376433925;17678.292868285254;18669.253229870807;18675.252989880406;17732.82267177328;17982.280708771665;18404.907975460137;19216.135273912674;19229.42311730647;5561.249231353756;5700.401457846929;5717.828465146053;5725.055365864649;5728.77084916605;4259.5953384428585;4393.912121757563;5735.598508104435;6214.65819379934;6470.4823614110755;6270.561060725751;6340.8097757067135;6361.236651601815;6389.808305750812;6405.871882562346;6266;6279.403456671609;6296.559240853142;6299.68501574924;6324.114623952673;5416.864578385533;5574.47042530963;5586.692731899744;5613.4386561343945;5622.381538030813;22347.10611575535;22370.993305301137;23265.06939722409;23873.522529549486;23984.88007559951;2318.629019356895;2367.4199821043953;2396.928092157238;2432;2634.315078079694;13831.79252311216;14085.859141408557;14339.78490322646;14588.489402870848;14623.341949612293;2033.2901425296463;2120.522882351474;2137.316058861165;2207.1061220205843;2214.047959377467;73456.63271683607;74512.25487745108;77297.22702772956;77740.61129694372;78472;17094.230759615846;17103.657926841395;17114.229859656345;17126.314947402214;17230.224639891236;27049.729502704722;27133.592996105075;27459;27559.586606200923;27641.861790690917;9630.662926797668;9905.75235619101;9912.405255684682;9917.851232231522;9959.950200248952;8268.049174344907;8271.793205169799;8314.875276870851;8358.582070896431;8549.487030778173;7259.637018149071;8402.621882015324;8578.957105214435;8597.355198360023;8641.30869530436;2671.647082910973;2813.6563569084674;3118.5789918361183;3172.920676983094;3210.21349769308;936.442816524167;995.721198064543;1057.2757661002238;1086.6739978006567;1097.412884106999;15362;16903;17138.314467421413;17365.913170434065;18216.362427315245;945.7824700318965;983.3755565216139;983.9262055345878;1011.0748664971469;1030.948452577383;9464.053594640482;10093.343932644355;10104.191664666809;10144.898551014543;10174.4912754362;448167;451827;458371;463056;620634;83862.58068709617;88085.11914880769;88279.55860220658;89408.5529572348;91837;1188.518649946773;1194.199886076331;1220.6155061155707;1222.0590145587848;1226.4358395138336;15686.529404117895;16229.269682864064;16472.01167929928;16568.00591964486;16613.0862802547;34703.30593388169;35746.64253357433;36820.15899204976;36934.445983309735;37582.06044848901;46199;47331.763341183076;47621;49465.75267123641;50058.249126263865;9855.556499957662;10146.340487868265;10149.746256343651;10256.538455769658;10272.435016074187;14207.928960355131;14695.632609184855;15095.849041509884;15204.771928420862;17213.13934303305;14763.188024658746;15027.323770430137;15033.924830375778;15162.696746064796;15325;15553.611159721098;15732.370705171665;15953.840461595235;15969;16237.106959116889;15979.121148336953;16310.102944337701;16489.83510164883;16783;16806.495805125865;10282.228832837418;10421.06210441064;10423.68728938133;10689;10698;15357.155356455502;15624.609384765472;15644.843551564338;16133.64391614281;16365.509034728977 18:37:56 INFO - 2016-02-17 18:37:56,228 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1564.139723152266;1567.1537369820298;1752.9649407011852;1785.6250187460635;1825.9957023637;7281.089863767029;7506.361959233472;7513.023306970086;7517.097948246212;7526.698932042726;6845.828854278646;6962.965185174067;7449.590272535009;7653.15815260321;7923.801904952379;2215.501512159763;2223.8776867272295;2249.662550617404;2250.1224522436264;2251.4146321956246;2020.8585399022074;2266.4900397410534;2284.817214622826;2329.8369114162015;2330.1145564685394;1965.5282732144326;2191.068795761803;2236.4856083100817;2236.6085934961316;2238.46276893546;2184.235517568862;2201.680756290345;2211.380813372258;2239.596872562938;2240.1599400224914;2275.601769690314;2298.0348253733473;2313.664518644804;2321.2339927823778;2326.278853555403;7664;7669.233076692342;7705.499142555716;7728.845423091563;7739.883901741478;4649.837255696035;4749.4775574686755;4749.881252968669;4753;4757.5718185363485;2969.317057076863;2972.524396096614;2994.2215024093894;2995.925101872449;3068.340306834019;966.709987003896;978.0708327089294;1008.606643409071;1025.5795123999198;1052.3370276725614;10086.646967356108;10197.49012549377;10204.94897525515;10210.2852800304;10225.948870255676;3917.5103112110987;3928.1947200824334;3971.0270983609203;3984.6015398460504;3985;8880.333974951775;8907.064758200295;8908.376413651113;8909.509976951329;8915.55422228886;4469;4493.348464472699;4496.9325460118125;4501.909961800746;4503.482099558527;4064.2684316822665;4067.044244602516;4068.715189936676;4071.714979951375;4072.2873497137884;3552.2007548301426;3590.192206753512;3602.1354874829854;3602.225521512835;3613.8735144269826;1063.213800814639;1066.173715370594;1066.7439814444633;1090.0571006079683;1090.8527348807809;1178.66997240771;1179.8584169899666;1218.4760552962312;1423.5729281215595;1443.7040406716599;7335.083114610674;7382.298681625237;7432.962835185897;7437.51656142349;7445.85108297831;636.8917284061721;643.8905386084377;646.1890327638783;656.2748163279603;793.4168386236112;5788.218590490314;5840.795572154954;5841.853953651193;5851.063829787298;5857.179994800731;9079.909200907907;9155.084491550791;9296.628134874665;9352.345335826563;9453.101955314234;9306.488143152192;9313.580888860017;9326.673566425277;9330.30022748283;9337;7142.107236595426;7255.23819998903;7426.331630153312;7454.515456495419;7454.888176677354;7140.678669459783;7169.749058783126;7181.497295189287;7188.928110719035;7218.639068046472;8229.711960081368;8488;8495.277901378453;8503.362247831314;8505.659773609234;8458.830823383374;8462.238398544161;8625.309975201842;8640.13598640131;8648.1784230498;6904.240533541407;6971.128608923885;7002.474814389043;7011.6494175292055;7023.262557431601;7593.012908321883;7657.846843062996;7668.233176682287;7679.116901556393;7683.039620047494;5983.700814959322;7040.894386584103;7245.239249878898;7328.157261914948;7334.926650733638;6558.80323590293;6761.86476270462;6772.119624448987;6834;6842.897356539556;6834.589924604539;6839.076724642109;6946.479014073863;6952.687129079102;6961.512694111364;6361.936380636134;6364.649944252926;6401.839954001187;6409.4231519163495;6417.197850268716;6426.036094585663;6444.420002199825;6456.386643268882;6561.80314590563;6798.252192258748 18:37:56 INFO - 2016-02-17 18:37:56,229 DEBUG : BROWSER_OUTPUT: |4;prototype.html;345.51110179096577;351.1659807956105;357.98747043853473;358.6556905370844;363.8726445743988;6036.788712395067;6121.938780612192;6131.417515336041;6134.938650613498;6172.043333283348;5810.1865738796605;5851.678157701324;5946;6007.579469437142;6013.188219590354;4661.997670500841;4687.507811679776;4698;4705.600023997948;4720.315554244632;4672.532746725335;4701.694389864648;4703.412073490814;4711.340412342275;4715.41057367829;4422.601965823075;4481.619062379702;4543.4093567836135;4666.486686464486;4671.439427268732;4656.138614356321;4658.790354434059;4661.254199328125;4667.789949452283;4679.15775160471;4135.110951145488;4139.151473947833;4140.275451795954;4140.751554906716;4141.7100802943805;5729.169270455761;5736.7992120276;5737.885242295172;5741.483266505993;5743.4543718346695;5250.7112108834;5393.487618676219;5394.002109609734;5399.055165346049;5399.541039011689;6357.300696923335;6365.904511432333;6366.140571022946;6368.458681012119;6382.297947225801;4494.662900282459;4501.572350626685;4505.842295519641;4506.752128632957;4507.481639611421;6484.448821850101;6559.9672001640165;6628.138342015555;6631.171103612049;6632.900506492407;4620.8151673933335;4624.30635404692;4626.699264547861;4628.5371462853445;4635.212013957568;4666.113438446684;4672.906541869143;4678.789454474489;4680.976595117003;4687.5781179693995;5375.865603359869;5380.623356365095;5384.165454354581;5386.730663466811;5401.945980540223;6332.33510481402;6433.388828061326;6451.580652256496;6457.677116144174;6464.385883341075;1635.6646887388056;1649.6783127290303;1650.3563610192034;1650.867930565552;1652.4712092130644;1059.814532456817;1075.6127793994156;1097.0510508410327;1111.6164923101678;1142.2974870454611;6224.37756224383;6226.657533835682;6228.906566401508;6235.657038862906;6236.345183755731;6692.297308782605;6693.497987650849;6695.0626912231355;6696.732130714717;6697.162854643169;6048.304444988795;6116;6174.598651087665;6276.152719382916;6284.12022316876;3601.7478776485395;3611.4041183204477;3625.655562721537;3628.927421451609;3630.618785027587;6903.723851046002;6918.619475928872;6920.134983127109;6922.965385173042;6930.3762661360715;6704.430123439464;6889.586624802528;6891.27641597635;6891.862162756717;6901.068355772007;6907.930920690829;6909.930900690929;6913.446924246048;6915.792526224222;6916.308369163044;6617.690504795909;6716.764913228014;6720;6721.663916804043;6723.193216814014;6575.736970521126;6622.4702023838945;6627.768028119185;6633.502487313567;6636.83407914806;6894.000739785607;6900.551464154814;6905.309469053054;6906.516543841883;6907.998340240537;4620.907581848412;4621.075784842978;4622.306654001926;4622.653301002506;4626.282926146453;6618.238902526271;6709.899351509829;6736.797896063126;6747.628880411625;6755.662216889037;6548.83627909287;6552.508561857975;6557.836054098686;6558.376954189344;6564.901526477202;6552.1154644124335;6554.115194448688;6554.541182117206;6557.147570815954;6562.475001999733;6272.121902933502;6446.194225721785;6447.548671592944;6453.51598630114;6464.612123272619;6597.010448432773;6603.966980165068;6604.735810567716;6605.5376123670885;6606.240282367589;6253.8749225014335;6431.260405053479;6439.935600643934;6441.259255185713;6443.291237963914 18:37:56 INFO - 2016-02-17 18:37:56,230 DEBUG : BROWSER_OUTPUT: |5;yui.html;761.5735188294559;795.554489485888;874.4753148111134;876.123876123876;885.3404213860673;13555.118917270383;13649.181049137034;13739.862601373983;13744.381502832372;13885.028048036642;13871.16772993621;13880.722385552283;14083.366248518816;14703.779443308358;14724.779128313085;891.8974317953438;900.4867225681364;901.04489241404;901.1889299630319;901.5717534171282;894.995525022374;897.2507955856868;900.7838118851494;900.9819803603924;901.4771432569127;947.0955237747934;948.4025064209573;948.6205517792869;948.83869742144;953.3755390219418;939.567798812547;940.9858852117223;941.4727752458645;941.9340646154772;945.3618807305076;695.4332219241353;696.314130581377;697.0311267338403;697.0624510033996;698.4866123399297;13729;13838.93080534601;13928.58214253574;13944.16335019902;13987.160770353812;11453.59912403062;11744.177907546475;11840.171188016842;12147.878521214763;12316.322602256872;10505.947470262676;10652.573897044109;10657.200709946708;10673.199510036779;12140.696482587917;3786.678132358753;3787.8484860605545;3791.393377059685;3810;3898.629630185128;48888;49330;50232;53867.461325386634;55024.44975550233;10433.372465527045;10781.892181078245;10931;11045.613403530839;11152.275102118336;18771;18795.060246987596;18838;18842.81157188438;18861;7517.774466766005;7628.618569071524;7680.116786569616;7850.528968261922;7865.488743231672;4510.954890451119;4524.864254072383;4588;4602.953970460319;4607.907841843212;3214.3089235813945;3220.6940340667597;3256.6417694053634;3259.543663887058;3261.4944683574086;555.2920026965651;579.1139556478595;579.3858509979435;587.8912401205705;605.6214865708932;536.771320507142;547.805529037186;625.7027911741886;656;665.8692185007994;7905.920940790634;8398.538080405637;8507.234348908629;8614.569271536398;8907.643694252158;492.81927470940946;612.6171143035602;639.280809089774;640.1390130274773;649.447969226154;4013.4381186633896;4128.174365126986;4194.643455306272;4197.874063778091;4245.490541135022;57833.710831445576;58049;58168.709156453944;58572;58807;45919.77040114778;52494.73752631212;52521.73739131356;52889.206661900105;55101.72449137729;47140;47150;47777;47811.521884780705;48043.51956480391;8309;8624.223819856243;8691.130886911258;8767.693130740394;8876.556172191495;34968.475472867416;35075.649243507236;35568.28863422769;36945.81527092347;37665.4350184742;45955.54044459647;46452.07095858132;46806;46870;46918.53081469142;11155;11289.661310160709;11349.205555611028;11422.200445969034;11512.36681982499;11886.58396956137;12170.604467740586;12205.816912746139;12339.321337326173;12628.179168354027;11253.493592788507;11646.475908583965;11710.765784684088;11794.46924888365;11840.585579504675;10648.627298044532;10917.290376125526;11108.722281943015;11183.384913829817;11256.380899050304;11285.605003824827;11314.03830674402;11365.602203923154;11635.47640356203;11674.778298647614;9599.184069353903;9631;9657.22742180638;10053.19574434058;10723.571057157938;9719.951400242953;9972.700818975442;10092.89907100949;10168.745781355525;10215.080642742189 18:37:56 INFO - 2016-02-17 18:37:56,230 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:37:56 INFO - 2016-02-17 18:37:56,230 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,741 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: __startTimestamp1455763076215__endTimestamp 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,231 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5537.06 Median:5765.91 stddev:619.32 (10.7%) stddev-sans-first:595.22 18:37:56 INFO - 2016-02-17 18:37:56,232 DEBUG : BROWSER_OUTPUT: Values: 3273.3 3342.3 3375.1 3382.2 3402.4 5518.1 5544.2 5552.0 5576.5 5579.3 5547.4 5585.1 5588.6 5589.9 5590.5 4902.1 5038.8 5053.5 5098.8 5170.9 5083.9 5090.8 5126.8 5157.1 5161.0 4904.3 4959.3 5024.5 5033.2 5042.8 5087.0 5109.8 5113.7 5114.9 5133.4 4824.2 5041.6 5045.9 5093.8 5114.4 5263.9 5298.9 5314.7 5331.6 5342.0 5991.8 5997.1 6029.0 6032.2 6040.9 5786.7 5814.4 6048.5 6052.9 6065.6 5478.6 5537.3 5543.8 5550.2 5576.0 6040.4 6049.2 6054.1 6055.7 6055.9 5663.2 5720.8 5770.2 5897.7 5904.4 5921.7 5928.9 5932.6 5933.0 6017.6 5829.0 5871.8 5873.8 5875.1 5883.3 5723.6 5836.3 5891.6 5931.3 6059.5 4558.4 4562.4 4564.1 4566.5 4586.1 4080.1 4089.7 4089.9 4094.7 4111.8 5390.7 5471.0 5530.2 5564.3 5581.2 5977.3 6115.8 6130.8 6131.4 6135.5 5693.9 5713.8 5726.7 5727.0 5729.7 5056.1 5134.5 5145.4 5277.9 5280.9 6162.4 6165.4 6169.2 6171.3 6175.4 6029.5 6034.7 6037.7 6042.9 6070.9 6057.4 6069.1 6120.4 6128.2 6171.5 5978.9 5981.5 6026.1 6033.3 6035.0 6087.3 6088.8 6095.4 6098.4 6099.0 5537.0 5711.6 5778.5 5886.9 5917.4 5846.4 5846.5 5854.7 5856.8 5902.8 5502.8 5765.9 5766.4 5766.9 5770.2 5786.7 5795.9 5818.9 5862.5 5898.3 5670.6 5811.4 5836.8 5841.5 5844.5 18:37:56 INFO - 2016-02-17 18:37:56,232 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,232 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:54048.28 Median:36170.64 stddev:92821.20 (256.6%) stddev-sans-first:92994.78 18:37:56 INFO - 2016-02-17 18:37:56,233 DEBUG : BROWSER_OUTPUT: Values: 582.5 583.8 589.7 596.4 603.8 41496.2 41878.0 41896.0 41952.6 41956.4 46909.0 47152.8 47545.5 47569.5 47636.8 8041.6 8120.7 9089.1 9259.4 10366.8 10719.8 10800.7 10840.1 10854.6 10856.6 10836.6 10936.2 10941.4 10945.0 10953.2 10786.5 10878.9 10887.2 10890.2 10895.9 10542.4 10690.8 10697.6 10699.8 10701.3 42451.4 42772.6 42853.6 42890.1 42969.1 3526.4 3589.7 3631.4 3688.6 3922.1 31059.5 31194.5 31305.4 31591.7 32111.8 4057.9 4132.6 4146.7 4146.8 4162.1 282921.0 283373.0 283930.0 284932.0 371809.1 49080.3 74213.3 75398.0 75424.0 75443.6 67232.7 67855.0 67871.7 67893.7 67896.6 17092.9 17100.3 17195.5 17243.1 17260.5 13000.3 13160.6 13168.3 13168.5 13191.8 22278.3 22385.8 22388.1 22448.4 22452.4 8378.9 8556.1 8556.4 8730.7 8732.1 1034.7 1078.9 1079.2 1082.0 1124.9 30571.8 30803.5 31062.9 31435.5 31525.5 1140.1 1164.2 1178.4 1182.1 1222.0 14642.9 15229.5 15381.3 15690.1 16569.6 427486.0 433479.0 433806.0 434215.0 434417.0 53860.5 53967.7 54290.7 54294.7 54321.5 1383.9 1413.6 1458.2 1521.2 1527.0 29606.4 30122.5 33822.0 34619.1 35024.3 52961.7 53445.7 53630.2 53649.0 53765.9 308171.0 308596.0 309122.0 310916.0 311632.0 44559.0 44905.8 45164.5 45490.0 45612.8 49688.8 51504.2 55309.2 55589.4 56481.0 38772.8 39491.0 39706.8 40227.2 40316.6 45373.0 45651.0 46007.0 46437.3 47122.0 39659.3 40521.8 40546.6 40552.8 40810.6 34710.0 35945.6 35959.1 36099.5 36241.8 26855.1 27296.6 27406.3 27803.4 27998.0 18:37:56 INFO - 2016-02-17 18:37:56,233 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,233 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29583.42 Median:13208.44 stddev:80792.20 (611.7%) stddev-sans-first:80989.07 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: Values: 372.4 379.0 379.0 380.1 383.3 15408.1 17279.5 17678.3 18669.3 18675.3 17732.8 17982.3 18404.9 19216.1 19229.4 5561.2 5700.4 5717.8 5725.1 5728.8 4259.6 4393.9 5735.6 6214.7 6470.5 6270.6 6340.8 6361.2 6389.8 6405.9 6266.0 6279.4 6296.6 6299.7 6324.1 5416.9 5574.5 5586.7 5613.4 5622.4 22347.1 22371.0 23265.1 23873.5 23984.9 2318.6 2367.4 2396.9 2432.0 2634.3 13831.8 14085.9 14339.8 14588.5 14623.3 2033.3 2120.5 2137.3 2207.1 2214.0 73456.6 74512.3 77297.2 77740.6 78472.0 17094.2 17103.7 17114.2 17126.3 17230.2 27049.7 27133.6 27459.0 27559.6 27641.9 9630.7 9905.8 9912.4 9917.9 9960.0 8268.0 8271.8 8314.9 8358.6 8549.5 7259.6 8402.6 8579.0 8597.4 8641.3 2671.6 2813.7 3118.6 3172.9 3210.2 936.4 995.7 1057.3 1086.7 1097.4 15362.0 16903.0 17138.3 17365.9 18216.4 945.8 983.4 983.9 1011.1 1030.9 9464.1 10093.3 10104.2 10144.9 10174.5 448167.0 451827.0 458371.0 463056.0 620634.0 83862.6 88085.1 88279.6 89408.6 91837.0 1188.5 1194.2 1220.6 1222.1 1226.4 15686.5 16229.3 16472.0 16568.0 16613.1 34703.3 35746.6 36820.2 36934.4 37582.1 46199.0 47331.8 47621.0 49465.8 50058.2 9855.6 10146.3 10149.7 10256.5 10272.4 14207.9 14695.6 15095.8 15204.8 17213.1 14763.2 15027.3 15033.9 15162.7 15325.0 15553.6 15732.4 15953.8 15969.0 16237.1 15979.1 16310.1 16489.8 16783.0 16806.5 10282.2 10421.1 10423.7 10689.0 10698.0 15357.2 15624.6 15644.8 16133.6 16365.5 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5388.35 Median:3534.96 stddev:2804.93 (79.3%) stddev-sans-first:2798.07 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: Values: 1564.1 1567.2 1753.0 1785.6 1826.0 7281.1 7506.4 7513.0 7517.1 7526.7 6845.8 6963.0 7449.6 7653.2 7923.8 2215.5 2223.9 2249.7 2250.1 2251.4 2020.9 2266.5 2284.8 2329.8 2330.1 1965.5 2191.1 2236.5 2236.6 2238.5 2184.2 2201.7 2211.4 2239.6 2240.2 2275.6 2298.0 2313.7 2321.2 2326.3 7664.0 7669.2 7705.5 7728.8 7739.9 4649.8 4749.5 4749.9 4753.0 4757.6 2969.3 2972.5 2994.2 2995.9 3068.3 966.7 978.1 1008.6 1025.6 1052.3 10086.6 10197.5 10204.9 10210.3 10225.9 3917.5 3928.2 3971.0 3984.6 3985.0 8880.3 8907.1 8908.4 8909.5 8915.6 4469.0 4493.3 4496.9 4501.9 4503.5 4064.3 4067.0 4068.7 4071.7 4072.3 3552.2 3590.2 3602.1 3602.2 3613.9 1063.2 1066.2 1066.7 1090.1 1090.9 1178.7 1179.9 1218.5 1423.6 1443.7 7335.1 7382.3 7433.0 7437.5 7445.9 636.9 643.9 646.2 656.3 793.4 5788.2 5840.8 5841.9 5851.1 5857.2 9079.9 9155.1 9296.6 9352.3 9453.1 9306.5 9313.6 9326.7 9330.3 9337.0 7142.1 7255.2 7426.3 7454.5 7454.9 7140.7 7169.7 7181.5 7188.9 7218.6 8229.7 8488.0 8495.3 8503.4 8505.7 8458.8 8462.2 8625.3 8640.1 8648.2 6904.2 6971.1 7002.5 7011.6 7023.3 7593.0 7657.8 7668.2 7679.1 7683.0 5983.7 7040.9 7245.2 7328.2 7334.9 6558.8 6761.9 6772.1 6834.0 6842.9 6834.6 6839.1 6946.5 6952.7 6961.5 6361.9 6364.6 6401.8 6409.4 6417.2 6426.0 6444.4 6456.4 6561.8 6798.3 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,234 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5419.16 Median:6153.49 stddev:1628.42 (26.5%) stddev-sans-first:1587.84 18:37:56 INFO - 2016-02-17 18:37:56,235 DEBUG : BROWSER_OUTPUT: Values: 345.5 351.2 358.0 358.7 363.9 6036.8 6121.9 6131.4 6134.9 6172.0 5810.2 5851.7 5946.0 6007.6 6013.2 4662.0 4687.5 4698.0 4705.6 4720.3 4672.5 4701.7 4703.4 4711.3 4715.4 4422.6 4481.6 4543.4 4666.5 4671.4 4656.1 4658.8 4661.3 4667.8 4679.2 4135.1 4139.2 4140.3 4140.8 4141.7 5729.2 5736.8 5737.9 5741.5 5743.5 5250.7 5393.5 5394.0 5399.1 5399.5 6357.3 6365.9 6366.1 6368.5 6382.3 4494.7 4501.6 4505.8 4506.8 4507.5 6484.4 6560.0 6628.1 6631.2 6632.9 4620.8 4624.3 4626.7 4628.5 4635.2 4666.1 4672.9 4678.8 4681.0 4687.6 5375.9 5380.6 5384.2 5386.7 5401.9 6332.3 6433.4 6451.6 6457.7 6464.4 1635.7 1649.7 1650.4 1650.9 1652.5 1059.8 1075.6 1097.1 1111.6 1142.3 6224.4 6226.7 6228.9 6235.7 6236.3 6692.3 6693.5 6695.1 6696.7 6697.2 6048.3 6116.0 6174.6 6276.2 6284.1 3601.7 3611.4 3625.7 3628.9 3630.6 6903.7 6918.6 6920.1 6923.0 6930.4 6704.4 6889.6 6891.3 6891.9 6901.1 6907.9 6909.9 6913.4 6915.8 6916.3 6617.7 6716.8 6720.0 6721.7 6723.2 6575.7 6622.5 6627.8 6633.5 6636.8 6894.0 6900.6 6905.3 6906.5 6908.0 4620.9 4621.1 4622.3 4622.7 4626.3 6618.2 6709.9 6736.8 6747.6 6755.7 6548.8 6552.5 6557.8 6558.4 6564.9 6552.1 6554.1 6554.5 6557.1 6562.5 6272.1 6446.2 6447.5 6453.5 6464.6 6597.0 6604.0 6604.7 6605.5 6606.2 6253.9 6431.3 6439.9 6441.3 6443.3 18:37:56 INFO - 2016-02-17 18:37:56,236 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,236 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14207.05 Median:4605.43 stddev:16438.62 (356.9%) stddev-sans-first:16453.73 18:37:56 INFO - 2016-02-17 18:37:56,236 DEBUG : BROWSER_OUTPUT: Values: 761.6 795.6 874.5 876.1 885.3 13555.1 13649.2 13739.9 13744.4 13885.0 13871.2 13880.7 14083.4 14703.8 14724.8 891.9 900.5 901.0 901.2 901.6 895.0 897.3 900.8 901.0 901.5 947.1 948.4 948.6 948.8 953.4 939.6 941.0 941.5 941.9 945.4 695.4 696.3 697.0 697.1 698.5 13729.0 13838.9 13928.6 13944.2 13987.2 11453.6 11744.2 11840.2 12147.9 12316.3 10505.9 10652.6 10657.2 10673.2 12140.7 3786.7 3787.8 3791.4 3810.0 3898.6 48888.0 49330.0 50232.0 53867.5 55024.4 10433.4 10781.9 10931.0 11045.6 11152.3 18771.0 18795.1 18838.0 18842.8 18861.0 7517.8 7628.6 7680.1 7850.5 7865.5 4511.0 4524.9 4588.0 4603.0 4607.9 3214.3 3220.7 3256.6 3259.5 3261.5 555.3 579.1 579.4 587.9 605.6 536.8 547.8 625.7 656.0 665.9 7905.9 8398.5 8507.2 8614.6 8907.6 492.8 612.6 639.3 640.1 649.4 4013.4 4128.2 4194.6 4197.9 4245.5 57833.7 58049.0 58168.7 58572.0 58807.0 45919.8 52494.7 52521.7 52889.2 55101.7 47140.0 47150.0 47777.0 47811.5 48043.5 8309.0 8624.2 8691.1 8767.7 8876.6 34968.5 35075.6 35568.3 36945.8 37665.4 45955.5 46452.1 46806.0 46870.0 46918.5 11155.0 11289.7 11349.2 11422.2 11512.4 11886.6 12170.6 12205.8 12339.3 12628.2 11253.5 11646.5 11710.8 11794.5 11840.6 10648.6 10917.3 11108.7 11183.4 11256.4 11285.6 11314.0 11365.6 11635.5 11674.8 9599.2 9631.0 9657.2 10053.2 10723.6 9720.0 9972.7 10092.9 10168.7 10215.1 18:37:56 INFO - 2016-02-17 18:37:56,236 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:37:56 INFO - 2016-02-17 18:37:56,236 DEBUG : BROWSER_OUTPUT: 18:37:56 INFO - 2016-02-17 18:37:56,788 INFO : Browser exited with error code: 0 18:37:56 INFO - 2016-02-17 18:37:56,809 INFO : Completed test dromaeo_css (00:18:30) 18:37:56 INFO - 2016-02-17 18:37:56,810 INFO : Starting test kraken 18:37:56 INFO - 2016-02-17 18:37:56,810 DEBUG : operating with platform_type : linux_ 18:37:56 INFO - 2016-02-17 18:37:56,810 INFO : Initialising browser for kraken test... 18:37:56 INFO - 2016-02-17 18:37:56,816 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprzfdgc/profile http://localhost:60756/getInfo.html 18:38:00 INFO - 2016-02-17 18:38:00,754 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:38:00 INFO - 2016-02-17 18:38:00,754 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:38:00 INFO - 2016-02-17 18:38:00,754 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:38:00 INFO - 2016-02-17 18:38:00,754 DEBUG : BROWSER_OUTPUT: __metrics 18:38:00 INFO - 2016-02-17 18:38:00,911 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] 18:38:01 INFO - 2016-02-17 18:38:01,724 INFO : Browser initialized. 18:38:01 INFO - 2016-02-17 18:38:01,725 INFO : Running cycle 1/1 for kraken test... 18:38:01 INFO - 2016-02-17 18:38:01,725 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprzfdgc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:38:13 INFO - 2016-02-17 18:38:13,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 132599808 18:38:13 INFO - 2016-02-17 18:38:13,497 DEBUG : BROWSER_OUTPUT: 18:38:15 INFO - 2016-02-17 18:38:15,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60756/tests/kraken/driver.html?testName=audio-beat-detection) 18:38:16 INFO - 2016-02-17 18:38:16,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 164749312 18:38:16 INFO - 2016-02-17 18:38:16,520 DEBUG : BROWSER_OUTPUT: 18:38:19 INFO - 2016-02-17 18:38:19,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60756/tests/kraken/driver.html?testName=audio-dft) 18:38:19 INFO - 2016-02-17 18:38:19,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 165134336 18:38:19 INFO - 2016-02-17 18:38:19,672 DEBUG : BROWSER_OUTPUT: 18:38:22 INFO - 2016-02-17 18:38:22,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60756/tests/kraken/driver.html?testName=audio-fft) 18:38:23 INFO - 2016-02-17 18:38:23,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 161517568 18:38:23 INFO - 2016-02-17 18:38:23,019 DEBUG : BROWSER_OUTPUT: 18:38:24 INFO - 2016-02-17 18:38:24,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60756/tests/kraken/driver.html?testName=audio-oscillator) 18:38:25 INFO - 2016-02-17 18:38:25,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 159653888 18:38:25 INFO - 2016-02-17 18:38:25,564 DEBUG : BROWSER_OUTPUT: 18:38:27 INFO - 2016-02-17 18:38:27,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:28 INFO - 2016-02-17 18:38:28,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 158777344 18:38:28 INFO - 2016-02-17 18:38:28,305 DEBUG : BROWSER_OUTPUT: 18:38:31 INFO - 2016-02-17 18:38:31,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60756/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:31 INFO - 2016-02-17 18:38:31,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 159035392 18:38:31 INFO - 2016-02-17 18:38:31,734 DEBUG : BROWSER_OUTPUT: 18:38:35 INFO - 2016-02-17 18:38:35,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60756/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:36 INFO - 2016-02-17 18:38:36,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 154025984 18:38:36 INFO - 2016-02-17 18:38:36,208 DEBUG : BROWSER_OUTPUT: 18:38:38 INFO - 2016-02-17 18:38:38,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60756/tests/kraken/driver.html?testName=json-parse-financial) 18:38:39 INFO - 2016-02-17 18:38:39,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 151842816 18:38:39 INFO - 2016-02-17 18:38:39,495 DEBUG : BROWSER_OUTPUT: 18:38:41 INFO - 2016-02-17 18:38:41,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:41 INFO - 2016-02-17 18:38:41,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 166379520 18:38:41 INFO - 2016-02-17 18:38:41,625 DEBUG : BROWSER_OUTPUT: 18:38:43 INFO - 2016-02-17 18:38:43,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:44 INFO - 2016-02-17 18:38:44,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 164474880 18:38:44 INFO - 2016-02-17 18:38:44,010 DEBUG : BROWSER_OUTPUT: 18:38:46 INFO - 2016-02-17 18:38:46,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:46 INFO - 2016-02-17 18:38:46,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 169148416 18:38:46 INFO - 2016-02-17 18:38:46,589 DEBUG : BROWSER_OUTPUT: 18:38:48 INFO - 2016-02-17 18:38:48,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:49 INFO - 2016-02-17 18:38:49,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 176922624 18:38:49 INFO - 2016-02-17 18:38:49,550 DEBUG : BROWSER_OUTPUT: 18:38:52 INFO - 2016-02-17 18:38:52,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:52 INFO - 2016-02-17 18:38:52,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 174170112 18:38:52 INFO - 2016-02-17 18:38:52,638 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60756/tests/kraken/driver.html?testName=ai-astar) 18:38:54 INFO - 2016-02-17 18:38:54,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 232792064 18:38:54 INFO - 2016-02-17 18:38:54,552 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,552 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;109;111;112;113;101;113;111;111 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;122;148;159;130;155;150;125;159;122 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;161;162;163;161;162;160;161 18:38:54 INFO - 2016-02-17 18:38:54,553 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;72;145;72;71;72;72;160;71 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;134;94;94;94;137;92;94;137 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;108;109;109;109 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;191;199;205;199;198;199;200;197;198;198 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;94;95;95;95 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;57;59;58;57;58;58;55;57 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;66;66;65;66;64;65;66;75 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;78;77;78;79;79;78;79;78;83 18:38:54 INFO - 2016-02-17 18:38:54,554 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;113;112;112;119;132;114;128;117;116 18:38:54 INFO - 2016-02-17 18:38:54,555 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;137;152;147;145;135;147;152;142;142 18:38:54 INFO - 2016-02-17 18:38:54,555 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;65;68;64;64;67;66;69;65 18:38:54 INFO - 2016-02-17 18:38:54,555 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:38:54 INFO - 2016-02-17 18:38:54,555 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:38:54 INFO - 2016-02-17 18:38:54,555 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,866 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: __startTimestamp1455763134547__endTimestamp 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:38:54 INFO - 2016-02-17 18:38:54,556 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,557 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.47 (3.1%) stddev-sans-first:3.67 18:38:54 INFO - 2016-02-17 18:38:54,557 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 109.0 111.0 112.0 113.0 101.0 113.0 111.0 111.0 18:38:54 INFO - 2016-02-17 18:38:54,557 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,558 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:151.50 stddev:15.64 (10.3%) stddev-sans-first:16.10 18:38:54 INFO - 2016-02-17 18:38:54,558 DEBUG : BROWSER_OUTPUT: Values: 153.0 122.0 148.0 159.0 130.0 155.0 150.0 125.0 159.0 122.0 18:38:54 INFO - 2016-02-17 18:38:54,558 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,559 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 18:38:54 INFO - 2016-02-17 18:38:54,559 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 161.0 162.0 163.0 161.0 162.0 160.0 161.0 18:38:54 INFO - 2016-02-17 18:38:54,559 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,559 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.80 Median:72.00 stddev:34.29 (47.6%) stddev-sans-first:35.82 18:38:54 INFO - 2016-02-17 18:38:54,559 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 145.0 72.0 71.0 72.0 72.0 160.0 71.0 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:94.00 stddev:20.39 (21.7%) stddev-sans-first:21.12 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 134.0 94.0 94.0 94.0 137.0 92.0 94.0 137.0 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:38:54 INFO - 2016-02-17 18:38:54,560 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:198.40 Median:199.00 stddev:3.41 (1.7%) stddev-sans-first:2.33 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: Values: 191.0 199.0 205.0 199.0 198.0 199.0 200.0 197.0 198.0 198.0 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 57.0 59.0 58.0 57.0 58.0 58.0 55.0 57.0 18:38:54 INFO - 2016-02-17 18:38:54,561 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:3.19 (4.8%) stddev-sans-first:3.28 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 66.0 66.0 65.0 66.0 64.0 65.0 66.0 75.0 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.66 (2.1%) stddev-sans-first:1.72 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: Values: 80.0 78.0 77.0 78.0 79.0 79.0 78.0 79.0 78.0 83.0 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:118.00 stddev:7.35 (6.2%) stddev-sans-first:7.20 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: Values: 127.0 113.0 112.0 112.0 119.0 132.0 114.0 128.0 117.0 116.0 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:146.00 stddev:6.20 (4.2%) stddev-sans-first:5.96 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: Values: 136.0 137.0 152.0 147.0 145.0 135.0 147.0 152.0 142.0 142.0 18:38:54 INFO - 2016-02-17 18:38:54,562 DEBUG : BROWSER_OUTPUT: 18:38:54 INFO - 2016-02-17 18:38:54,564 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 18:38:54 INFO - 2016-02-17 18:38:54,564 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 68.0 64.0 64.0 67.0 66.0 69.0 65.0 18:38:54 INFO - 2016-02-17 18:38:54,564 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:38:54 INFO - 2016-02-17 18:38:54,564 DEBUG : BROWSER_OUTPUT: 18:38:55 INFO - 2016-02-17 18:38:55,252 INFO : Browser exited with error code: 0 18:38:55 INFO - 2016-02-17 18:38:55,309 INFO : Completed test kraken (00:00:58) 18:38:55 INFO - 2016-02-17 18:38:55,309 INFO : Starting test v8_7 18:38:55 INFO - 2016-02-17 18:38:55,309 DEBUG : operating with platform_type : linux_ 18:38:55 INFO - 2016-02-17 18:38:55,309 INFO : Initialising browser for v8_7 test... 18:38:55 INFO - 2016-02-17 18:38:55,315 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO_aUKE/profile http://localhost:60756/getInfo.html 18:38:58 INFO - 2016-02-17 18:38:58,933 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:38:58 INFO - 2016-02-17 18:38:58,933 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:38:58 INFO - 2016-02-17 18:38:58,933 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:38:58 INFO - 2016-02-17 18:38:58,934 DEBUG : BROWSER_OUTPUT: __metrics 18:38:59 INFO - 2016-02-17 18:38:59,098 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] 18:39:00 INFO - 2016-02-17 18:39:00,236 INFO : Browser initialized. 18:39:00 INFO - 2016-02-17 18:39:00,237 INFO : Running cycle 1/1 for v8_7 test... 18:39:00 INFO - 2016-02-17 18:39:00,237 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpO_aUKE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:11 INFO - 2016-02-17 18:39:11,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 132952064 18:39:11 INFO - 2016-02-17 18:39:11,930 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60756/tests/v8_7/run.html (next: http://localhost:60756/tests/v8_7/run.html) 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 428613632 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |0;Richards;167.8697330871244 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.2800267648043 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |4;RayTrace;965.2509652509652 18:39:33 INFO - 2016-02-17 18:39:33,573 DEBUG : BROWSER_OUTPUT: |5;Earley;541.1255411255411 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: |6;Boyer;10562.5 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: |7;RegExp;24853.658536585364 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: |8;Splay;504.2821158690176 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: __startTimestamp1455763173565__endTimestamp 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.87 Median:167.87 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: Values: 167.9 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: Values: 167.3 18:39:33 INFO - 2016-02-17 18:39:33,574 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: Values: 278.3 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: Values: 5159.8 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:965.25 Median:965.25 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: Values: 965.3 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:541.13 Median:541.13 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: Values: 541.1 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10562.50 Median:10562.50 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: Values: 10562.5 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,575 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24853.66 Median:24853.66 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: Values: 24853.7 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:504.28 Median:504.28 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: Values: 504.3 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: Values: 4826.9 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:39:33 INFO - 2016-02-17 18:39:33,576 DEBUG : BROWSER_OUTPUT: 18:39:34 INFO - 2016-02-17 18:39:34,248 INFO : Browser exited with error code: 0 18:39:34 INFO - 2016-02-17 18:39:34,260 INFO : Completed test v8_7 (00:00:38) 18:39:34 INFO - 2016-02-17 18:39:34,558 INFO : Completed test suite (00:20:07) 18:39:34 INFO - 2016-02-17 18:39:34,558 DEBUG : Working with test: dromaeo_css 18:39:34 INFO - 2016-02-17 18:39:34,558 DEBUG : Generating results file: dromaeo_css 18:39:34 INFO - 2016-02-17 18:39:34,560 DEBUG : Working with test: kraken 18:39:34 INFO - 2016-02-17 18:39:34,560 DEBUG : Generating results file: kraken 18:39:34 INFO - 2016-02-17 18:39:34,560 INFO : javascript benchmark 18:39:34 INFO - 2016-02-17 18:39:34,560 DEBUG : Working with test: v8_7 18:39:34 INFO - 2016-02-17 18:39:34,560 DEBUG : Generating results file: v8_7 18:39:34 INFO - 2016-02-17 18:39:34,561 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:34 INFO - 2016-02-17 18:39:34,620 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 18:39:34 INFO - 2016-02-17 18:39:34,621 DEBUG : process_Request line: dromaeo_css 7415.49 graph.html#tests=[[72,53,35]] 18:39:34 INFO - 2016-02-17 18:39:34,621 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:34 INFO - 2016-02-17 18:39:34,656 DEBUG : process_Request line: kraken 1541.30 graph.html#tests=[[232,53,35]] 18:39:34 INFO - 2016-02-17 18:39:34,656 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:39:34 INFO - 2016-02-17 18:39:34,698 DEBUG : process_Request line: v8_7 23254.74 graph.html#tests=[[230,53,35]] 18:39:34 INFO - 2016-02-17 18:39:34,700 INFO : javascript benchmark 18:39:34 INFO - 2016-02-17 18:39:34,703 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3273.345330933813, 3342.314825460781, 3375.054984604312, 3382.2220889195482, 3402.370561446133, 5518.117101263799, 5544.16837474379, 5551.9722401388035, 5576.498115169634, 5579.302587176603, 5547.44525547446, 5585.05054140796, 5588.580856435773, 5589.8602534936645, 5590.468905453975, 4902.068606964665, 5038.7984480620735, 5053.519915608012, 5098.847034588968, 5170.870728231786, 5083.898322033557, 5090.821821236257, 5126.769295381698, 5157.123289040854, 5161.045206636784, 4904.313396124546, 4959.330490383788, 5024.4724303948105, 5033.2450132480235, 5042.773075211624, 5086.97456512717, 5109.795608175668, 5113.718745468997, 5114.872128196787, 5133.409657889353, 4824.179889418807, 5041.571466425322, 5045.949540504585, 5093.847184584469, 5114.360704911886, 5263.921041184385, 5298.867528311785, 5314.681119132826, 5331.573474122061, 5342.011727830364, 5991.820245392645, 5997.1304160896425, 6029.0, 6032.185654936615, 6040.939590604082, 5786.68173250471, 5814.447627475383, 6048.516118710537, 6052.878942421171, 6065.575409721321, 5478.616496845222, 5537.280153580049, 5543.833684989457, 5550.195221692832, 5575.972120139414, 6040.395960403925, 6049.213602231682, 6054.091886217103, 6055.697215139226, 6055.909161362583, 5663.178839068394, 5720.771169153188, 5770.16332631766, 5897.705114744245, 5904.439078287642, 5921.73352199152, 5928.940710592925, 5932.614380065368, 5933.0, 6017.608855424383, 5829.0, 5871.794487192928, 5873.794417195463, 5875.089361149029, 5883.264591926009, 5723.59934804568, 5836.299644042657, 5891.587588868738, 5931.347551769302, 6059.48494377974, 4558.361829343895, 4562.406887104721, 4564.064366804863, 4566.452025756864, 4586.128635559233, 4080.1431699342875, 4089.652379547772, 4089.9182016359505, 4094.733842300241, 4111.835526578963, 5390.703511306916, 5470.972645136829, 5530.198121272473, 5564.304461942257, 5581.246531718166, 5977.342492325927, 6115.785947491817, 6130.754769809158, 6131.386861313922, 6135.509159267248, 5693.9430605693415, 5713.8285851424525, 5726.656400615976, 5727.026405511073, 5729.656220626775, 5056.089903817275, 5134.512221338967, 5145.3568303962, 5277.868053298622, 5280.867978300574, 6162.352952939877, 6165.414285642857, 6169.2288463942, 6171.290301615282, 6175.3515880831865, 6029.51763858899, 6034.6982650867285, 6037.735849056534, 6042.879142417215, 6070.908936366046, 6057.363976782551, 6069.0592958091565, 6120.357362476876, 6128.167033931239, 6171.506279497719, 5978.910316345171, 5981.491573216325, 6026.126211699367, 6033.336333003454, 6035.0, 6087.269527656709, 6088.756449741961, 6095.420935011167, 6098.390160983866, 6098.969505152446, 5536.972315138399, 5711.600187986801, 5778.537716982547, 5886.852828679317, 5917.408259174048, 5846.444587764156, 5846.532277417711, 5854.736536855937, 5856.824295271149, 5902.793402230901, 5502.80740174092, 5765.91351129725, 5766.365699773106, 5766.884662306814, 5770.221020162225, 5786.652800831964, 5795.855103622274, 5818.883622327615, 5862.530997520274, 5898.292204935436, 5670.631408958405, 5811.418858114154, 5836.795712150054, 5841.532677385884, 5844.47399734026], "unit": "ms", "name": "dojo.html", "value": 5496.910643993843}, {"lowerIsBetter": false, "replicates": [582.522331688016, 583.8423625621083, 589.7110415896209, 596.4423264247927, 603.7796204385398, 41496.17007659845, 41878.0, 41896.0, 41952.58047419525, 41956.37065444013, 46909.0, 47152.76423617886, 47545.52454475454, 47569.524304756946, 47636.76181619087, 8041.597920104001, 8120.715774947878, 9089.136532029446, 9259.398139120969, 10366.844497332546, 10719.78560428791, 10800.72998175044, 10840.13278937683, 10854.620088296911, 10856.565737370496, 10836.620718274862, 10936.234463587552, 10941.398223097727, 10945.0, 10953.17851161162, 10786.514606842711, 10878.891211087866, 10887.237893347468, 10890.183236257233, 10895.891041089568, 10542.420166890817, 10690.78618427627, 10697.572097116106, 10699.83950240747, 10701.304415212986, 42451.36322955158, 42772.57227427748, 42853.57146428527, 42890.142197156194, 42969.140617187484, 3526.3828829954655, 3589.7128229741556, 3631.400818864884, 3688.6311368863167, 3922.1371298314325, 31059.534106988413, 31194.532082018788, 31305.37389252202, 31591.684083159103, 32111.83944080288, 4057.9188416231805, 4132.648724858391, 4146.66826653867, 4146.813393397304, 4162.105147393295, 282921.0, 283373.0, 283930.0, 284932.0, 371809.1409542962, 49080.26379604309, 74213.25786742063, 75398.0, 75424.0, 75443.62278188574, 67232.6638366805, 67855.0, 67871.66064169648, 67893.66053169801, 67896.62361817312, 17092.91453542749, 17100.315987360365, 17195.484135475956, 17243.137843108045, 17260.482185534453, 13000.284984325765, 13160.60518184456, 13168.275744833934, 13168.473261069641, 13191.802122968164, 22278.331650050524, 22385.77614223837, 22388.104475820786, 22448.438789030406, 22452.438689032904, 8378.916210837935, 8556.101609331055, 8556.40105192643, 8730.65077396897, 8732.126787321344, 1034.6585626743308, 1078.8597482327248, 1079.1528650009705, 1081.9945900270607, 1124.9144575484697, 30571.8471407646, 30803.537946930814, 31062.91279805196, 31435.52846707301, 31525.52711709326, 1140.1164097824253, 1164.1967042740482, 1178.4284621958343, 1182.0897908610323, 1221.993890030562, 14642.926785366219, 15229.543113706606, 15381.307841147176, 15690.137042462775, 16569.585760356087, 427486.0, 433479.0, 433806.0, 434215.0, 434417.0, 53860.46139538633, 53967.73016134894, 54290.728546357015, 54294.72852635712, 54321.45678543164, 1383.9377228024764, 1413.5543715016422, 1458.1979911048882, 1521.186165401527, 1526.96182595436, 29606.407871842013, 30122.54816177715, 33822.0, 34619.13452163716, 35024.29951401009, 52961.735191323794, 53445.7327713359, 53630.195547067604, 53649.0, 53765.924681506935, 308171.0, 308596.0, 309122.0, 310916.0, 311632.0, 44559.0, 44905.77547112243, 45164.54835451603, 45490.0, 45612.77193614011, 49688.75155624199, 51504.22743658923, 55309.1703624454, 55589.44410556005, 56481.0, 38772.80613596914, 39491.0, 39706.80146599249, 40227.1954560913, 40316.59683403128, 45373.0, 45651.0, 46007.0, 46437.303440447744, 47122.0, 39659.270998414984, 40521.79739101286, 40546.59453405428, 40552.797236013634, 40810.59189408187, 34710.0, 35945.64054359423, 35959.10102247465, 36099.458508121876, 36241.818790905876, 26855.060072897355, 27296.590551142144, 27406.314842128308, 27803.44393112086, 27998.0], "unit": "ms", "name": "ext.html", "value": 20950.67731279021}, {"lowerIsBetter": false, "replicates": [372.42274474564437, 378.9526309211349, 379.0485880440095, 380.12950343712896, 383.28708602000273, 15408.075515469052, 17279.52376433925, 17678.292868285254, 18669.253229870807, 18675.252989880406, 17732.82267177328, 17982.280708771665, 18404.907975460137, 19216.135273912674, 19229.42311730647, 5561.249231353756, 5700.401457846929, 5717.828465146053, 5725.055365864649, 5728.77084916605, 4259.5953384428585, 4393.912121757563, 5735.598508104435, 6214.65819379934, 6470.4823614110755, 6270.561060725751, 6340.8097757067135, 6361.236651601815, 6389.808305750812, 6405.871882562346, 6266.0, 6279.403456671609, 6296.559240853142, 6299.68501574924, 6324.114623952673, 5416.864578385533, 5574.47042530963, 5586.692731899744, 5613.4386561343945, 5622.381538030813, 22347.10611575535, 22370.993305301137, 23265.06939722409, 23873.522529549486, 23984.88007559951, 2318.629019356895, 2367.4199821043953, 2396.928092157238, 2432.0, 2634.315078079694, 13831.79252311216, 14085.859141408557, 14339.78490322646, 14588.489402870848, 14623.341949612293, 2033.2901425296463, 2120.522882351474, 2137.316058861165, 2207.1061220205843, 2214.047959377467, 73456.63271683607, 74512.25487745108, 77297.22702772956, 77740.61129694372, 78472.0, 17094.230759615846, 17103.657926841395, 17114.229859656345, 17126.314947402214, 17230.224639891236, 27049.729502704722, 27133.592996105075, 27459.0, 27559.586606200923, 27641.861790690917, 9630.662926797668, 9905.75235619101, 9912.405255684682, 9917.851232231522, 9959.950200248952, 8268.049174344907, 8271.793205169799, 8314.875276870851, 8358.582070896431, 8549.487030778173, 7259.637018149071, 8402.621882015324, 8578.957105214435, 8597.355198360023, 8641.30869530436, 2671.647082910973, 2813.6563569084674, 3118.5789918361183, 3172.920676983094, 3210.21349769308, 936.442816524167, 995.721198064543, 1057.2757661002238, 1086.6739978006567, 1097.412884106999, 15362.0, 16903.0, 17138.314467421413, 17365.913170434065, 18216.362427315245, 945.7824700318965, 983.3755565216139, 983.9262055345878, 1011.0748664971469, 1030.948452577383, 9464.053594640482, 10093.343932644355, 10104.191664666809, 10144.898551014543, 10174.4912754362, 448167.0, 451827.0, 458371.0, 463056.0, 620634.0, 83862.58068709617, 88085.11914880769, 88279.55860220658, 89408.5529572348, 91837.0, 1188.518649946773, 1194.199886076331, 1220.6155061155707, 1222.0590145587848, 1226.4358395138336, 15686.529404117895, 16229.269682864064, 16472.01167929928, 16568.00591964486, 16613.0862802547, 34703.30593388169, 35746.64253357433, 36820.15899204976, 36934.445983309735, 37582.06044848901, 46199.0, 47331.763341183076, 47621.0, 49465.75267123641, 50058.249126263865, 9855.556499957662, 10146.340487868265, 10149.746256343651, 10256.538455769658, 10272.435016074187, 14207.928960355131, 14695.632609184855, 15095.849041509884, 15204.771928420862, 17213.13934303305, 14763.188024658746, 15027.323770430137, 15033.924830375778, 15162.696746064796, 15325.0, 15553.611159721098, 15732.370705171665, 15953.840461595235, 15969.0, 16237.106959116889, 15979.121148336953, 16310.102944337701, 16489.83510164883, 16783.0, 16806.495805125865, 10282.228832837418, 10421.06210441064, 10423.68728938133, 10689.0, 10698.0, 15357.155356455502, 15624.609384765472, 15644.843551564338, 16133.64391614281, 16365.509034728977], "unit": "ms", "name": "jquery.html", "value": 10292.344778677005}, {"lowerIsBetter": false, "replicates": [1564.139723152266, 1567.1537369820298, 1752.9649407011852, 1785.6250187460635, 1825.9957023637, 7281.089863767029, 7506.361959233472, 7513.023306970086, 7517.097948246212, 7526.698932042726, 6845.828854278646, 6962.965185174067, 7449.590272535009, 7653.15815260321, 7923.801904952379, 2215.501512159763, 2223.8776867272295, 2249.662550617404, 2250.1224522436264, 2251.4146321956246, 2020.8585399022074, 2266.4900397410534, 2284.817214622826, 2329.8369114162015, 2330.1145564685394, 1965.5282732144326, 2191.068795761803, 2236.4856083100817, 2236.6085934961316, 2238.46276893546, 2184.235517568862, 2201.680756290345, 2211.380813372258, 2239.596872562938, 2240.1599400224914, 2275.601769690314, 2298.0348253733473, 2313.664518644804, 2321.2339927823778, 2326.278853555403, 7664.0, 7669.233076692342, 7705.499142555716, 7728.845423091563, 7739.883901741478, 4649.837255696035, 4749.4775574686755, 4749.881252968669, 4753.0, 4757.5718185363485, 2969.317057076863, 2972.524396096614, 2994.2215024093894, 2995.925101872449, 3068.340306834019, 966.709987003896, 978.0708327089294, 1008.606643409071, 1025.5795123999198, 1052.3370276725614, 10086.646967356108, 10197.49012549377, 10204.94897525515, 10210.2852800304, 10225.948870255676, 3917.5103112110987, 3928.1947200824334, 3971.0270983609203, 3984.6015398460504, 3985.0, 8880.333974951775, 8907.064758200295, 8908.376413651113, 8909.509976951329, 8915.55422228886, 4469.0, 4493.348464472699, 4496.9325460118125, 4501.909961800746, 4503.482099558527, 4064.2684316822665, 4067.044244602516, 4068.715189936676, 4071.714979951375, 4072.2873497137884, 3552.2007548301426, 3590.192206753512, 3602.1354874829854, 3602.225521512835, 3613.8735144269826, 1063.213800814639, 1066.173715370594, 1066.7439814444633, 1090.0571006079683, 1090.8527348807809, 1178.66997240771, 1179.8584169899666, 1218.4760552962312, 1423.5729281215595, 1443.7040406716599, 7335.083114610674, 7382.298681625237, 7432.962835185897, 7437.51656142349, 7445.85108297831, 636.8917284061721, 643.8905386084377, 646.1890327638783, 656.2748163279603, 793.4168386236112, 5788.218590490314, 5840.795572154954, 5841.853953651193, 5851.063829787298, 5857.179994800731, 9079.909200907907, 9155.084491550791, 9296.628134874665, 9352.345335826563, 9453.101955314234, 9306.488143152192, 9313.580888860017, 9326.673566425277, 9330.30022748283, 9337.0, 7142.107236595426, 7255.23819998903, 7426.331630153312, 7454.515456495419, 7454.888176677354, 7140.678669459783, 7169.749058783126, 7181.497295189287, 7188.928110719035, 7218.639068046472, 8229.711960081368, 8488.0, 8495.277901378453, 8503.362247831314, 8505.659773609234, 8458.830823383374, 8462.238398544161, 8625.309975201842, 8640.13598640131, 8648.1784230498, 6904.240533541407, 6971.128608923885, 7002.474814389043, 7011.6494175292055, 7023.262557431601, 7593.012908321883, 7657.846843062996, 7668.233176682287, 7679.116901556393, 7683.039620047494, 5983.700814959322, 7040.894386584103, 7245.239249878898, 7328.157261914948, 7334.926650733638, 6558.80323590293, 6761.86476270462, 6772.119624448987, 6834.0, 6842.897356539556, 6834.589924604539, 6839.076724642109, 6946.479014073863, 6952.687129079102, 6961.512694111364, 6361.936380636134, 6364.649944252926, 6401.839954001187, 6409.4231519163495, 6417.197850268716, 6426.036094585663, 6444.420002199825, 6456.386643268882, 6561.80314590563, 6798.252192258748], "unit": "ms", "name": "mootools.html", "value": 4387.5910004311545}, {"lowerIsBetter": false, "replicates": [345.51110179096577, 351.1659807956105, 357.98747043853473, 358.6556905370844, 363.8726445743988, 6036.788712395067, 6121.938780612192, 6131.417515336041, 6134.938650613498, 6172.043333283348, 5810.1865738796605, 5851.678157701324, 5946.0, 6007.579469437142, 6013.188219590354, 4661.997670500841, 4687.507811679776, 4698.0, 4705.600023997948, 4720.315554244632, 4672.532746725335, 4701.694389864648, 4703.412073490814, 4711.340412342275, 4715.41057367829, 4422.601965823075, 4481.619062379702, 4543.4093567836135, 4666.486686464486, 4671.439427268732, 4656.138614356321, 4658.790354434059, 4661.254199328125, 4667.789949452283, 4679.15775160471, 4135.110951145488, 4139.151473947833, 4140.275451795954, 4140.751554906716, 4141.7100802943805, 5729.169270455761, 5736.7992120276, 5737.885242295172, 5741.483266505993, 5743.4543718346695, 5250.7112108834, 5393.487618676219, 5394.002109609734, 5399.055165346049, 5399.541039011689, 6357.300696923335, 6365.904511432333, 6366.140571022946, 6368.458681012119, 6382.297947225801, 4494.662900282459, 4501.572350626685, 4505.842295519641, 4506.752128632957, 4507.481639611421, 6484.448821850101, 6559.9672001640165, 6628.138342015555, 6631.171103612049, 6632.900506492407, 4620.8151673933335, 4624.30635404692, 4626.699264547861, 4628.5371462853445, 4635.212013957568, 4666.113438446684, 4672.906541869143, 4678.789454474489, 4680.976595117003, 4687.5781179693995, 5375.865603359869, 5380.623356365095, 5384.165454354581, 5386.730663466811, 5401.945980540223, 6332.33510481402, 6433.388828061326, 6451.580652256496, 6457.677116144174, 6464.385883341075, 1635.6646887388056, 1649.6783127290303, 1650.3563610192034, 1650.867930565552, 1652.4712092130644, 1059.814532456817, 1075.6127793994156, 1097.0510508410327, 1111.6164923101678, 1142.2974870454611, 6224.37756224383, 6226.657533835682, 6228.906566401508, 6235.657038862906, 6236.345183755731, 6692.297308782605, 6693.497987650849, 6695.0626912231355, 6696.732130714717, 6697.162854643169, 6048.304444988795, 6116.0, 6174.598651087665, 6276.152719382916, 6284.12022316876, 3601.7478776485395, 3611.4041183204477, 3625.655562721537, 3628.927421451609, 3630.618785027587, 6903.723851046002, 6918.619475928872, 6920.134983127109, 6922.965385173042, 6930.3762661360715, 6704.430123439464, 6889.586624802528, 6891.27641597635, 6891.862162756717, 6901.068355772007, 6907.930920690829, 6909.930900690929, 6913.446924246048, 6915.792526224222, 6916.308369163044, 6617.690504795909, 6716.764913228014, 6720.0, 6721.663916804043, 6723.193216814014, 6575.736970521126, 6622.4702023838945, 6627.768028119185, 6633.502487313567, 6636.83407914806, 6894.000739785607, 6900.551464154814, 6905.309469053054, 6906.516543841883, 6907.998340240537, 4620.907581848412, 4621.075784842978, 4622.306654001926, 4622.653301002506, 4626.282926146453, 6618.238902526271, 6709.899351509829, 6736.797896063126, 6747.628880411625, 6755.662216889037, 6548.83627909287, 6552.508561857975, 6557.836054098686, 6558.376954189344, 6564.901526477202, 6552.1154644124335, 6554.115194448688, 6554.541182117206, 6557.147570815954, 6562.475001999733, 6272.121902933502, 6446.194225721785, 6447.548671592944, 6453.51598630114, 6464.612123272619, 6597.010448432773, 6603.966980165068, 6604.735810567716, 6605.5376123670885, 6606.240282367589, 6253.8749225014335, 6431.260405053479, 6439.935600643934, 6441.259255185713, 6443.291237963914], "unit": "ms", "name": "prototype.html", "value": 4893.528867196996}, {"lowerIsBetter": false, "replicates": [761.5735188294559, 795.554489485888, 874.4753148111134, 876.123876123876, 885.3404213860673, 13555.118917270383, 13649.181049137034, 13739.862601373983, 13744.381502832372, 13885.028048036642, 13871.16772993621, 13880.722385552283, 14083.366248518816, 14703.779443308358, 14724.779128313085, 891.8974317953438, 900.4867225681364, 901.04489241404, 901.1889299630319, 901.5717534171282, 894.995525022374, 897.2507955856868, 900.7838118851494, 900.9819803603924, 901.4771432569127, 947.0955237747934, 948.4025064209573, 948.6205517792869, 948.83869742144, 953.3755390219418, 939.567798812547, 940.9858852117223, 941.4727752458645, 941.9340646154772, 945.3618807305076, 695.4332219241353, 696.314130581377, 697.0311267338403, 697.0624510033996, 698.4866123399297, 13729.0, 13838.93080534601, 13928.58214253574, 13944.16335019902, 13987.160770353812, 11453.59912403062, 11744.177907546475, 11840.171188016842, 12147.878521214763, 12316.322602256872, 10505.947470262676, 10652.573897044109, 10657.200709946708, 10673.199510036779, 12140.696482587917, 3786.678132358753, 3787.8484860605545, 3791.393377059685, 3810.0, 3898.629630185128, 48888.0, 49330.0, 50232.0, 53867.461325386634, 55024.44975550233, 10433.372465527045, 10781.892181078245, 10931.0, 11045.613403530839, 11152.275102118336, 18771.0, 18795.060246987596, 18838.0, 18842.81157188438, 18861.0, 7517.774466766005, 7628.618569071524, 7680.116786569616, 7850.528968261922, 7865.488743231672, 4510.954890451119, 4524.864254072383, 4588.0, 4602.953970460319, 4607.907841843212, 3214.3089235813945, 3220.6940340667597, 3256.6417694053634, 3259.543663887058, 3261.4944683574086, 555.2920026965651, 579.1139556478595, 579.3858509979435, 587.8912401205705, 605.6214865708932, 536.771320507142, 547.805529037186, 625.7027911741886, 656.0, 665.8692185007994, 7905.920940790634, 8398.538080405637, 8507.234348908629, 8614.569271536398, 8907.643694252158, 492.81927470940946, 612.6171143035602, 639.280809089774, 640.1390130274773, 649.447969226154, 4013.4381186633896, 4128.174365126986, 4194.643455306272, 4197.874063778091, 4245.490541135022, 57833.710831445576, 58049.0, 58168.709156453944, 58572.0, 58807.0, 45919.77040114778, 52494.73752631212, 52521.73739131356, 52889.206661900105, 55101.72449137729, 47140.0, 47150.0, 47777.0, 47811.521884780705, 48043.51956480391, 8309.0, 8624.223819856243, 8691.130886911258, 8767.693130740394, 8876.556172191495, 34968.475472867416, 35075.649243507236, 35568.28863422769, 36945.81527092347, 37665.4350184742, 45955.54044459647, 46452.07095858132, 46806.0, 46870.0, 46918.53081469142, 11155.0, 11289.661310160709, 11349.205555611028, 11422.200445969034, 11512.36681982499, 11886.58396956137, 12170.604467740586, 12205.816912746139, 12339.321337326173, 12628.179168354027, 11253.493592788507, 11646.475908583965, 11710.765784684088, 11794.46924888365, 11840.585579504675, 10648.627298044532, 10917.290376125526, 11108.722281943015, 11183.384913829817, 11256.380899050304, 11285.605003824827, 11314.03830674402, 11365.602203923154, 11635.47640356203, 11674.778298647614, 9599.184069353903, 9631.0, 9657.22742180638, 10053.19574434058, 10723.571057157938, 9719.951400242953, 9972.700818975442, 10092.89907100949, 10168.745781355525, 10215.080642742189], "unit": "ms", "name": "yui.html", "value": 6533.045927210413}], "name": "dromaeo_css", "value": 7415.491952291127}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 109.0, 111.0, 112.0, 113.0, 101.0, 113.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 148.0, 159.0, 130.0, 155.0, 150.0, 125.0, 159.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 145.0, 72.0, 71.0, 72.0, 72.0, 160.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 134.0, 94.0, 94.0, 94.0, 137.0, 92.0, 94.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [191.0, 199.0, 205.0, 199.0, 198.0, 199.0, 200.0, 197.0, 198.0, 198.0], "unit": "ms", "name": "imaging-darkroom", "value": 198.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 57.0, 59.0, 58.0, 57.0, 58.0, 58.0, 55.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 64.0, 65.0, 66.0, 75.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [80.0, 78.0, 77.0, 78.0, 79.0, 79.0, 78.0, 79.0, 78.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [127.0, 113.0, 112.0, 112.0, 119.0, 132.0, 114.0, 128.0, 117.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [136.0, 137.0, 152.0, 147.0, 145.0, 135.0, 147.0, 152.0, 142.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 68.0, 64.0, 64.0, 67.0, 66.0, 69.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1541.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.8697330871244], "unit": "score", "name": "Richards", "value": 210.29401399999998}, {"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "DeltaBlue", "value": 395.25340400000005}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [965.2509652509652], "unit": "score", "name": "RayTrace", "value": 766.6286040000001}, {"lowerIsBetter": false, "replicates": [541.1255411255411], "unit": "score", "name": "Earley", "value": 1231.623624}, {"lowerIsBetter": false, "replicates": [10562.5], "unit": "score", "name": "Boyer", "value": 63.09708875739642}, {"lowerIsBetter": false, "replicates": [24853.658536585364], "unit": "score", "name": "RegExp", "value": 36.65395976447495}, {"lowerIsBetter": false, "replicates": [504.2821158690176], "unit": "score", "name": "Splay", "value": 161.598036963037}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23254.7423400521}]} 18:39:34 INFO - RETURN: dromaeo_css: 7415.49 18:39:34 INFO - RETURN: kraken: 1541.30 18:39:34 INFO - RETURN: v8_7: 23254.74 18:39:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23254.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1541.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7415.49"}}} 18:39:34 INFO - Return code: 0 18:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:39:34 INFO - # TBPL SUCCESS # 18:39:34 INFO - Running post-action listener: _resource_record_post_action 18:39:34 INFO - Running post-run listener: _resource_record_post_run 18:39:35 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 331776; Write bytes: 503341056; Read time: 300; Write time: 403888 18:39:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 238235648; Read time: 64; Write time: 257928 18:39:35 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 327680; Write bytes: 265105408; Read time: 236; Write time: 145960 18:39:35 INFO - Running post-run listener: _upload_blobber_files 18:39:35 INFO - Blob upload gear active. 18:39:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:39:35 INFO - Copying logs to upload dir... 18:39:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.525354 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-02-17 18:39:35.631035) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-17 18:39:35.634269) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010067 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455753505/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-17 18:39:35.684677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:39:35.685016) ========= 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=52faae308a556c440401f8e5000001e8-1455761914.640400-305560378 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 18:39:35.734702) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 18:39:35.735022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 18:39:35.735313) ========= ========= Total master_lag: 0.25 =========