builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1455043395.66 results: success (0) buildid: 20160209081956 builduid: 3f66061e085a4845bdba5b5aa0b4db30 revision: 645a5f29ab61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.661754) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.662643) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.663014) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006228 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.690249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.690751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.704438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.704952) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.757899) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.758660) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.759596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.760408) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 10:43:15-- 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% 87.2M=0s 2016-02-09 10:43:15 (87.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099001 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.877152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.877936) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.929046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:15.929452) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 645a5f29ab61 --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 645a5f29ab61 --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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 10:43:16,066 Setting DEBUG logging. 2016-02-09 10:43:16,066 attempt 1/10 2016-02-09 10:43:16,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/645a5f29ab61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 10:43:16,305 unpacking tar archive at: mozilla-beta-645a5f29ab61/testing/mozharness/ program finished with exit code 0 elapsedTime=0.577163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:16.524133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:16.525040) ========= echo 645a5f29ab61 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'645a5f29ab61'] 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 645a5f29ab61 program finished with exit code 0 elapsedTime=0.004656 script_repo_revision: '645a5f29ab61' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:16.580373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:16.581181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:43:16.593102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-02-09 10:43:16.594280) ========= /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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:43:16 INFO - MultiFileLogger online at 20160209 10:43:16 in /builds/slave/test-pgo 10:43:16 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 10:43:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:43:16 INFO - {'append_to_log': False, 10:43:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:43:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:43:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:43:16 INFO - 'branch': 'Mozilla-Beta', 10:43:16 INFO - 'buildbot_json_path': 'buildprops.json', 10:43:16 INFO - 'config_files': ('talos/linux_config.py',), 10:43:16 INFO - 'default_actions': ('clobber', 10:43:16 INFO - 'read-buildbot-config', 10:43:16 INFO - 'download-and-extract', 10:43:16 INFO - 'populate-webroot', 10:43:16 INFO - 'create-virtualenv', 10:43:16 INFO - 'install', 10:43:16 INFO - 'run-tests'), 10:43:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:43:16 INFO - 'download_minidump_stackwalk': True, 10:43:16 INFO - 'download_symbols': 'ondemand', 10:43:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:43:16 INFO - 'tooltool.py': '/tools/tooltool.py', 10:43:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:43:16 INFO - '/tools/misc-python/virtualenv.py')}, 10:43:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:43:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:43:16 INFO - 'installer_path': 'installer.exe', 10:43:16 INFO - 'log_level': 'info', 10:43:16 INFO - 'log_name': 'talos', 10:43:16 INFO - 'log_to_console': True, 10:43:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:43:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:43:16 INFO - 'opt_config_files': (), 10:43:16 INFO - 'pip_index': False, 10:43:16 INFO - 'sps_profile': False, 10:43:16 INFO - 'sps_profile_interval': 0, 10:43:16 INFO - 'suite': 'dromaeojs', 10:43:16 INFO - 'system_bits': '32', 10:43:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:43:16 INFO - 'title': 'talos-linux64-ix-015', 10:43:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:43:16 INFO - 'use_talos_json': True, 10:43:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:43:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:43:16 INFO - 'work_dir': 'build'} 10:43:16 INFO - ##### 10:43:16 INFO - ##### Running clobber step. 10:43:16 INFO - ##### 10:43:16 INFO - Running pre-action listener: _resource_record_pre_action 10:43:16 INFO - Running main action method: clobber 10:43:16 INFO - rmtree: /builds/slave/test-pgo/build 10:43:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:43:17 INFO - Running post-action listener: _resource_record_post_action 10:43:17 INFO - ##### 10:43:17 INFO - ##### Running read-buildbot-config step. 10:43:17 INFO - ##### 10:43:17 INFO - Running pre-action listener: _resource_record_pre_action 10:43:17 INFO - Running main action method: read_buildbot_config 10:43:17 INFO - Using buildbot properties: 10:43:17 INFO - { 10:43:17 INFO - "properties": { 10:43:17 INFO - "buildnumber": 104, 10:43:17 INFO - "product": "firefox", 10:43:17 INFO - "script_repo_revision": "production", 10:43:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:43:17 INFO - "repository": "", 10:43:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:43:17 INFO - "buildid": "20160209081956", 10:43:17 INFO - "slavename": "talos-linux64-ix-015", 10:43:17 INFO - "pgo_build": "True", 10:43:17 INFO - "basedir": "/builds/slave/test-pgo", 10:43:17 INFO - "project": "", 10:43:17 INFO - "platform": "ubuntu64_hw", 10:43:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:43:17 INFO - "slavebuilddir": "test", 10:43:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:43:17 INFO - "branch": "mozilla-beta", 10:43:17 INFO - "repo_path": "releases/mozilla-beta", 10:43:17 INFO - "stage_platform": "linux64-pgo", 10:43:17 INFO - "builduid": "3f66061e085a4845bdba5b5aa0b4db30", 10:43:17 INFO - "revision": "645a5f29ab61" 10:43:17 INFO - }, 10:43:17 INFO - "sourcestamp": { 10:43:17 INFO - "repository": "", 10:43:17 INFO - "hasPatch": false, 10:43:17 INFO - "project": "", 10:43:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:43:17 INFO - "changes": [ 10:43:17 INFO - { 10:43:17 INFO - "category": null, 10:43:17 INFO - "files": [ 10:43:17 INFO - { 10:43:17 INFO - "url": null, 10:43:17 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:43:17 INFO - } 10:43:17 INFO - ], 10:43:17 INFO - "repository": "", 10:43:17 INFO - "rev": "645a5f29ab61", 10:43:17 INFO - "who": "sendchange", 10:43:17 INFO - "when": 1455043257, 10:43:17 INFO - "number": 7583459, 10:43:17 INFO - "comments": "Bug 1245724 - Make plugin network requests bypass service worker interception. r=ehsan, a=sledru", 10:43:17 INFO - "project": "", 10:43:17 INFO - "at": "Tue 09 Feb 2016 10:40:57", 10:43:17 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:43:17 INFO - "revlink": "", 10:43:17 INFO - "properties": [ 10:43:17 INFO - [ 10:43:17 INFO - "buildid", 10:43:17 INFO - "20160209081956", 10:43:17 INFO - "Change" 10:43:17 INFO - ], 10:43:17 INFO - [ 10:43:17 INFO - "builduid", 10:43:17 INFO - "3f66061e085a4845bdba5b5aa0b4db30", 10:43:17 INFO - "Change" 10:43:17 INFO - ], 10:43:17 INFO - [ 10:43:17 INFO - "pgo_build", 10:43:17 INFO - "True", 10:43:17 INFO - "Change" 10:43:17 INFO - ] 10:43:17 INFO - ], 10:43:17 INFO - "revision": "645a5f29ab61" 10:43:17 INFO - } 10:43:17 INFO - ], 10:43:17 INFO - "revision": "645a5f29ab61" 10:43:17 INFO - } 10:43:17 INFO - } 10:43:17 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:43:17 INFO - Running post-action listener: _resource_record_post_action 10:43:17 INFO - ##### 10:43:17 INFO - ##### Running download-and-extract step. 10:43:17 INFO - ##### 10:43:17 INFO - Running pre-action listener: _resource_record_pre_action 10:43:17 INFO - Running main action method: download_and_extract 10:43:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/test_packages.json 10:43:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:43:17 INFO - Downloaded 1270 bytes. 10:43:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:43:17 INFO - Using the following test package requirements: 10:43:17 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:17 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:43:17 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'jsshell-linux-x86_64.zip'], 10:43:17 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:43:17 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:17 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:43:17 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:43:17 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:43:17 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:43:17 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:43:17 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:43:17 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:17 INFO - Downloaded 21581694 bytes. 10:43:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:43:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:43:18 INFO - Return code: 0 10:43:18 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:19 INFO - Downloaded 21581694 bytes. 10:43:19 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 10:43:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:43:19 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 10:43:20 INFO - Return code: 0 10:43:20 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')]} 10:43:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:43:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:20 INFO - Downloaded 11132038 bytes. 10:43:20 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 10:43:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:43:20 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 10:43:21 INFO - Return code: 0 10:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:21 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:21 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/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 10:43:22 INFO - Downloaded 57935888 bytes. 10:43:22 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:22 INFO - mkdir: /builds/slave/test-pgo/properties 10:43:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:43:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:43:22 INFO - Contents: 10:43:22 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:43:22 INFO - Running post-action listener: _resource_record_post_action 10:43:22 INFO - Running post-action listener: set_extra_try_arguments 10:43:22 INFO - ##### 10:43:22 INFO - ##### Running populate-webroot step. 10:43:22 INFO - ##### 10:43:22 INFO - Running pre-action listener: _resource_record_pre_action 10:43:22 INFO - Running main action method: populate_webroot 10:43:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:43:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:43:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:43:22 INFO - '--tppagecycles', 10:43:22 INFO - '7'], 10:43:22 INFO - 'tests': ['tsvgm']}}, 10:43:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:43:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:43:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:43:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:43:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:43:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'tests': ['damp', 'tps']}, 10:43:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['damp', 'tps']}, 10:43:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:43:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:43:22 INFO - 'other': {'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'other_l64': {'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'other_nol64': {'tests': ['a11yr', 10:43:22 INFO - 'ts_paint', 10:43:22 INFO - 'tpaint', 10:43:22 INFO - 'sessionrestore', 10:43:22 INFO - 'sessionrestore_no_auto_restore']}, 10:43:22 INFO - 'svgr': {'tests': ['tsvgx', 10:43:22 INFO - 'tsvgr_opacity', 10:43:22 INFO - 'tart', 10:43:22 INFO - 'tscrollx', 10:43:22 INFO - 'cart']}, 10:43:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['tsvgx', 10:43:22 INFO - 'tsvgr_opacity', 10:43:22 INFO - 'tart', 10:43:22 INFO - 'tscrollx', 10:43:22 INFO - 'cart']}, 10:43:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'tests': ['tp5o']}, 10:43:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'talos_options': ['--e10s'], 10:43:22 INFO - 'tests': ['tp5o']}, 10:43:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'talos_options': ['--xperf_path', 10:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:22 INFO - 'tests': ['tp5n']}, 10:43:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:43:22 INFO - 'talos_options': ['--e10s', 10:43:22 INFO - '--xperf_path', 10:43:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:43:22 INFO - 'tests': ['tp5n']}}, 10:43:22 INFO - 'talos.zip': {'path': '', 10:43:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:43:22 INFO - Running post-action listener: _resource_record_post_action 10:43:22 INFO - ##### 10:43:22 INFO - ##### Running create-virtualenv step. 10:43:22 INFO - ##### 10:43:22 INFO - Running pre-action listener: _resource_record_pre_action 10:43:22 INFO - Running main action method: create_virtualenv 10:43:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:43:22 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 10:43:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:43:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:43:22 INFO - Using real prefix '/usr' 10:43:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:43:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:43:25 INFO - Installing pip.................done. 10:43:25 INFO - Return code: 0 10:43:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:43: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')]} 10:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:25 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:25 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 10:43:25 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 10:43:25 INFO - Using env: {'DISPLAY': ':0', 10:43:25 INFO - 'HOME': '/home/cltbld', 10:43:25 INFO - 'LANG': 'en_US.UTF-8', 10:43:25 INFO - 'LANGUAGE': 'en_US:en', 10:43:25 INFO - 'LOGNAME': 'cltbld', 10:43:25 INFO - 'MAIL': '/var/mail/cltbld', 10:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:25 INFO - 'MOZ_NO_REMOTE': '1', 10:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:25 INFO - 'NO_EM_RESTART': '1', 10:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:25 INFO - 'SHELL': '/bin/bash', 10:43:25 INFO - 'SHLVL': '1', 10:43:25 INFO - 'TERM': 'linux', 10:43:25 INFO - 'TMOUT': '86400', 10:43:25 INFO - 'USER': 'cltbld', 10:43:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:25 INFO - '_': '/tools/buildbot/bin/python'} 10:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:25 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 10:43:25 INFO - Cleaning up... 10:43:25 INFO - Return code: 0 10:43:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:43: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')]} 10:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:25 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:25 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 10:43:25 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 10:43:25 INFO - Using env: {'DISPLAY': ':0', 10:43:25 INFO - 'HOME': '/home/cltbld', 10:43:25 INFO - 'LANG': 'en_US.UTF-8', 10:43:25 INFO - 'LANGUAGE': 'en_US:en', 10:43:25 INFO - 'LOGNAME': 'cltbld', 10:43:25 INFO - 'MAIL': '/var/mail/cltbld', 10:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:25 INFO - 'MOZ_NO_REMOTE': '1', 10:43:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:25 INFO - 'NO_EM_RESTART': '1', 10:43:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:25 INFO - 'SHELL': '/bin/bash', 10:43:25 INFO - 'SHLVL': '1', 10:43:25 INFO - 'TERM': 'linux', 10:43:25 INFO - 'TMOUT': '86400', 10:43:25 INFO - 'USER': 'cltbld', 10:43:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:25 INFO - '_': '/tools/buildbot/bin/python'} 10:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:25 INFO - Downloading/unpacking psutil>=0.7.1 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:25 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 10:43:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:27 INFO - Installing collected packages: psutil 10:43:27 INFO - Running setup.py install for psutil 10:43:27 INFO - building 'psutil._psutil_linux' extension 10:43:27 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 10:43:27 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 10:43:27 INFO - building 'psutil._psutil_posix' extension 10:43:27 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 10:43:27 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 10:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:43:27 INFO - Successfully installed psutil 10:43:27 INFO - Cleaning up... 10:43:27 INFO - Return code: 0 10:43:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:43:27 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')]} 10:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:27 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')]} 10:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:27 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:27 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 10:43:27 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 10:43:27 INFO - Using env: {'DISPLAY': ':0', 10:43:27 INFO - 'HOME': '/home/cltbld', 10:43:27 INFO - 'LANG': 'en_US.UTF-8', 10:43:27 INFO - 'LANGUAGE': 'en_US:en', 10:43:27 INFO - 'LOGNAME': 'cltbld', 10:43:27 INFO - 'MAIL': '/var/mail/cltbld', 10:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:27 INFO - 'MOZ_NO_REMOTE': '1', 10:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:27 INFO - 'NO_EM_RESTART': '1', 10:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:27 INFO - 'SHELL': '/bin/bash', 10:43:27 INFO - 'SHLVL': '1', 10:43:27 INFO - 'TERM': 'linux', 10:43:27 INFO - 'TMOUT': '86400', 10:43:27 INFO - 'USER': 'cltbld', 10:43:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:27 INFO - '_': '/tools/buildbot/bin/python'} 10:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:43:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:43:29 INFO - Installing collected packages: mozsystemmonitor 10:43:29 INFO - Running setup.py install for mozsystemmonitor 10:43:30 INFO - Successfully installed mozsystemmonitor 10:43:30 INFO - Cleaning up... 10:43:30 INFO - Return code: 0 10:43:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:43:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:43:30 INFO - Using env: {'DISPLAY': ':0', 10:43:30 INFO - 'HOME': '/home/cltbld', 10:43:30 INFO - 'LANG': 'en_US.UTF-8', 10:43:30 INFO - 'LANGUAGE': 'en_US:en', 10:43:30 INFO - 'LOGNAME': 'cltbld', 10:43:30 INFO - 'MAIL': '/var/mail/cltbld', 10:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:30 INFO - 'MOZ_NO_REMOTE': '1', 10:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:30 INFO - 'NO_EM_RESTART': '1', 10:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:30 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:30 INFO - 'SHELL': '/bin/bash', 10:43:30 INFO - 'SHLVL': '1', 10:43:30 INFO - 'TERM': 'linux', 10:43:30 INFO - 'TMOUT': '86400', 10:43:30 INFO - 'USER': 'cltbld', 10:43:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:30 INFO - '_': '/tools/buildbot/bin/python'} 10:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:30 INFO - Downloading/unpacking blobuploader==1.2.4 10:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:43:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:43:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:43:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:32 INFO - Downloading docopt-0.6.1.tar.gz 10:43:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:43:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:43:32 INFO - Running setup.py install for blobuploader 10:43:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:43:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:43:32 INFO - Running setup.py install for requests 10:43:33 INFO - Running setup.py install for docopt 10:43:33 INFO - Successfully installed blobuploader requests docopt 10:43:33 INFO - Cleaning up... 10:43:33 INFO - Return code: 0 10:43:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43:33 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')]} 10:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:33 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')]} 10:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:33 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:33 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 10:43:33 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 10:43:33 INFO - Using env: {'DISPLAY': ':0', 10:43:33 INFO - 'HOME': '/home/cltbld', 10:43:33 INFO - 'LANG': 'en_US.UTF-8', 10:43:33 INFO - 'LANGUAGE': 'en_US:en', 10:43:33 INFO - 'LOGNAME': 'cltbld', 10:43:33 INFO - 'MAIL': '/var/mail/cltbld', 10:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:33 INFO - 'MOZ_NO_REMOTE': '1', 10:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:33 INFO - 'NO_EM_RESTART': '1', 10:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:33 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:33 INFO - 'SHELL': '/bin/bash', 10:43:33 INFO - 'SHLVL': '1', 10:43:33 INFO - 'TERM': 'linux', 10:43:33 INFO - 'TMOUT': '86400', 10:43:33 INFO - 'USER': 'cltbld', 10:43:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:33 INFO - '_': '/tools/buildbot/bin/python'} 10:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:33 INFO - Running setup.py (path:/tmp/pip-07evgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:33 INFO - Running setup.py (path:/tmp/pip-dlYwlJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:33 INFO - Running setup.py (path:/tmp/pip-TFSXyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:33 INFO - Running setup.py (path:/tmp/pip-LPwm7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:33 INFO - Running setup.py (path:/tmp/pip-gBdeVY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:33 INFO - Running setup.py (path:/tmp/pip-YWEcKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:34 INFO - Running setup.py (path:/tmp/pip-Ku086d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:34 INFO - Running setup.py (path:/tmp/pip-NdRtZX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:34 INFO - Running setup.py (path:/tmp/pip-S3gsbd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:34 INFO - Running setup.py (path:/tmp/pip-vkndhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:34 INFO - Running setup.py (path:/tmp/pip-AieRww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:34 INFO - Running setup.py (path:/tmp/pip-86uHZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:34 INFO - Running setup.py (path:/tmp/pip-KqvfDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:34 INFO - Running setup.py (path:/tmp/pip-HCLHmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:34 INFO - Running setup.py (path:/tmp/pip-wD8egc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:34 INFO - Running setup.py (path:/tmp/pip-tVtZnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:34 INFO - Running setup.py (path:/tmp/pip-tf93bU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:43:34 INFO - Running setup.py install for manifestparser 10:43:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:43:34 INFO - Running setup.py install for mozcrash 10:43:35 INFO - Running setup.py install for mozdebug 10:43:35 INFO - Running setup.py install for mozdevice 10:43:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Running setup.py install for mozfile 10:43:35 INFO - Running setup.py install for mozhttpd 10:43:35 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Running setup.py install for mozinfo 10:43:35 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Running setup.py install for mozInstall 10:43:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Running setup.py install for mozleak 10:43:35 INFO - Running setup.py install for mozlog 10:43:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:43:35 INFO - Running setup.py install for moznetwork 10:43:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Running setup.py install for mozprocess 10:43:36 INFO - Running setup.py install for mozprofile 10:43:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Running setup.py install for mozrunner 10:43:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Running setup.py install for mozscreenshot 10:43:36 INFO - Running setup.py install for moztest 10:43:36 INFO - Running setup.py install for mozversion 10:43:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:43:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:43:36 INFO - Cleaning up... 10:43:36 INFO - Return code: 0 10:43:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:36 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:36 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 10:43:36 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 10:43:36 INFO - Using env: {'DISPLAY': ':0', 10:43:36 INFO - 'HOME': '/home/cltbld', 10:43:36 INFO - 'LANG': 'en_US.UTF-8', 10:43:36 INFO - 'LANGUAGE': 'en_US:en', 10:43:36 INFO - 'LOGNAME': 'cltbld', 10:43:36 INFO - 'MAIL': '/var/mail/cltbld', 10:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:36 INFO - 'MOZ_NO_REMOTE': '1', 10:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:36 INFO - 'NO_EM_RESTART': '1', 10:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:36 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:36 INFO - 'SHELL': '/bin/bash', 10:43:36 INFO - 'SHLVL': '1', 10:43:36 INFO - 'TERM': 'linux', 10:43:36 INFO - 'TMOUT': '86400', 10:43:36 INFO - 'USER': 'cltbld', 10:43:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:36 INFO - '_': '/tools/buildbot/bin/python'} 10:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:36 INFO - Running setup.py (path:/tmp/pip-DNJLmO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:43:36 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)) 10:43:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:36 INFO - Running setup.py (path:/tmp/pip-JRZPU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:37 INFO - Running setup.py (path:/tmp/pip-cjru15-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:37 INFO - Running setup.py (path:/tmp/pip-RmMYD9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:37 INFO - Running setup.py (path:/tmp/pip-6OO0l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:37 INFO - Running setup.py (path:/tmp/pip-QVu3M1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:37 INFO - Running setup.py (path:/tmp/pip-r6XDYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:37 INFO - Running setup.py (path:/tmp/pip-yFvhxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:37 INFO - Running setup.py (path:/tmp/pip-_84ZDP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:37 INFO - Running setup.py (path:/tmp/pip-PBO8iN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:37 INFO - Running setup.py (path:/tmp/pip-SLdBSD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:37 INFO - Running setup.py (path:/tmp/pip-1EO772-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:37 INFO - Running setup.py (path:/tmp/pip-71Ma6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:37 INFO - Running setup.py (path:/tmp/pip-HUQoDe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:37 INFO - Running setup.py (path:/tmp/pip-FRPirS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:43:37 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)) 10:43:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:37 INFO - Running setup.py (path:/tmp/pip-y2BaYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:43:38 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)) 10:43:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:38 INFO - Running setup.py (path:/tmp/pip-OQXyON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:43:38 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)) 10:43:38 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)) 10:43:38 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)) 10:43:38 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)) 10:43:38 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)) 10:43:38 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)) 10:43:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:43:38 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 10:43:38 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 10:43:38 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 10:43:38 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 10:43:38 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 10:43:38 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 10:43:39 INFO - Downloading blessings-1.6.tar.gz 10:43:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:43:39 INFO - Installing collected packages: blessings 10:43:39 INFO - Running setup.py install for blessings 10:43:40 INFO - Successfully installed blessings 10:43:40 INFO - Cleaning up... 10:43:40 INFO - Return code: 0 10:43:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:43:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:43:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:43:40 INFO - Reading from file tmpfile_stdout 10:43:40 INFO - Current package versions: 10:43:40 INFO - argparse == 1.2.1 10:43:40 INFO - blessings == 1.6 10:43:40 INFO - blobuploader == 1.2.4 10:43:40 INFO - docopt == 0.6.1 10:43:40 INFO - manifestparser == 1.1 10:43:40 INFO - mozInstall == 1.12 10:43:40 INFO - mozcrash == 0.16 10:43:40 INFO - mozdebug == 0.1 10:43:40 INFO - mozdevice == 0.47 10:43:40 INFO - mozfile == 1.2 10:43:40 INFO - mozhttpd == 0.7 10:43:40 INFO - mozinfo == 0.9 10:43:40 INFO - mozleak == 0.1 10:43:40 INFO - mozlog == 3.1 10:43:40 INFO - moznetwork == 0.27 10:43:40 INFO - mozprocess == 0.22 10:43:40 INFO - mozprofile == 0.27 10:43:40 INFO - mozrunner == 6.11 10:43:40 INFO - mozscreenshot == 0.1 10:43:40 INFO - mozsystemmonitor == 0.0 10:43:40 INFO - moztest == 0.7 10:43:40 INFO - mozversion == 1.4 10:43:40 INFO - psutil == 3.1.1 10:43:40 INFO - requests == 1.2.3 10:43:40 INFO - wsgiref == 0.1.2 10:43:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:43: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')]} 10:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:40 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:40 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 10:43:40 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 10:43:40 INFO - Using env: {'DISPLAY': ':0', 10:43:40 INFO - 'HOME': '/home/cltbld', 10:43:40 INFO - 'LANG': 'en_US.UTF-8', 10:43:40 INFO - 'LANGUAGE': 'en_US:en', 10:43:40 INFO - 'LOGNAME': 'cltbld', 10:43:40 INFO - 'MAIL': '/var/mail/cltbld', 10:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:40 INFO - 'MOZ_NO_REMOTE': '1', 10:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:40 INFO - 'NO_EM_RESTART': '1', 10:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:40 INFO - 'SHELL': '/bin/bash', 10:43:40 INFO - 'SHLVL': '1', 10:43:40 INFO - 'TERM': 'linux', 10:43:40 INFO - 'TMOUT': '86400', 10:43:40 INFO - 'USER': 'cltbld', 10:43:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:40 INFO - '_': '/tools/buildbot/bin/python'} 10:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 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)) 10:43:40 INFO - Cleaning up... 10:43:40 INFO - Return code: 0 10:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:43: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')]} 10:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:43:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:43:40 INFO - Using env: {'DISPLAY': ':0', 10:43:40 INFO - 'HOME': '/home/cltbld', 10:43:40 INFO - 'LANG': 'en_US.UTF-8', 10:43:40 INFO - 'LANGUAGE': 'en_US:en', 10:43:40 INFO - 'LOGNAME': 'cltbld', 10:43:40 INFO - 'MAIL': '/var/mail/cltbld', 10:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:40 INFO - 'MOZ_NO_REMOTE': '1', 10:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:40 INFO - 'NO_EM_RESTART': '1', 10:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:40 INFO - 'SHELL': '/bin/bash', 10:43:40 INFO - 'SHLVL': '1', 10:43:40 INFO - 'TERM': 'linux', 10:43:40 INFO - 'TMOUT': '86400', 10:43:40 INFO - 'USER': 'cltbld', 10:43:40 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:40 INFO - '_': '/tools/buildbot/bin/python'} 10:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:40 INFO - Downloading/unpacking jsonschema 10:43:40 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 10:43:40 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 10:43:40 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 10:43:40 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 10:43:40 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 10:43:40 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 10:43:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:43:42 INFO - Downloading/unpacking functools32 (from jsonschema) 10:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:43:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:43:42 INFO - warning: no files found matching '*.txt' 10:43:42 INFO - no previously-included directories found matching 'build' 10:43:42 INFO - no previously-included directories found matching 'dist' 10:43:42 INFO - no previously-included directories found matching '.git*' 10:43:42 INFO - Installing collected packages: jsonschema, functools32 10:43:42 INFO - Running setup.py install for functools32 10:43:42 INFO - warning: no files found matching '*.txt' 10:43:42 INFO - no previously-included directories found matching 'build' 10:43:42 INFO - no previously-included directories found matching 'dist' 10:43:42 INFO - no previously-included directories found matching '.git*' 10:43:43 INFO - Successfully installed jsonschema functools32 10:43:43 INFO - Cleaning up... 10:43:43 INFO - Return code: 0 10:43:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:43: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')]} 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43: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')]} 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:43:43 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 0x7f5ec5630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20610e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, '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': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', '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 10:43:43 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 10:43:43 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 10:43:43 INFO - Using env: {'DISPLAY': ':0', 10:43:43 INFO - 'HOME': '/home/cltbld', 10:43:43 INFO - 'LANG': 'en_US.UTF-8', 10:43:43 INFO - 'LANGUAGE': 'en_US:en', 10:43:43 INFO - 'LOGNAME': 'cltbld', 10:43:43 INFO - 'MAIL': '/var/mail/cltbld', 10:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:43:43 INFO - 'MOZ_NO_REMOTE': '1', 10:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:43:43 INFO - 'NO_EM_RESTART': '1', 10:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:43:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:43:43 INFO - 'SHELL': '/bin/bash', 10:43:43 INFO - 'SHLVL': '1', 10:43:43 INFO - 'TERM': 'linux', 10:43:43 INFO - 'TMOUT': '86400', 10:43:43 INFO - 'USER': 'cltbld', 10:43:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:43:43 INFO - '_': '/tools/buildbot/bin/python'} 10:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:43:43 INFO - Downloading/unpacking flake8 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:43:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:43:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:43:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:43:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:43:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:43:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:43:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:43:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:43:45 INFO - no previously-included directories found matching 'docs/_build' 10:43:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:43:45 INFO - Running setup.py install for pep8 10:43:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:43:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:43:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:43:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:43:45 INFO - no previously-included directories found matching 'docs/_build' 10:43:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:43:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:43:45 INFO - Cleaning up... 10:43:45 INFO - Return code: 0 10:43:45 INFO - Running post-action listener: _resource_record_post_action 10:43:45 INFO - Running post-action listener: _start_resource_monitoring 10:43:45 INFO - Starting resource monitoring. 10:43:45 INFO - ##### 10:43:45 INFO - ##### Running install step. 10:43:45 INFO - ##### 10:43:45 INFO - Running pre-action listener: _resource_record_pre_action 10:43:45 INFO - Running main action method: install 10:43:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:43:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:43:46 INFO - Reading from file tmpfile_stdout 10:43:46 INFO - Detecting whether we're running mozinstall >=1.0... 10:43:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:43:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:43:46 INFO - Reading from file tmpfile_stdout 10:43:46 INFO - Output received: 10:43:46 INFO - Usage: mozinstall [options] installer 10:43:46 INFO - Options: 10:43:46 INFO - -h, --help show this help message and exit 10:43:46 INFO - -d DEST, --destination=DEST 10:43:46 INFO - Directory to install application into. [default: 10:43:46 INFO - "/builds/slave/test-pgo"] 10:43:46 INFO - --app=APP Application being installed. [default: firefox] 10:43:46 INFO - mkdir: /builds/slave/test-pgo/build/application 10:43:46 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'] 10:43:46 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 10:44:00 INFO - Reading from file tmpfile_stdout 10:44:00 INFO - Output received: 10:44:00 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:44:00 INFO - Running post-action listener: _resource_record_post_action 10:44:00 INFO - ##### 10:44:00 INFO - ##### Running run-tests step. 10:44:00 INFO - ##### 10:44:00 INFO - Running pre-action listener: _resource_record_pre_action 10:44:00 INFO - Running main action method: run_tests 10:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:44:00 INFO - Python 2.7.3 10:44:00 INFO - Return code: 0 10:44:00 INFO - grabbing minidump binary from tooltool 10:44:00 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')]} 10:44:00 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 0x20efe30>, '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 0x20f0d30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f11c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:44:00 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 10:44:00 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 10:44:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:44:00 INFO - Return code: 0 10:44:00 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:44:00 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:44:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:44:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:44:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:44:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:44:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:44:01 INFO - Return code: 0 10:44:01 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/1455034796/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:44:01 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/1455034796/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 10:44:01 INFO - Using env: {'DISPLAY': ':0', 10:44:01 INFO - 'HOME': '/home/cltbld', 10:44:01 INFO - 'LANG': 'en_US.UTF-8', 10:44:01 INFO - 'LANGUAGE': 'en_US:en', 10:44:01 INFO - 'LOGNAME': 'cltbld', 10:44:01 INFO - 'MAIL': '/var/mail/cltbld', 10:44:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:44:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:01 INFO - 'MOZ_NO_REMOTE': '1', 10:44:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:01 INFO - 'NO_EM_RESTART': '1', 10:44:01 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:44:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:44:01 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:44:01 INFO - 'SHELL': '/bin/bash', 10:44:01 INFO - 'SHLVL': '1', 10:44:01 INFO - 'TERM': 'linux', 10:44:01 INFO - 'TMOUT': '86400', 10:44:01 INFO - 'USER': 'cltbld', 10:44:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077', 10:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:01 INFO - '_': '/tools/buildbot/bin/python'} 10:44:01 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/1455034796/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 10:44:02 INFO - mozversion INFO | application_buildid: 20160209081956 10:44:02 INFO - mozversion INFO | application_changeset: 645a5f29ab6163712a166f41321c82ffb83234c0 10:44:02 INFO - mozversion INFO | application_display_name: Nightly 10:44:02 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:44:02 INFO - mozversion INFO | application_name: Firefox 10:44:02 INFO - mozversion INFO | application_remotingname: firefox 10:44:02 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:44:02 INFO - mozversion INFO | application_vendor: Mozilla 10:44:02 INFO - mozversion INFO | application_version: 45.0 10:44:02 INFO - mozversion INFO | platform_buildid: 20160209081956 10:44:02 INFO - mozversion INFO | platform_changeset: 645a5f29ab6163712a166f41321c82ffb83234c0 10:44:02 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:44:02 INFO - mozversion INFO | platform_version: 45.0 10:44:02 INFO - 2016-02-09 10:44:02,152 DEBUG : using testdate: 1455043442 10:44:02 INFO - 2016-02-09 10:44:02,152 DEBUG : actual date: 1455043442 10:44:02 INFO - 2016-02-09 10:44:02,160 INFO : starting webserver on 'localhost:34655' 10:44:02 INFO - 2016-02-09 10:44:02,161 INFO : Starting test suite talos-linux64-ix-015 10:44:02 INFO - 2016-02-09 10:44:02,161 INFO : Starting test dromaeo_css 10:44:02 INFO - 2016-02-09 10:44:02,162 DEBUG : operating with platform_type : linux_ 10:44:02 INFO - 2016-02-09 10:44:02,162 INFO : Initialising browser for dromaeo_css test... 10:44:02 INFO - 2016-02-09 10:44:02,179 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2f4Q4n/profile http://localhost:34655/getInfo.html 10:44:05 INFO - 2016-02-09 10:44:05,786 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:44:05 INFO - 2016-02-09 10:44:05,786 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:44:05 INFO - 2016-02-09 10:44:05,786 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:44:05 INFO - 2016-02-09 10:44:05,786 DEBUG : BROWSER_OUTPUT: __metrics 10:44:05 INFO - 2016-02-09 10:44:05,944 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:44:07 INFO - 2016-02-09 10:44:07,109 INFO : Browser initialized. 10:44:07 INFO - 2016-02-09 10:44:07,110 INFO : Running cycle 1/1 for dromaeo_css test... 10:44:07 INFO - 2016-02-09 10:44:07,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2f4Q4n/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:44:18 INFO - 2016-02-09 10:44:18,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 132239360 10:44:18 INFO - 2016-02-09 10:44:18,788 DEBUG : BROWSER_OUTPUT: 10:45:09 INFO - 2016-02-09 10:45:09,610 DEBUG : BROWSER_OUTPUT: 1455043509608 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] 10:47:17 INFO - 2016-02-09 10:47:17,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34655/tests/dromaeo/cssquery-ext.html) 10:47:18 INFO - 2016-02-09 10:47:18,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 236056576 10:47:18 INFO - 2016-02-09 10:47:18,917 DEBUG : BROWSER_OUTPUT: 10:50:21 INFO - 2016-02-09 10:50:21,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-ext.html (next: http://localhost:34655/tests/dromaeo/cssquery-jquery.html) 10:50:21 INFO - 2016-02-09 10:50:21,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 207544320 10:50:21 INFO - 2016-02-09 10:50:21,627 DEBUG : BROWSER_OUTPUT: 10:53:23 INFO - 2016-02-09 10:53:23,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34655/tests/dromaeo/cssquery-mootools.html) 10:53:23 INFO - 2016-02-09 10:53:23,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 208142336 10:53:23 INFO - 2016-02-09 10:53:23,953 DEBUG : BROWSER_OUTPUT: 10:56:25 INFO - 2016-02-09 10:56:25,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34655/tests/dromaeo/cssquery-prototype.html) 10:56:26 INFO - 2016-02-09 10:56:26,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 196296704 10:56:26 INFO - 2016-02-09 10:56:26,190 DEBUG : BROWSER_OUTPUT: 10:59:28 INFO - 2016-02-09 10:59:28,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34655/tests/dromaeo/cssquery-yui.html) 10:59:29 INFO - 2016-02-09 10:59:29,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 198569984 10:59:29 INFO - 2016-02-09 10:59:29,137 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-yui.html (next: http://localhost:34655/tests/dromaeo/cssquery-dojo.html) 11:02:31 INFO - 2016-02-09 11:02:31,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 240521216 11:02:31 INFO - 2016-02-09 11:02:31,324 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,324 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:02:31 INFO - 2016-02-09 11:02:31,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:02:31 INFO - 2016-02-09 11:02:31,325 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:02:31 INFO - 2016-02-09 11:02:31,326 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:02:31 INFO - 2016-02-09 11:02:31,327 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3319.6016478022634;3388.2037721135544;3412.7099196568292;3413.948790768139;3436.793792372458;5535.861603459915;5553;5586.41342659021;5588.86027849304;5598.944010559898;5579.69311687857;5605.411431799654;5618.690971996539;5623.662580245188;5632.7746890124445;4954.925676114861;5049.4950504949575;5059.7976080956805;5095.5923526118;5143.922841157386;5012.899742005157;5047.772850221731;5107.744612769366;5112.437631860493;5112.718800465973;5037.848864534069;5095.108356037697;5129.769160387791;5142.768575414097;5146.305248791421;5152.046871328816;5212.765425555821;5225.9025604623075;5231.843044708646;5241.0042092002395;4914.729689867056;4959.479254678243;5129.897402051975;5136.101182293121;5193.272941788153;5191.922121168185;5277.947220527784;5285.603579731497;5285.894282114336;5294.338207724035;6028.5478589106;6038.516918646542;6087.665178415185;6088.908666370008;6098.32918378978;5844.53243740504;5972.163897054415;6047.939520604782;6107.236595425572;6116.785912493041;5655.773769049233;5700.7149642518125;5701.942980570183;5702.230198923092;5708.40061793514;6171.691415429211;6176.474999625082;6178.7219575119225;6180.196574445384;6189.473894718909;5617.129344951539;5694.829155125353;5770.221020162225;5898.557608179403;5906.822795316148;6016.2479690038745;6021.879562408815;6023.096535519707;6023.69881505923;6027.758889644453;5933.673647949404;5967.582269241198;5974.551908606785;5975.282966044103;5980.312264089685;5741.25363702716;5856.619319744203;5933.792317268875;6043.3352331244405;6060.969695151496;4620.630349572026;4622.275306061524;4623.468301145344;4630.444346678353;4637.489876113625;4037.6971727120585;4133.028738246509;4138.689598280141;4144.316187829035;4153.314703073959;5578.163275508625;5619.129034999582;5648.181013752983;5666.575006874501;5713.457221563945;6018.15745795589;6071.423214794588;6073.696315184311;6075.179850720185;6076.726547305382;5546.584006199551;5624.943750562524;5678.261825962599;5712.371639119693;5748;5170.146925757208;5200.427952925175;5213.2701421800975;5214.97392513035;5222.712750798667;6199.969000154971;6231.189945307081;6233.844153896189;6234.9688251559355;6236.469900058546;5833.766649333979;5925.555583331354;5942.851428714317;6055.333913269449;6062.393760623902;6173.783917562864;6174.104754810617;6176.166217560572;6180.196574445294;6180.567360284737;5905.261842269716;5937.376575459514;5944.8811023780145;5945.227120474311;5982.7307771149535;5833.67914764692;5919.200907877382;5943.791967281124;6004.219451471281;6052.848678783065;5950.910736339045;5961.105834124916;5984.850378740566;5991.970040149771;5993.760249589967;5922.644641321534;5940.3168635605725;5968.22413086296;5969.641821490724;5978.461938425563;5580;5679.9148012779015;5696.629719068247;5783.942160578508;5823.854403639943;5899.764009439746;5921.940780592311;5927.110933360031;5929.051351783866;5932.911006334994;5677.574181936288;5769.451902069297;5805.76776928935;5814.505767009851;5819.563532734977 11:02:31 INFO - 2016-02-09 11:02:31,330 DEBUG : BROWSER_OUTPUT: |1;ext.html;604.1964187630452;638.9776357827477;649.7043845050501;650.9877141045675;700.8878579427289;33100.83449582752;41329.58670413295;42025.57974420255;42048.15903681932;42196.78901605495;45202.54797452025;45461;45663.086738265214;45701;45780.54219457805;8222.095569487352;8361.83276334473;9239.168474837263;9420.105090016472;9428.387154834949;8230.50616962981;11105.55577776892;11335.943320283386;11350.262232954872;11360.545578176863;11048.447577621127;11164.385958772264;11169.664910052712;11169.7207569811;11173.776524469506;10970.286931349478;11049.337039777558;11052.336859788398;11053.336799792038;11060.446977651125;10827.187960902964;10968.341899486057;10972.835407468894;10979.451027448597;10979.945100274448;42775.57224427747;43036;43123.13753724939;43199;43270.35094473585;3612;3805.162864169878;4133.42132101506;4170.70805043644;4313.741175529478;32478.18804529882;32641.673583264102;32780.672193278;32844.83577582121;33119.6688033119;3714.387126124186;3731.160488889978;3838.7888666123354;3930.233604447134;4200.537940826506;276035;276141;280055;280128;280323;59857;60856.391436085956;64554.677226614505;65127;65190;76320;77947.61026194833;78138.60930695424;78192.2180778185;78290.2170978283;14158.433662653584;14241.572752817432;14279.286035698173;14289.857101428852;14322.069065510917;10524.473776311306;10561.049505544537;10580.312279701795;10585.153187745116;10628.46857657114;21739.239126630808;22095;22105.778942210694;22182.112715491523;22186.778132218795;8392.538410387488;8417.410781245255;8422;8482.575871206414;8537.914620853711;1074.5809134437575;1088.50473034769;1128.368113856243;1156.5662876421343;1160.9551403736536;28959.986400475882;28974.565381519293;29278.97523586664;29352.559711604343;30146.698533014827;1155.78040172367;1198.8021976373975;1216.3873296309946;1221.0109811053076;1265.0954567484293;13372.93313533426;15226.847731522765;15594.454194103151;15653;15666.207634465134;350614;354346;354971;355160;355227;48891.511084889404;50079.74960125176;51814.740926295126;53044.20433693498;55862.44137558654;1444.7317711193325;1455.992720036393;1475.1739026145392;1475.8966872318836;1480.3264514646025;26302;26506.602400963617;27063.86468067647;27431.588526171723;27662.723372766013;42813;43337.34993975156;43367.34948975831;43367.56632433762;43379.349309759746;265775;266117;266595;267777;268075;35093.29813403769;35102.64897351096;35432.46851297181;35538.933831984046;50024;45276.547234527236;45489.77255113703;45774;45861.541384587064;46411.76794116143;38041.4293785599;38237;38996.76214196762;39327;39428.605713942496;38793.224135517696;39364.21271574495;39539.209215814946;39909.20181596294;39924.00189995273;44705;44926.55073449224;45209;45753;45971.3104303429;34244.15470319258;34509.964701059005;34973.47539786956;34975.30049398947;35446.113847154025;26593.202203933914;26971.460570788866;27287.454250915267;27542.449151017267;28038.210415868536 11:02:31 INFO - 2016-02-09 11:02:31,331 DEBUG : BROWSER_OUTPUT: |2;jquery.html;388.90666240102365;389.75834982310954;393.3607887183327;396.3579002016733;399.78012093348656;17149.742753858685;18195.636087278246;18563.535911602215;18583.628327433442;18611.25554977801;16458.506244812645;16515.256813443393;16696.49910502684;16737;16743.497695069138;5448.128299472085;5695.316562012544;5703.7148142592705;5704.458076482748;5706.65760054396;5601.411851755568;5660.5471562275125;5687.118496633028;5689.260396148516;5691.345495268035;4241.1305682335205;4382.342648602703;5615.522680572136;6027.306859711123;6338.873222535546;6101.633901965896;6225.90661140081;6239.469645080174;6239.781607643756;6274.4353008229255;5617.43825617435;5628.662280263197;5629.831105066854;5630.296212973379;5632.2678051853;21917.671234931488;22171;22233.22183723562;22359.66460503094;22790.544189116124;2339.94150146246;2501.661611038104;2510.811689123305;2542.7457254274423;2590.5078035173256;13868.4452621895;14025.78961315581;14119.082259653089;14186.148831070066;14490;1739.5477175934222;1770.4688593422052;1855.6288742251604;1874.4751469588537;1889.4048374761906;63776;64889.3511064888;66147.66926165386;66574.66712666454;67368.3263167367;10796.596442462429;11040.227184097035;11084.113270938306;11178.27341222818;11191.832122518006;14907.776383354258;14918.477853275082;14982.550523484313;14986.700265994838;14987.400503979938;7440.925590744023;7455.85088298231;7486.812829679302;7521.962390188014;7591.240875912365;6095.05526643371;6141.140240366352;6142.262928448526;6162.661053642093;6721.4958878084335;6564.376384243489;6662.100616416722;6678.465722742169;6696.665166741741;6705.094812200388;1770.7783166082638;1836.6877630802796;1920.8271255587065;1960.362882063335;3030.3787723517066;455.49667617283086;465.6786817096193;933.6265493802533;1050.3750268590177;1078.4877183338008;10447.268691191544;11083.778324433466;11087.33475991443;11378.829317560243;11433.656990290305;446.91732029573984;454.18700526058643;460.8916904527433;464.1089108910899;486.90505351456125;5944.375840536768;5975.79084732041;6132;6171.13604095427;6189.288231853395;630788;648731;652072;659256;670186;84407.57796210979;85361;85441;85447.5727621358;85503;473.377508576228;475.77876287525777;475.93099000644713;476.38784162351214;477.0935223076183;10002.849957250794;10080.445575493419;10201.74495637615;10203.081722644998;10240.590376384862;36759;37051.25897482089;37458.81270593739;37586.24827503489;38065.23869522539;50742.74628626833;51133.48866511436;51186.74406627943;55696;55928.72035639796;10628.096611788085;10893.727656808644;14413.63965900819;14468;14535.127892326494;10867.402292873652;11124.443777811239;11754.529818807152;11764.411779411166;19605.509862252988;9994.350367226107;10078.387458006684;10188.89811101909;10312.381257124596;10322.535485903303;9972.102510774064;10046.196304295492;10053.849192262269;10176.185905127424;10433.634822781167;10118.139958103644;10224.437655928996;10262.948685256526;10274.229432792421;10435.16518678519;15858.920705396398;16031.599210019376;16064.919675401548;16209.027458352537;16240.269187886337;16471.25879335409;16579.585510362336;16613.41853035138;16897.74653380225;16990.49028529146 11:02:31 INFO - 2016-02-09 11:02:31,332 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1533.9002964807294;1718.467275144705;1796.209667746192;1819.0813639112246;1842.4564753397738;7142.678579463924;7616.200298968612;7620.009398778158;7621.047369078865;7623.237676232374;7734.071911370629;7792.571408572526;7825.373970082394;7832.530048197113;7836.373090152789;2331.895064722092;2350.612148995418;2358.870262135582;2382.475855311837;2386.8806559672034;2349.9647505287435;2357.4695693469002;2392.222527678503;2393.3059412770276;2396.604560247557;1990.9402717918485;2046.9283575074876;2289.107248173214;2302.666113413554;2336.158982766203;2283.5204607032542;2300.5513924784673;2302.8503147295455;2304.06685292456;2306.3657494189065;2292.094622624071;2342.800861926721;2353.341064501942;2354.281944007077;2356.32844639277;6815.7614483493335;6995.965020174917;7368.189499155143;7549.849003019964;7562.243775622449;4639.884002899921;4723.881902952419;4725.621950243973;4726.76366181693;4727.361806156159;3028.9848550757106;3035.104644129987;3058.4189004089153;3064.6628870824193;3142.104500217427;1012.3268026762195;1025.5385076715509;1044.070777008463;1045.7437927707683;1055.5672174408455;10487;10514.053735163796;10547.84178237327;10582.735431614194;10586.15310775144;4329.090890912944;4383.276759334738;4384.232759267179;4410.051838854662;4442.20040392726;9213.170814626716;9225.630974761069;9240.306976976754;9241.21449676785;9245.167934885892;4777.8327758528285;4807.351007613997;4808.8797780055775;4811.133995880775;4812.374391329105;4293.763842988603;4337.891552711144;4342.153280110411;4343.478782546114;4343.695941284143;3658.5243918290985;3717.9070523236596;3734.514513113332;3735.5704094029534;3755.9812200938823;1208.2327721896659;1213.2962881528692;1213.3993673131856;1216.5437960764714;1219.6279185915844;1386.8543802900751;1411.3014058041335;1411.329618431237;1414.9009569330049;1444.0469290268372;7369.410447164214;7572.734954276574;7624.19945905683;7633.503822251536;7645.541267523967;1182.148852825964;1186.175607952482;1194.2476239968937;1203.8047404794286;1228.342836582424;5648.491635752802;5876.647401155944;5898.911516327258;5915.733791979371;5920.348761636216;8697.652093916173;9313.953430232805;9417.434953902788;9429.3399462037;9443.763905902408;9112.589933453011;9309.581068851918;9334.766630834283;9344.95327523358;9541.809163816684;7492.550446973199;7567.394608431312;7571.886421703679;7573.318401343906;7578.014858068526;7302.306280903305;7504.249575042452;7506.099268087646;7560.924390756022;7564.546127232384;8401.15988401155;8573.828523429622;8673.91326086731;8676.696315629175;8736.91263087361;8602.225799678059;8693.261072808882;8750.737477875675;8780.03419623828;8982.191602755784;7035.859282814417;7113.3953613943395;7117.252688467844;7122.8219294515975;7124.3944264736;7328.633568321669;7537.982372379659;7540.434467414856;7597.924020759721;7636.885446718193;7100.538464999759;7224.566526008456;7254.310840470147;7278.708851646086;7326.523775954546;6835.282295359115;6879;6886.931130688629;6964.965175174092;7006.439484841098;6761.087253220752;6786.0838786765125;6786.355296246848;6788.219354774066;6798.626075565693;6386.840328991812;6456.677166141768;6459.547831651739;6474.838129046811;6476.0933469313395;6441.838954026187;6470.838229044123;6484;6488.448481879093;6492.123563318892 11:02:31 INFO - 2016-02-09 11:02:31,332 DEBUG : BROWSER_OUTPUT: |4;prototype.html;371.7843650682603;371.9088823238307;374.1432120444183;376.7814667492854;383.1379396358194;5916.556258280635;5990.430909063637;6000.3699611540815;6046.093086037096;6068.544859135566;5886.911696324559;6005.0692142717835;6040;6055.636661800295;6061.212042434478;4776.044791041805;4785.234362502;4785.282207668843;4787.8324258650955;4789.066132104241;4777.737224452654;4785.258284965836;4787.976060119695;4789.856304310859;4796.112719146951;4607.63138948885;4680.204365257898;4686.484486706459;4713.1987562114355;4744.6204303655795;4684.320773487825;4698.459677137122;4702.717836929795;4706.48228694845;4710.364100846393;3919.568847426781;4030.133521292936;4145.108801607669;4159.209750147493;4160.958390416117;5698.800541981011;5778.27771528559;5817.738201780888;5827.096799996008;5836.095405212199;5461.808836690737;5464.562834973192;5465.180222966547;5471.06991811393;5474.370447398521;6346.143270658448;6392.137061496732;6443.130177426035;6447.54867159299;6449.419552240321;4587.931181032287;4589.242774942164;4590.60979816716;4594.173048851206;4603.125406172817;6549.705263263117;6594.934050659528;6611.140551728245;6628.635425051621;6630.801075967729;4695.976520117446;4701.459332176775;4701.788419521062;4706.529347065266;4708.223143181337;4668.089722504147;4752.382190315237;4766.76166191689;4773.856784296477;4778.952210477851;5420.810271640553;5437.483439073281;5438.102713052381;5439.211314359396;5442.102053161263;6438;6441.5490915635455;6447.1296374989715;6451.258105317855;6453.225612926479;1673.2554013464135;1692;1693.144961794286;1693.2718930859849;1693.6443346897042;1146.6731981385433;1148.7185639518204;1149.7700459907885;1170;1179.8643156036994;6304.243490781136;6314.336994615591;6322.873542529123;6325.810225693236;6326.240851097806;6661.966690166518;6666.766663166766;6667.099941507931;6667.233268174125;6674.432673222734;6170.50635949123;6317.178766760292;6326.304106548276;6327.683615819191;6329.68351582419;3598.4962105305276;3648.069742215718;3648.6716195542;3650.2881938021833;3652.5251717276583;6587.571807832475;6686.331366863372;6709.597424154566;6783.966080169567;6943.132108486439;6883.8967415488805;6890.552114112566;6890.655467226718;6897.965510172417;6910.827229319308;6639.468842492589;6864.828379290558;6875.896861547081;6880.174379074543;6884.208316043719;6681.832954176184;6744.291849355944;6745.2242992056545;6747.190337159573;6753.054572359972;6646.767363142267;6647.069410282661;6653.63405012729;6659.234188068241;6660.267370589135;6791.3548212919695;6930.930690693231;6952.652367381712;6959.547629404073;6964.373206411447;4704.600108990774;4759.0719809636785;4763.333133361263;4768.284757286435;4768.666193366431;6668.166479190101;6704.396604305636;6706.128203333536;6709.597424154371;6714.328567143247;6364.6181229126405;6558.1802274715665;6566.6388348639375;6582.670866456754;6587.901181482186;6529.118568993125;6576.638284894186;6578.539502234989;6580.1116849224745;6594.274629790623;6427.935720642734;6471.191101112361;6471.514636402383;6474.5791523550815;6481.902771458526;6327.810165695037;6512.218533775977;6600.53796234259;6612.5040621952585;6613;6409;6416.615003099829;6417.101605775289;6418.614883107029;6423.357664233539 11:02:31 INFO - 2016-02-09 11:02:31,333 DEBUG : BROWSER_OUTPUT: |5;yui.html;853.5262929074369;875.5359659380531;948.0472125513858;954.923606111511;977.3647129365916;14238.216898070603;14688.926555367221;14776.926115369435;15876.682466350667;16112.274947627355;15704.136272505008;15715.921420392911;15871.206439677999;15873.603159921007;15881.285342159601;779.6140910249435;917.7843206846386;936.1901954809109;937.5452905340904;937.8030613571158;739.7706710919605;909.4770506958492;911.3802614222326;915.922146617535;918.1094338491653;966.2897770138942;978.2858513285306;978.9363691360074;979.7648564344577;980.4215512847419;798.9360851131895;806.5281810141016;965.4255717847905;965.8599503072086;970.7233438470003;725.2674798453547;725.5175308419895;726.6403130450408;727.5089314712601;727.9854402911965;13881.305934703225;13966.511172108927;14075.648108797259;14093.436262549485;14096;11827.172097953147;12507.437165327583;12531.624051278477;12776.744465110738;13061.281629510373;10110.69667909964;10145.08694217524;10174.236932230113;10291.176705863589;10523.947380263126;3662.633736626343;3720.21875406165;3740.5698344690436;3744.794036328001;3747.9437808432895;47657.76171119157;48112.27831582529;48616.27075593869;48789.26816097761;48818.51181488175;9301.255899528021;9377.390469619453;9662.613495460244;9694.95152524247;9744.707658770249;17777.822221777617;17811.198496067707;17833.197506112258;17846.643067138586;17936;7527.623618819037;7570.05374328209;7670.731524396731;7735.381169506426;7920.4059695523065;4420.071784925201;4421.889452763642;4435.689501734848;4452.8218871245435;4455.198064348384;3075.338802157547;3091.721745042957;3100.7209351158504;3104.6895310469226;3111.144435280271;549.3682265394748;566.7364675425947;575.4331982996745;581.9563532734977;587.2160665511504;570.9457601527848;577.650521434526;590.6397097770357;620.9689515524296;649.6199723162003;7444.404447644176;7960.203979602109;8058.879116813252;8086.454442825428;8236.670533178605;461.6652926628168;478.8324086569742;515.9664621799571;560.4311623701946;622.5144387377852;3829.6553310202216;3860.4209368594934;3923.4703315052675;3939.3106206413763;4020.1557672888434;59226;60346.698266509266;60700;60905.69547152236;61516.69241653853;52037;52715;53435;53441.732791335795;53575.73212133914;48413.5158648416;48500.5149948496;48534.514654853;48783.02433951301;49100;8516.40385173032;8599.65601375963;8599.699010534601;8838.690645827364;8847;34982;35627.287454250254;36201.818990904874;36290.27419451649;36639.63360366362;43004.139917202105;45444.772776135906;47547;47722.28416573685;48049.75975120102;10456.111230545488;10664.413457259925;10709.678709638723;11305.491252893475;11979;11275.66173014811;11414.657560273205;11535.653930382103;11597.130215233723;12006.939965300118;10041.397516148761;10190.745231369276;10344.689659310232;10475;10749.731256718333;10717.839232411365;10904.7273818152;10982.725431863948;11062.612808551663;11069.391183484986;10002.699919002442;10233.74415639615;10287.125594324267;10438.53026613789;10688.091512221237;9293.395929264576;9404.482753448627;9502.861856082327;9538.23694104456;9764.316497845082;9037.774055648399;9053.139951704577;9068.093190680878;9301.441913484941;9524.095210954949 11:02:31 INFO - 2016-02-09 11:02:31,333 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:02:31 INFO - 2016-02-09 11:02:31,333 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:02:31 INFO - 2016-02-09 11:02:31,333 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,762 11:02:31 INFO - 2016-02-09 11:02:31,333 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: __startTimestamp1455044551323__endTimestamp 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5574.47 Median:5769.45 stddev:617.46 (10.7%) stddev-sans-first:593.47 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: Values: 3319.6 3388.2 3412.7 3413.9 3436.8 5535.9 5553.0 5586.4 5588.9 5598.9 5579.7 5605.4 5618.7 5623.7 5632.8 4954.9 5049.5 5059.8 5095.6 5143.9 5012.9 5047.8 5107.7 5112.4 5112.7 5037.8 5095.1 5129.8 5142.8 5146.3 5152.0 5212.8 5225.9 5231.8 5241.0 4914.7 4959.5 5129.9 5136.1 5193.3 5191.9 5277.9 5285.6 5285.9 5294.3 6028.5 6038.5 6087.7 6088.9 6098.3 5844.5 5972.2 6047.9 6107.2 6116.8 5655.8 5700.7 5701.9 5702.2 5708.4 6171.7 6176.5 6178.7 6180.2 6189.5 5617.1 5694.8 5770.2 5898.6 5906.8 6016.2 6021.9 6023.1 6023.7 6027.8 5933.7 5967.6 5974.6 5975.3 5980.3 5741.3 5856.6 5933.8 6043.3 6061.0 4620.6 4622.3 4623.5 4630.4 4637.5 4037.7 4133.0 4138.7 4144.3 4153.3 5578.2 5619.1 5648.2 5666.6 5713.5 6018.2 6071.4 6073.7 6075.2 6076.7 5546.6 5624.9 5678.3 5712.4 5748.0 5170.1 5200.4 5213.3 5215.0 5222.7 6200.0 6231.2 6233.8 6235.0 6236.5 5833.8 5925.6 5942.9 6055.3 6062.4 6173.8 6174.1 6176.2 6180.2 6180.6 5905.3 5937.4 5944.9 5945.2 5982.7 5833.7 5919.2 5943.8 6004.2 6052.8 5950.9 5961.1 5984.9 5992.0 5993.8 5922.6 5940.3 5968.2 5969.6 5978.5 5580.0 5679.9 5696.6 5783.9 5823.9 5899.8 5921.9 5927.1 5929.1 5932.9 5677.6 5769.5 5805.8 5814.5 5819.6 11:02:31 INFO - 2016-02-09 11:02:31,334 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,335 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48853.18 Median:35097.97 stddev:79004.69 (225.1%) stddev-sans-first:79143.26 11:02:31 INFO - 2016-02-09 11:02:31,335 DEBUG : BROWSER_OUTPUT: Values: 604.2 639.0 649.7 651.0 700.9 33100.8 41329.6 42025.6 42048.2 42196.8 45202.5 45461.0 45663.1 45701.0 45780.5 8222.1 8361.8 9239.2 9420.1 9428.4 8230.5 11105.6 11335.9 11350.3 11360.5 11048.4 11164.4 11169.7 11169.7 11173.8 10970.3 11049.3 11052.3 11053.3 11060.4 10827.2 10968.3 10972.8 10979.5 10979.9 42775.6 43036.0 43123.1 43199.0 43270.4 3612.0 3805.2 4133.4 4170.7 4313.7 32478.2 32641.7 32780.7 32844.8 33119.7 3714.4 3731.2 3838.8 3930.2 4200.5 276035.0 276141.0 280055.0 280128.0 280323.0 59857.0 60856.4 64554.7 65127.0 65190.0 76320.0 77947.6 78138.6 78192.2 78290.2 14158.4 14241.6 14279.3 14289.9 14322.1 10524.5 10561.0 10580.3 10585.2 10628.5 21739.2 22095.0 22105.8 22182.1 22186.8 8392.5 8417.4 8422.0 8482.6 8537.9 1074.6 1088.5 1128.4 1156.6 1161.0 28960.0 28974.6 29279.0 29352.6 30146.7 1155.8 1198.8 1216.4 1221.0 1265.1 13372.9 15226.8 15594.5 15653.0 15666.2 350614.0 354346.0 354971.0 355160.0 355227.0 48891.5 50079.7 51814.7 53044.2 55862.4 1444.7 1456.0 1475.2 1475.9 1480.3 26302.0 26506.6 27063.9 27431.6 27662.7 42813.0 43337.3 43367.3 43367.6 43379.3 265775.0 266117.0 266595.0 267777.0 268075.0 35093.3 35102.6 35432.5 35538.9 50024.0 45276.5 45489.8 45774.0 45861.5 46411.8 38041.4 38237.0 38996.8 39327.0 39428.6 38793.2 39364.2 39539.2 39909.2 39924.0 44705.0 44926.6 45209.0 45753.0 45971.3 34244.2 34510.0 34973.5 34975.3 35446.1 26593.2 26971.5 27287.5 27542.4 28038.2 11:02:31 INFO - 2016-02-09 11:02:31,335 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,335 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32359.90 Median:36905.13 stddev:106634.05 (288.9%) stddev-sans-first:106906.16 11:02:31 INFO - 2016-02-09 11:02:31,336 DEBUG : BROWSER_OUTPUT: Values: 388.9 389.8 393.4 396.4 399.8 17149.7 18195.6 18563.5 18583.6 18611.3 16458.5 16515.3 16696.5 16737.0 16743.5 5448.1 5695.3 5703.7 5704.5 5706.7 5601.4 5660.5 5687.1 5689.3 5691.3 4241.1 4382.3 5615.5 6027.3 6338.9 6101.6 6225.9 6239.5 6239.8 6274.4 5617.4 5628.7 5629.8 5630.3 5632.3 21917.7 22171.0 22233.2 22359.7 22790.5 2339.9 2501.7 2510.8 2542.7 2590.5 13868.4 14025.8 14119.1 14186.1 14490.0 1739.5 1770.5 1855.6 1874.5 1889.4 63776.0 64889.4 66147.7 66574.7 67368.3 10796.6 11040.2 11084.1 11178.3 11191.8 14907.8 14918.5 14982.6 14986.7 14987.4 7440.9 7455.9 7486.8 7522.0 7591.2 6095.1 6141.1 6142.3 6162.7 6721.5 6564.4 6662.1 6678.5 6696.7 6705.1 1770.8 1836.7 1920.8 1960.4 3030.4 455.5 465.7 933.6 1050.4 1078.5 10447.3 11083.8 11087.3 11378.8 11433.7 446.9 454.2 460.9 464.1 486.9 5944.4 5975.8 6132.0 6171.1 6189.3 630788.0 648731.0 652072.0 659256.0 670186.0 84407.6 85361.0 85441.0 85447.6 85503.0 473.4 475.8 475.9 476.4 477.1 10002.8 10080.4 10201.7 10203.1 10240.6 36759.0 37051.3 37458.8 37586.2 38065.2 50742.7 51133.5 51186.7 55696.0 55928.7 10628.1 10893.7 14413.6 14468.0 14535.1 10867.4 11124.4 11754.5 11764.4 19605.5 9994.4 10078.4 10188.9 10312.4 10322.5 9972.1 10046.2 10053.8 10176.2 10433.6 10118.1 10224.4 10262.9 10274.2 10435.2 15858.9 16031.6 16064.9 16209.0 16240.3 16471.3 16579.6 16613.4 16897.7 16990.5 11:02:31 INFO - 2016-02-09 11:02:31,336 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,336 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5513.44 Median:6414.34 stddev:2798.19 (43.6%) stddev-sans-first:2790.05 11:02:31 INFO - 2016-02-09 11:02:31,337 DEBUG : BROWSER_OUTPUT: Values: 1533.9 1718.5 1796.2 1819.1 1842.5 7142.7 7616.2 7620.0 7621.0 7623.2 7734.1 7792.6 7825.4 7832.5 7836.4 2331.9 2350.6 2358.9 2382.5 2386.9 2350.0 2357.5 2392.2 2393.3 2396.6 1990.9 2046.9 2289.1 2302.7 2336.2 2283.5 2300.6 2302.9 2304.1 2306.4 2292.1 2342.8 2353.3 2354.3 2356.3 6815.8 6996.0 7368.2 7549.8 7562.2 4639.9 4723.9 4725.6 4726.8 4727.4 3029.0 3035.1 3058.4 3064.7 3142.1 1012.3 1025.5 1044.1 1045.7 1055.6 10487.0 10514.1 10547.8 10582.7 10586.2 4329.1 4383.3 4384.2 4410.1 4442.2 9213.2 9225.6 9240.3 9241.2 9245.2 4777.8 4807.4 4808.9 4811.1 4812.4 4293.8 4337.9 4342.2 4343.5 4343.7 3658.5 3717.9 3734.5 3735.6 3756.0 1208.2 1213.3 1213.4 1216.5 1219.6 1386.9 1411.3 1411.3 1414.9 1444.0 7369.4 7572.7 7624.2 7633.5 7645.5 1182.1 1186.2 1194.2 1203.8 1228.3 5648.5 5876.6 5898.9 5915.7 5920.3 8697.7 9314.0 9417.4 9429.3 9443.8 9112.6 9309.6 9334.8 9345.0 9541.8 7492.6 7567.4 7571.9 7573.3 7578.0 7302.3 7504.2 7506.1 7560.9 7564.5 8401.2 8573.8 8673.9 8676.7 8736.9 8602.2 8693.3 8750.7 8780.0 8982.2 7035.9 7113.4 7117.3 7122.8 7124.4 7328.6 7538.0 7540.4 7597.9 7636.9 7100.5 7224.6 7254.3 7278.7 7326.5 6835.3 6879.0 6886.9 6965.0 7006.4 6761.1 6786.1 6786.4 6788.2 6798.6 6386.8 6456.7 6459.5 6474.8 6476.1 6441.8 6470.8 6484.0 6488.4 6492.1 11:02:31 INFO - 2016-02-09 11:02:31,337 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,337 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5448.59 Median:6237.37 stddev:1610.21 (25.8%) stddev-sans-first:1568.99 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: Values: 371.8 371.9 374.1 376.8 383.1 5916.6 5990.4 6000.4 6046.1 6068.5 5886.9 6005.1 6040.0 6055.6 6061.2 4776.0 4785.2 4785.3 4787.8 4789.1 4777.7 4785.3 4788.0 4789.9 4796.1 4607.6 4680.2 4686.5 4713.2 4744.6 4684.3 4698.5 4702.7 4706.5 4710.4 3919.6 4030.1 4145.1 4159.2 4161.0 5698.8 5778.3 5817.7 5827.1 5836.1 5461.8 5464.6 5465.2 5471.1 5474.4 6346.1 6392.1 6443.1 6447.5 6449.4 4587.9 4589.2 4590.6 4594.2 4603.1 6549.7 6594.9 6611.1 6628.6 6630.8 4696.0 4701.5 4701.8 4706.5 4708.2 4668.1 4752.4 4766.8 4773.9 4779.0 5420.8 5437.5 5438.1 5439.2 5442.1 6438.0 6441.5 6447.1 6451.3 6453.2 1673.3 1692.0 1693.1 1693.3 1693.6 1146.7 1148.7 1149.8 1170.0 1179.9 6304.2 6314.3 6322.9 6325.8 6326.2 6662.0 6666.8 6667.1 6667.2 6674.4 6170.5 6317.2 6326.3 6327.7 6329.7 3598.5 3648.1 3648.7 3650.3 3652.5 6587.6 6686.3 6709.6 6784.0 6943.1 6883.9 6890.6 6890.7 6898.0 6910.8 6639.5 6864.8 6875.9 6880.2 6884.2 6681.8 6744.3 6745.2 6747.2 6753.1 6646.8 6647.1 6653.6 6659.2 6660.3 6791.4 6930.9 6952.7 6959.5 6964.4 4704.6 4759.1 4763.3 4768.3 4768.7 6668.2 6704.4 6706.1 6709.6 6714.3 6364.6 6558.2 6566.6 6582.7 6587.9 6529.1 6576.6 6578.5 6580.1 6594.3 6427.9 6471.2 6471.5 6474.6 6481.9 6327.8 6512.2 6600.5 6612.5 6613.0 6409.0 6416.6 6417.1 6418.6 6423.4 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14098.12 Median:48517.51 stddev:16591.59 (34.2%) stddev-sans-first:16608.32 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: Values: 853.5 875.5 948.0 954.9 977.4 14238.2 14688.9 14776.9 15876.7 16112.3 15704.1 15715.9 15871.2 15873.6 15881.3 779.6 917.8 936.2 937.5 937.8 739.8 909.5 911.4 915.9 918.1 966.3 978.3 978.9 979.8 980.4 798.9 806.5 965.4 965.9 970.7 725.3 725.5 726.6 727.5 728.0 13881.3 13966.5 14075.6 14093.4 14096.0 11827.2 12507.4 12531.6 12776.7 13061.3 10110.7 10145.1 10174.2 10291.2 10523.9 3662.6 3720.2 3740.6 3744.8 3747.9 47657.8 48112.3 48616.3 48789.3 48818.5 9301.3 9377.4 9662.6 9695.0 9744.7 17777.8 17811.2 17833.2 17846.6 17936.0 7527.6 7570.1 7670.7 7735.4 7920.4 4420.1 4421.9 4435.7 4452.8 4455.2 3075.3 3091.7 3100.7 3104.7 3111.1 549.4 566.7 575.4 582.0 587.2 570.9 577.7 590.6 621.0 649.6 7444.4 7960.2 8058.9 8086.5 8236.7 461.7 478.8 516.0 560.4 622.5 3829.7 3860.4 3923.5 3939.3 4020.2 59226.0 60346.7 60700.0 60905.7 61516.7 52037.0 52715.0 53435.0 53441.7 53575.7 48413.5 48500.5 48534.5 48783.0 49100.0 8516.4 8599.7 8599.7 8838.7 8847.0 34982.0 35627.3 36201.8 36290.3 36639.6 43004.1 45444.8 47547.0 47722.3 48049.8 10456.1 10664.4 10709.7 11305.5 11979.0 11275.7 11414.7 11535.7 11597.1 12006.9 10041.4 10190.7 10344.7 10475.0 10749.7 10717.8 10904.7 10982.7 11062.6 11069.4 10002.7 10233.7 10287.1 10438.5 10688.1 9293.4 9404.5 9502.9 9538.2 9764.3 9037.8 9053.1 9068.1 9301.4 9524.1 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:02:31 INFO - 2016-02-09 11:02:31,338 DEBUG : BROWSER_OUTPUT: 11:02:31 INFO - 2016-02-09 11:02:31,929 INFO : Browser exited with error code: 0 11:02:31 INFO - 2016-02-09 11:02:31,948 INFO : Completed test dromaeo_css (00:18:29) 11:02:31 INFO - 2016-02-09 11:02:31,948 INFO : Starting test kraken 11:02:31 INFO - 2016-02-09 11:02:31,948 DEBUG : operating with platform_type : linux_ 11:02:31 INFO - 2016-02-09 11:02:31,948 INFO : Initialising browser for kraken test... 11:02:31 INFO - 2016-02-09 11:02:31,955 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8EQ8B/profile http://localhost:34655/getInfo.html 11:02:35 INFO - 2016-02-09 11:02:35,717 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:02:35 INFO - 2016-02-09 11:02:35,718 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:02:35 INFO - 2016-02-09 11:02:35,718 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:02:35 INFO - 2016-02-09 11:02:35,718 DEBUG : BROWSER_OUTPUT: __metrics 11:02:35 INFO - 2016-02-09 11:02:35,866 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] 11:02:36 INFO - 2016-02-09 11:02:36,601 INFO : Browser initialized. 11:02:36 INFO - 2016-02-09 11:02:36,602 INFO : Running cycle 1/1 for kraken test... 11:02:36 INFO - 2016-02-09 11:02:36,602 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC8EQ8B/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:02:48 INFO - 2016-02-09 11:02:48,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 133799936 11:02:48 INFO - 2016-02-09 11:02:48,213 DEBUG : BROWSER_OUTPUT: 11:02:50 INFO - 2016-02-09 11:02:50,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-beat-detection) 11:02:51 INFO - 2016-02-09 11:02:51,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 164921344 11:02:51 INFO - 2016-02-09 11:02:51,233 DEBUG : BROWSER_OUTPUT: 11:02:53 INFO - 2016-02-09 11:02:53,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-dft) 11:02:54 INFO - 2016-02-09 11:02:54,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 161857536 11:02:54 INFO - 2016-02-09 11:02:54,363 DEBUG : BROWSER_OUTPUT: 11:02:57 INFO - 2016-02-09 11:02:57,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-fft) 11:02:57 INFO - 2016-02-09 11:02:57,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 160260096 11:02:57 INFO - 2016-02-09 11:02:57,724 DEBUG : BROWSER_OUTPUT: 11:02:59 INFO - 2016-02-09 11:02:59,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-oscillator) 11:03:00 INFO - 2016-02-09 11:03:00,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 159662080 11:03:00 INFO - 2016-02-09 11:03:00,275 DEBUG : BROWSER_OUTPUT: 11:03:02 INFO - 2016-02-09 11:03:02,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:03:03 INFO - 2016-02-09 11:03:03,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 159358976 11:03:03 INFO - 2016-02-09 11:03:03,002 DEBUG : BROWSER_OUTPUT: 11:03:05 INFO - 2016-02-09 11:03:05,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-darkroom) 11:03:06 INFO - 2016-02-09 11:03:06,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 158228480 11:03:06 INFO - 2016-02-09 11:03:06,420 DEBUG : BROWSER_OUTPUT: 11:03:09 INFO - 2016-02-09 11:03:09,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-desaturate) 11:03:10 INFO - 2016-02-09 11:03:10,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 160354304 11:03:10 INFO - 2016-02-09 11:03:10,329 DEBUG : BROWSER_OUTPUT: 11:03:13 INFO - 2016-02-09 11:03:13,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34655/tests/kraken/driver.html?testName=json-parse-financial) 11:03:13 INFO - 2016-02-09 11:03:13,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 160636928 11:03:13 INFO - 2016-02-09 11:03:13,607 DEBUG : BROWSER_OUTPUT: 11:03:15 INFO - 2016-02-09 11:03:15,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:03:15 INFO - 2016-02-09 11:03:15,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 167649280 11:03:15 INFO - 2016-02-09 11:03:15,728 DEBUG : BROWSER_OUTPUT: 11:03:17 INFO - 2016-02-09 11:03:17,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:03:18 INFO - 2016-02-09 11:03:18,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 163631104 11:03:18 INFO - 2016-02-09 11:03:18,148 DEBUG : BROWSER_OUTPUT: 11:03:20 INFO - 2016-02-09 11:03:20,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:03:20 INFO - 2016-02-09 11:03:20,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 170205184 11:03:20 INFO - 2016-02-09 11:03:20,716 DEBUG : BROWSER_OUTPUT: 11:03:23 INFO - 2016-02-09 11:03:23,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:03:23 INFO - 2016-02-09 11:03:23,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 176840704 11:03:23 INFO - 2016-02-09 11:03:23,664 DEBUG : BROWSER_OUTPUT: 11:03:26 INFO - 2016-02-09 11:03:26,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:03:26 INFO - 2016-02-09 11:03:26,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 174612480 11:03:26 INFO - 2016-02-09 11:03:26,711 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34655/tests/kraken/driver.html?testName=ai-astar) 11:03:28 INFO - 2016-02-09 11:03:28,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 231329792 11:03:28 INFO - 2016-02-09 11:03:28,614 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,614 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:03:28 INFO - 2016-02-09 11:03:28,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:03:28 INFO - 2016-02-09 11:03:28,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:03:28 INFO - 2016-02-09 11:03:28,615 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:03:28 INFO - 2016-02-09 11:03:28,615 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;103;108;109;111;97;109;110;109 11:03:28 INFO - 2016-02-09 11:03:28,615 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;121;155;157;138;153;154;121;159;120 11:03:28 INFO - 2016-02-09 11:03:28,615 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;159;160;161;161;160;161 11:03:28 INFO - 2016-02-09 11:03:28,615 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;73;166;77;71;70;71;153;73 11:03:28 INFO - 2016-02-09 11:03:28,616 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;134;92;92;93;134;92;93;136 11:03:28 INFO - 2016-02-09 11:03:28,616 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 11:03:28 INFO - 2016-02-09 11:03:28,616 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;144;146;145;145;145;146;146;145;146;146 11:03:28 INFO - 2016-02-09 11:03:28,616 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;56;57;58;57;59;57;54;54 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;68;65;65;65;64;65;65 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;76;78;80;78;78;76;85;78;77 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;115;114;111;117;115;114;112;119;116 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;144;141;142;140;131;141;160;139;132 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;66;63;64;65;62;65;64;65;63 11:03:28 INFO - 2016-02-09 11:03:28,617 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: __startTimestamp1455044608612__endTimestamp 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:03:28 INFO - 2016-02-09 11:03:28,618 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.60 Median:110.00 stddev:4.33 (3.9%) stddev-sans-first:4.50 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 103.0 108.0 109.0 111.0 97.0 109.0 110.0 109.0 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.60 Median:154.50 stddev:16.87 (10.9%) stddev-sans-first:17.07 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: Values: 158.0 121.0 155.0 157.0 138.0 153.0 154.0 121.0 159.0 120.0 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,619 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 11:03:28 INFO - 2016-02-09 11:03:28,620 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 159.0 160.0 161.0 161.0 160.0 161.0 11:03:28 INFO - 2016-02-09 11:03:28,620 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,620 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.70 Median:71.50 stddev:36.97 (51.7%) stddev-sans-first:38.58 11:03:28 INFO - 2016-02-09 11:03:28,620 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 166.0 77.0 71.0 70.0 71.0 153.0 73.0 11:03:28 INFO - 2016-02-09 11:03:28,620 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,621 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:92.00 stddev:20.48 (22.3%) stddev-sans-first:21.18 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 134.0 92.0 92.0 93.0 134.0 92.0 93.0 136.0 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 11:03:28 INFO - 2016-02-09 11:03:28,622 DEBUG : BROWSER_OUTPUT: Values: 144.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.67 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 56.0 57.0 58.0 57.0 59.0 57.0 54.0 54.0 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 11:03:28 INFO - 2016-02-09 11:03:28,623 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 68.0 65.0 65.0 65.0 64.0 65.0 65.0 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.70 (3.5%) stddev-sans-first:2.74 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 78.0 80.0 78.0 78.0 76.0 85.0 78.0 77.0 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:2.40 (2.1%) stddev-sans-first:2.44 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: Values: 117.0 115.0 114.0 111.0 117.0 115.0 114.0 112.0 119.0 116.0 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:141.00 stddev:7.87 (5.6%) stddev-sans-first:8.34 11:03:28 INFO - 2016-02-09 11:03:28,624 DEBUG : BROWSER_OUTPUT: Values: 141.0 144.0 141.0 142.0 140.0 131.0 141.0 160.0 139.0 132.0 11:03:28 INFO - 2016-02-09 11:03:28,625 DEBUG : BROWSER_OUTPUT: 11:03:28 INFO - 2016-02-09 11:03:28,625 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.50 stddev:1.37 (2.1%) stddev-sans-first:1.27 11:03:28 INFO - 2016-02-09 11:03:28,625 DEBUG : BROWSER_OUTPUT: Values: 62.0 66.0 63.0 64.0 65.0 62.0 65.0 64.0 65.0 63.0 11:03:28 INFO - 2016-02-09 11:03:28,625 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:03:28 INFO - 2016-02-09 11:03:28,625 DEBUG : BROWSER_OUTPUT: 11:03:29 INFO - 2016-02-09 11:03:29,321 INFO : Browser exited with error code: 0 11:03:29 INFO - 2016-02-09 11:03:29,374 INFO : Completed test kraken (00:00:57) 11:03:29 INFO - 2016-02-09 11:03:29,374 INFO : Starting test v8_7 11:03:29 INFO - 2016-02-09 11:03:29,375 DEBUG : operating with platform_type : linux_ 11:03:29 INFO - 2016-02-09 11:03:29,375 INFO : Initialising browser for v8_7 test... 11:03:29 INFO - 2016-02-09 11:03:29,381 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwtJwK4/profile http://localhost:34655/getInfo.html 11:03:32 INFO - 2016-02-09 11:03:32,954 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:03:32 INFO - 2016-02-09 11:03:32,955 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:03:32 INFO - 2016-02-09 11:03:32,955 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:03:32 INFO - 2016-02-09 11:03:32,955 DEBUG : BROWSER_OUTPUT: __metrics 11:03:33 INFO - 2016-02-09 11:03:33,079 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] 11:03:34 INFO - 2016-02-09 11:03:34,285 INFO : Browser initialized. 11:03:34 INFO - 2016-02-09 11:03:34,286 INFO : Running cycle 1/1 for v8_7 test... 11:03:34 INFO - 2016-02-09 11:03:34,286 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwtJwK4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:03:45 INFO - 2016-02-09 11:03:45,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 131928064 11:03:45 INFO - 2016-02-09 11:03:45,915 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34655/tests/v8_7/run.html (next: http://localhost:34655/tests/v8_7/run.html) 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 424890368 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:04:07 INFO - 2016-02-09 11:04:07,526 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |0;Richards;168.71941960519655 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.80998176090202 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |4;RayTrace;947.8672985781991 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |5;Earley;545.5537370430987 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |6;Boyer;10526.315789473685 11:04:07 INFO - 2016-02-09 11:04:07,527 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: |8;Splay;527.1481286241434 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: __startTimestamp1455044647519__endTimestamp 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.72 Median:168.72 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: Values: 168.7 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.81 Median:165.81 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,528 DEBUG : BROWSER_OUTPUT: Values: 165.8 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 278.4 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 5148.7 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:947.87 Median:947.87 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 947.9 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:545.55 Median:545.55 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 545.6 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10526.32 Median:10526.32 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: Values: 10526.3 11:04:07 INFO - 2016-02-09 11:04:07,529 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: Values: 24261.9 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.15 Median:527.15 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: Values: 527.1 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: Values: 4830.9 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:04:07 INFO - 2016-02-09 11:04:07,530 DEBUG : BROWSER_OUTPUT: 11:04:08 INFO - 2016-02-09 11:04:08,297 INFO : Browser exited with error code: 0 11:04:08 INFO - 2016-02-09 11:04:08,314 INFO : Completed test v8_7 (00:00:38) 11:04:08 INFO - 2016-02-09 11:04:08,582 INFO : Completed test suite (00:20:06) 11:04:08 INFO - 2016-02-09 11:04:08,582 DEBUG : Working with test: dromaeo_css 11:04:08 INFO - 2016-02-09 11:04:08,582 DEBUG : Generating results file: dromaeo_css 11:04:08 INFO - 2016-02-09 11:04:08,584 DEBUG : Working with test: kraken 11:04:08 INFO - 2016-02-09 11:04:08,584 DEBUG : Generating results file: kraken 11:04:08 INFO - 2016-02-09 11:04:08,584 INFO : javascript benchmark 11:04:08 INFO - 2016-02-09 11:04:08,584 DEBUG : Working with test: v8_7 11:04:08 INFO - 2016-02-09 11:04:08,585 DEBUG : Generating results file: v8_7 11:04:08 INFO - 2016-02-09 11:04:08,585 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:08 INFO - 2016-02-09 11:04:08,636 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 11:04:08 INFO - 2016-02-09 11:04:08,637 DEBUG : process_Request line: dromaeo_css 7194.06 graph.html#tests=[[72,53,35]] 11:04:08 INFO - 2016-02-09 11:04:08,637 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:08 INFO - 2016-02-09 11:04:08,668 DEBUG : process_Request line: kraken 1475.70 graph.html#tests=[[232,53,35]] 11:04:08 INFO - 2016-02-09 11:04:08,668 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:04:08 INFO - 2016-02-09 11:04:08,705 DEBUG : process_Request line: v8_7 23249.06 graph.html#tests=[[230,53,35]] 11:04:08 INFO - 2016-02-09 11:04:08,706 INFO : javascript benchmark 11:04:08 INFO - 2016-02-09 11:04:08,709 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.6016478022634, 3388.2037721135544, 3412.7099196568292, 3413.948790768139, 3436.793792372458, 5535.861603459915, 5553.0, 5586.41342659021, 5588.86027849304, 5598.944010559898, 5579.69311687857, 5605.411431799654, 5618.690971996539, 5623.662580245188, 5632.7746890124445, 4954.925676114861, 5049.4950504949575, 5059.7976080956805, 5095.5923526118, 5143.922841157386, 5012.899742005157, 5047.772850221731, 5107.744612769366, 5112.437631860493, 5112.718800465973, 5037.848864534069, 5095.108356037697, 5129.769160387791, 5142.768575414097, 5146.305248791421, 5152.046871328816, 5212.765425555821, 5225.9025604623075, 5231.843044708646, 5241.0042092002395, 4914.729689867056, 4959.479254678243, 5129.897402051975, 5136.101182293121, 5193.272941788153, 5191.922121168185, 5277.947220527784, 5285.603579731497, 5285.894282114336, 5294.338207724035, 6028.5478589106, 6038.516918646542, 6087.665178415185, 6088.908666370008, 6098.32918378978, 5844.53243740504, 5972.163897054415, 6047.939520604782, 6107.236595425572, 6116.785912493041, 5655.773769049233, 5700.7149642518125, 5701.942980570183, 5702.230198923092, 5708.40061793514, 6171.691415429211, 6176.474999625082, 6178.7219575119225, 6180.196574445384, 6189.473894718909, 5617.129344951539, 5694.829155125353, 5770.221020162225, 5898.557608179403, 5906.822795316148, 6016.2479690038745, 6021.879562408815, 6023.096535519707, 6023.69881505923, 6027.758889644453, 5933.673647949404, 5967.582269241198, 5974.551908606785, 5975.282966044103, 5980.312264089685, 5741.25363702716, 5856.619319744203, 5933.792317268875, 6043.3352331244405, 6060.969695151496, 4620.630349572026, 4622.275306061524, 4623.468301145344, 4630.444346678353, 4637.489876113625, 4037.6971727120585, 4133.028738246509, 4138.689598280141, 4144.316187829035, 4153.314703073959, 5578.163275508625, 5619.129034999582, 5648.181013752983, 5666.575006874501, 5713.457221563945, 6018.15745795589, 6071.423214794588, 6073.696315184311, 6075.179850720185, 6076.726547305382, 5546.584006199551, 5624.943750562524, 5678.261825962599, 5712.371639119693, 5748.0, 5170.146925757208, 5200.427952925175, 5213.2701421800975, 5214.97392513035, 5222.712750798667, 6199.969000154971, 6231.189945307081, 6233.844153896189, 6234.9688251559355, 6236.469900058546, 5833.766649333979, 5925.555583331354, 5942.851428714317, 6055.333913269449, 6062.393760623902, 6173.783917562864, 6174.104754810617, 6176.166217560572, 6180.196574445294, 6180.567360284737, 5905.261842269716, 5937.376575459514, 5944.8811023780145, 5945.227120474311, 5982.7307771149535, 5833.67914764692, 5919.200907877382, 5943.791967281124, 6004.219451471281, 6052.848678783065, 5950.910736339045, 5961.105834124916, 5984.850378740566, 5991.970040149771, 5993.760249589967, 5922.644641321534, 5940.3168635605725, 5968.22413086296, 5969.641821490724, 5978.461938425563, 5580.0, 5679.9148012779015, 5696.629719068247, 5783.942160578508, 5823.854403639943, 5899.764009439746, 5921.940780592311, 5927.110933360031, 5929.051351783866, 5932.911006334994, 5677.574181936288, 5769.451902069297, 5805.76776928935, 5814.505767009851, 5819.563532734977], "unit": "ms", "name": "dojo.html", "value": 5534.78852535269}, {"lowerIsBetter": false, "replicates": [604.1964187630452, 638.9776357827477, 649.7043845050501, 650.9877141045675, 700.8878579427289, 33100.83449582752, 41329.58670413295, 42025.57974420255, 42048.15903681932, 42196.78901605495, 45202.54797452025, 45461.0, 45663.086738265214, 45701.0, 45780.54219457805, 8222.095569487352, 8361.83276334473, 9239.168474837263, 9420.105090016472, 9428.387154834949, 8230.50616962981, 11105.55577776892, 11335.943320283386, 11350.262232954872, 11360.545578176863, 11048.447577621127, 11164.385958772264, 11169.664910052712, 11169.7207569811, 11173.776524469506, 10970.286931349478, 11049.337039777558, 11052.336859788398, 11053.336799792038, 11060.446977651125, 10827.187960902964, 10968.341899486057, 10972.835407468894, 10979.451027448597, 10979.945100274448, 42775.57224427747, 43036.0, 43123.13753724939, 43199.0, 43270.35094473585, 3612.0, 3805.162864169878, 4133.42132101506, 4170.70805043644, 4313.741175529478, 32478.18804529882, 32641.673583264102, 32780.672193278, 32844.83577582121, 33119.6688033119, 3714.387126124186, 3731.160488889978, 3838.7888666123354, 3930.233604447134, 4200.537940826506, 276035.0, 276141.0, 280055.0, 280128.0, 280323.0, 59857.0, 60856.391436085956, 64554.677226614505, 65127.0, 65190.0, 76320.0, 77947.61026194833, 78138.60930695424, 78192.2180778185, 78290.2170978283, 14158.433662653584, 14241.572752817432, 14279.286035698173, 14289.857101428852, 14322.069065510917, 10524.473776311306, 10561.049505544537, 10580.312279701795, 10585.153187745116, 10628.46857657114, 21739.239126630808, 22095.0, 22105.778942210694, 22182.112715491523, 22186.778132218795, 8392.538410387488, 8417.410781245255, 8422.0, 8482.575871206414, 8537.914620853711, 1074.5809134437575, 1088.50473034769, 1128.368113856243, 1156.5662876421343, 1160.9551403736536, 28959.986400475882, 28974.565381519293, 29278.97523586664, 29352.559711604343, 30146.698533014827, 1155.78040172367, 1198.8021976373975, 1216.3873296309946, 1221.0109811053076, 1265.0954567484293, 13372.93313533426, 15226.847731522765, 15594.454194103151, 15653.0, 15666.207634465134, 350614.0, 354346.0, 354971.0, 355160.0, 355227.0, 48891.511084889404, 50079.74960125176, 51814.740926295126, 53044.20433693498, 55862.44137558654, 1444.7317711193325, 1455.992720036393, 1475.1739026145392, 1475.8966872318836, 1480.3264514646025, 26302.0, 26506.602400963617, 27063.86468067647, 27431.588526171723, 27662.723372766013, 42813.0, 43337.34993975156, 43367.34948975831, 43367.56632433762, 43379.349309759746, 265775.0, 266117.0, 266595.0, 267777.0, 268075.0, 35093.29813403769, 35102.64897351096, 35432.46851297181, 35538.933831984046, 50024.0, 45276.547234527236, 45489.77255113703, 45774.0, 45861.541384587064, 46411.76794116143, 38041.4293785599, 38237.0, 38996.76214196762, 39327.0, 39428.605713942496, 38793.224135517696, 39364.21271574495, 39539.209215814946, 39909.20181596294, 39924.00189995273, 44705.0, 44926.55073449224, 45209.0, 45753.0, 45971.3104303429, 34244.15470319258, 34509.964701059005, 34973.47539786956, 34975.30049398947, 35446.113847154025, 26593.202203933914, 26971.460570788866, 27287.454250915267, 27542.449151017267, 28038.210415868536], "unit": "ms", "name": "ext.html", "value": 20052.69462800674}, {"lowerIsBetter": false, "replicates": [388.90666240102365, 389.75834982310954, 393.3607887183327, 396.3579002016733, 399.78012093348656, 17149.742753858685, 18195.636087278246, 18563.535911602215, 18583.628327433442, 18611.25554977801, 16458.506244812645, 16515.256813443393, 16696.49910502684, 16737.0, 16743.497695069138, 5448.128299472085, 5695.316562012544, 5703.7148142592705, 5704.458076482748, 5706.65760054396, 5601.411851755568, 5660.5471562275125, 5687.118496633028, 5689.260396148516, 5691.345495268035, 4241.1305682335205, 4382.342648602703, 5615.522680572136, 6027.306859711123, 6338.873222535546, 6101.633901965896, 6225.90661140081, 6239.469645080174, 6239.781607643756, 6274.4353008229255, 5617.43825617435, 5628.662280263197, 5629.831105066854, 5630.296212973379, 5632.2678051853, 21917.671234931488, 22171.0, 22233.22183723562, 22359.66460503094, 22790.544189116124, 2339.94150146246, 2501.661611038104, 2510.811689123305, 2542.7457254274423, 2590.5078035173256, 13868.4452621895, 14025.78961315581, 14119.082259653089, 14186.148831070066, 14490.0, 1739.5477175934222, 1770.4688593422052, 1855.6288742251604, 1874.4751469588537, 1889.4048374761906, 63776.0, 64889.3511064888, 66147.66926165386, 66574.66712666454, 67368.3263167367, 10796.596442462429, 11040.227184097035, 11084.113270938306, 11178.27341222818, 11191.832122518006, 14907.776383354258, 14918.477853275082, 14982.550523484313, 14986.700265994838, 14987.400503979938, 7440.925590744023, 7455.85088298231, 7486.812829679302, 7521.962390188014, 7591.240875912365, 6095.05526643371, 6141.140240366352, 6142.262928448526, 6162.661053642093, 6721.4958878084335, 6564.376384243489, 6662.100616416722, 6678.465722742169, 6696.665166741741, 6705.094812200388, 1770.7783166082638, 1836.6877630802796, 1920.8271255587065, 1960.362882063335, 3030.3787723517066, 455.49667617283086, 465.6786817096193, 933.6265493802533, 1050.3750268590177, 1078.4877183338008, 10447.268691191544, 11083.778324433466, 11087.33475991443, 11378.829317560243, 11433.656990290305, 446.91732029573984, 454.18700526058643, 460.8916904527433, 464.1089108910899, 486.90505351456125, 5944.375840536768, 5975.79084732041, 6132.0, 6171.13604095427, 6189.288231853395, 630788.0, 648731.0, 652072.0, 659256.0, 670186.0, 84407.57796210979, 85361.0, 85441.0, 85447.5727621358, 85503.0, 473.377508576228, 475.77876287525777, 475.93099000644713, 476.38784162351214, 477.0935223076183, 10002.849957250794, 10080.445575493419, 10201.74495637615, 10203.081722644998, 10240.590376384862, 36759.0, 37051.25897482089, 37458.81270593739, 37586.24827503489, 38065.23869522539, 50742.74628626833, 51133.48866511436, 51186.74406627943, 55696.0, 55928.72035639796, 10628.096611788085, 10893.727656808644, 14413.63965900819, 14468.0, 14535.127892326494, 10867.402292873652, 11124.443777811239, 11754.529818807152, 11764.411779411166, 19605.509862252988, 9994.350367226107, 10078.387458006684, 10188.89811101909, 10312.381257124596, 10322.535485903303, 9972.102510774064, 10046.196304295492, 10053.849192262269, 10176.185905127424, 10433.634822781167, 10118.139958103644, 10224.437655928996, 10262.948685256526, 10274.229432792421, 10435.16518678519, 15858.920705396398, 16031.599210019376, 16064.919675401548, 16209.027458352537, 16240.269187886337, 16471.25879335409, 16579.585510362336, 16613.41853035138, 16897.74653380225, 16990.49028529146], "unit": "ms", "name": "jquery.html", "value": 8615.327254297881}, {"lowerIsBetter": false, "replicates": [1533.9002964807294, 1718.467275144705, 1796.209667746192, 1819.0813639112246, 1842.4564753397738, 7142.678579463924, 7616.200298968612, 7620.009398778158, 7621.047369078865, 7623.237676232374, 7734.071911370629, 7792.571408572526, 7825.373970082394, 7832.530048197113, 7836.373090152789, 2331.895064722092, 2350.612148995418, 2358.870262135582, 2382.475855311837, 2386.8806559672034, 2349.9647505287435, 2357.4695693469002, 2392.222527678503, 2393.3059412770276, 2396.604560247557, 1990.9402717918485, 2046.9283575074876, 2289.107248173214, 2302.666113413554, 2336.158982766203, 2283.5204607032542, 2300.5513924784673, 2302.8503147295455, 2304.06685292456, 2306.3657494189065, 2292.094622624071, 2342.800861926721, 2353.341064501942, 2354.281944007077, 2356.32844639277, 6815.7614483493335, 6995.965020174917, 7368.189499155143, 7549.849003019964, 7562.243775622449, 4639.884002899921, 4723.881902952419, 4725.621950243973, 4726.76366181693, 4727.361806156159, 3028.9848550757106, 3035.104644129987, 3058.4189004089153, 3064.6628870824193, 3142.104500217427, 1012.3268026762195, 1025.5385076715509, 1044.070777008463, 1045.7437927707683, 1055.5672174408455, 10487.0, 10514.053735163796, 10547.84178237327, 10582.735431614194, 10586.15310775144, 4329.090890912944, 4383.276759334738, 4384.232759267179, 4410.051838854662, 4442.20040392726, 9213.170814626716, 9225.630974761069, 9240.306976976754, 9241.21449676785, 9245.167934885892, 4777.8327758528285, 4807.351007613997, 4808.8797780055775, 4811.133995880775, 4812.374391329105, 4293.763842988603, 4337.891552711144, 4342.153280110411, 4343.478782546114, 4343.695941284143, 3658.5243918290985, 3717.9070523236596, 3734.514513113332, 3735.5704094029534, 3755.9812200938823, 1208.2327721896659, 1213.2962881528692, 1213.3993673131856, 1216.5437960764714, 1219.6279185915844, 1386.8543802900751, 1411.3014058041335, 1411.329618431237, 1414.9009569330049, 1444.0469290268372, 7369.410447164214, 7572.734954276574, 7624.19945905683, 7633.503822251536, 7645.541267523967, 1182.148852825964, 1186.175607952482, 1194.2476239968937, 1203.8047404794286, 1228.342836582424, 5648.491635752802, 5876.647401155944, 5898.911516327258, 5915.733791979371, 5920.348761636216, 8697.652093916173, 9313.953430232805, 9417.434953902788, 9429.3399462037, 9443.763905902408, 9112.589933453011, 9309.581068851918, 9334.766630834283, 9344.95327523358, 9541.809163816684, 7492.550446973199, 7567.394608431312, 7571.886421703679, 7573.318401343906, 7578.014858068526, 7302.306280903305, 7504.249575042452, 7506.099268087646, 7560.924390756022, 7564.546127232384, 8401.15988401155, 8573.828523429622, 8673.91326086731, 8676.696315629175, 8736.91263087361, 8602.225799678059, 8693.261072808882, 8750.737477875675, 8780.03419623828, 8982.191602755784, 7035.859282814417, 7113.3953613943395, 7117.252688467844, 7122.8219294515975, 7124.3944264736, 7328.633568321669, 7537.982372379659, 7540.434467414856, 7597.924020759721, 7636.885446718193, 7100.538464999759, 7224.566526008456, 7254.310840470147, 7278.708851646086, 7326.523775954546, 6835.282295359115, 6879.0, 6886.931130688629, 6964.965175174092, 7006.439484841098, 6761.087253220752, 6786.0838786765125, 6786.355296246848, 6788.219354774066, 6798.626075565693, 6386.840328991812, 6456.677166141768, 6459.547831651739, 6474.838129046811, 6476.0933469313395, 6441.838954026187, 6470.838229044123, 6484.0, 6488.448481879093, 6492.123563318892], "unit": "ms", "name": "mootools.html", "value": 4580.913457193509}, {"lowerIsBetter": false, "replicates": [371.7843650682603, 371.9088823238307, 374.1432120444183, 376.7814667492854, 383.1379396358194, 5916.556258280635, 5990.430909063637, 6000.3699611540815, 6046.093086037096, 6068.544859135566, 5886.911696324559, 6005.0692142717835, 6040.0, 6055.636661800295, 6061.212042434478, 4776.044791041805, 4785.234362502, 4785.282207668843, 4787.8324258650955, 4789.066132104241, 4777.737224452654, 4785.258284965836, 4787.976060119695, 4789.856304310859, 4796.112719146951, 4607.63138948885, 4680.204365257898, 4686.484486706459, 4713.1987562114355, 4744.6204303655795, 4684.320773487825, 4698.459677137122, 4702.717836929795, 4706.48228694845, 4710.364100846393, 3919.568847426781, 4030.133521292936, 4145.108801607669, 4159.209750147493, 4160.958390416117, 5698.800541981011, 5778.27771528559, 5817.738201780888, 5827.096799996008, 5836.095405212199, 5461.808836690737, 5464.562834973192, 5465.180222966547, 5471.06991811393, 5474.370447398521, 6346.143270658448, 6392.137061496732, 6443.130177426035, 6447.54867159299, 6449.419552240321, 4587.931181032287, 4589.242774942164, 4590.60979816716, 4594.173048851206, 4603.125406172817, 6549.705263263117, 6594.934050659528, 6611.140551728245, 6628.635425051621, 6630.801075967729, 4695.976520117446, 4701.459332176775, 4701.788419521062, 4706.529347065266, 4708.223143181337, 4668.089722504147, 4752.382190315237, 4766.76166191689, 4773.856784296477, 4778.952210477851, 5420.810271640553, 5437.483439073281, 5438.102713052381, 5439.211314359396, 5442.102053161263, 6438.0, 6441.5490915635455, 6447.1296374989715, 6451.258105317855, 6453.225612926479, 1673.2554013464135, 1692.0, 1693.144961794286, 1693.2718930859849, 1693.6443346897042, 1146.6731981385433, 1148.7185639518204, 1149.7700459907885, 1170.0, 1179.8643156036994, 6304.243490781136, 6314.336994615591, 6322.873542529123, 6325.810225693236, 6326.240851097806, 6661.966690166518, 6666.766663166766, 6667.099941507931, 6667.233268174125, 6674.432673222734, 6170.50635949123, 6317.178766760292, 6326.304106548276, 6327.683615819191, 6329.68351582419, 3598.4962105305276, 3648.069742215718, 3648.6716195542, 3650.2881938021833, 3652.5251717276583, 6587.571807832475, 6686.331366863372, 6709.597424154566, 6783.966080169567, 6943.132108486439, 6883.8967415488805, 6890.552114112566, 6890.655467226718, 6897.965510172417, 6910.827229319308, 6639.468842492589, 6864.828379290558, 6875.896861547081, 6880.174379074543, 6884.208316043719, 6681.832954176184, 6744.291849355944, 6745.2242992056545, 6747.190337159573, 6753.054572359972, 6646.767363142267, 6647.069410282661, 6653.63405012729, 6659.234188068241, 6660.267370589135, 6791.3548212919695, 6930.930690693231, 6952.652367381712, 6959.547629404073, 6964.373206411447, 4704.600108990774, 4759.0719809636785, 4763.333133361263, 4768.284757286435, 4768.666193366431, 6668.166479190101, 6704.396604305636, 6706.128203333536, 6709.597424154371, 6714.328567143247, 6364.6181229126405, 6558.1802274715665, 6566.6388348639375, 6582.670866456754, 6587.901181482186, 6529.118568993125, 6576.638284894186, 6578.539502234989, 6580.1116849224745, 6594.274629790623, 6427.935720642734, 6471.191101112361, 6471.514636402383, 6474.5791523550815, 6481.902771458526, 6327.810165695037, 6512.218533775977, 6600.53796234259, 6612.5040621952585, 6613.0, 6409.0, 6416.615003099829, 6417.101605775289, 6418.614883107029, 6423.357664233539], "unit": "ms", "name": "prototype.html", "value": 4938.175286065174}, {"lowerIsBetter": false, "replicates": [853.5262929074369, 875.5359659380531, 948.0472125513858, 954.923606111511, 977.3647129365916, 14238.216898070603, 14688.926555367221, 14776.926115369435, 15876.682466350667, 16112.274947627355, 15704.136272505008, 15715.921420392911, 15871.206439677999, 15873.603159921007, 15881.285342159601, 779.6140910249435, 917.7843206846386, 936.1901954809109, 937.5452905340904, 937.8030613571158, 739.7706710919605, 909.4770506958492, 911.3802614222326, 915.922146617535, 918.1094338491653, 966.2897770138942, 978.2858513285306, 978.9363691360074, 979.7648564344577, 980.4215512847419, 798.9360851131895, 806.5281810141016, 965.4255717847905, 965.8599503072086, 970.7233438470003, 725.2674798453547, 725.5175308419895, 726.6403130450408, 727.5089314712601, 727.9854402911965, 13881.305934703225, 13966.511172108927, 14075.648108797259, 14093.436262549485, 14096.0, 11827.172097953147, 12507.437165327583, 12531.624051278477, 12776.744465110738, 13061.281629510373, 10110.69667909964, 10145.08694217524, 10174.236932230113, 10291.176705863589, 10523.947380263126, 3662.633736626343, 3720.21875406165, 3740.5698344690436, 3744.794036328001, 3747.9437808432895, 47657.76171119157, 48112.27831582529, 48616.27075593869, 48789.26816097761, 48818.51181488175, 9301.255899528021, 9377.390469619453, 9662.613495460244, 9694.95152524247, 9744.707658770249, 17777.822221777617, 17811.198496067707, 17833.197506112258, 17846.643067138586, 17936.0, 7527.623618819037, 7570.05374328209, 7670.731524396731, 7735.381169506426, 7920.4059695523065, 4420.071784925201, 4421.889452763642, 4435.689501734848, 4452.8218871245435, 4455.198064348384, 3075.338802157547, 3091.721745042957, 3100.7209351158504, 3104.6895310469226, 3111.144435280271, 549.3682265394748, 566.7364675425947, 575.4331982996745, 581.9563532734977, 587.2160665511504, 570.9457601527848, 577.650521434526, 590.6397097770357, 620.9689515524296, 649.6199723162003, 7444.404447644176, 7960.203979602109, 8058.879116813252, 8086.454442825428, 8236.670533178605, 461.6652926628168, 478.8324086569742, 515.9664621799571, 560.4311623701946, 622.5144387377852, 3829.6553310202216, 3860.4209368594934, 3923.4703315052675, 3939.3106206413763, 4020.1557672888434, 59226.0, 60346.698266509266, 60700.0, 60905.69547152236, 61516.69241653853, 52037.0, 52715.0, 53435.0, 53441.732791335795, 53575.73212133914, 48413.5158648416, 48500.5149948496, 48534.514654853, 48783.02433951301, 49100.0, 8516.40385173032, 8599.65601375963, 8599.699010534601, 8838.690645827364, 8847.0, 34982.0, 35627.287454250254, 36201.818990904874, 36290.27419451649, 36639.63360366362, 43004.139917202105, 45444.772776135906, 47547.0, 47722.28416573685, 48049.75975120102, 10456.111230545488, 10664.413457259925, 10709.678709638723, 11305.491252893475, 11979.0, 11275.66173014811, 11414.657560273205, 11535.653930382103, 11597.130215233723, 12006.939965300118, 10041.397516148761, 10190.745231369276, 10344.689659310232, 10475.0, 10749.731256718333, 10717.839232411365, 10904.7273818152, 10982.725431863948, 11062.612808551663, 11069.391183484986, 10002.699919002442, 10233.74415639615, 10287.125594324267, 10438.53026613789, 10688.091512221237, 9293.395929264576, 9404.482753448627, 9502.861856082327, 9538.23694104456, 9764.316497845082, 9037.774055648399, 9053.139951704577, 9068.093190680878, 9301.441913484941, 9524.095210954949], "unit": "ms", "name": "yui.html", "value": 6408.255549193848}], "name": "dromaeo_css", "value": 7194.05575795703}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 103.0, 108.0, 109.0, 111.0, 97.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [158.0, 121.0, 155.0, 157.0, 138.0, 153.0, 154.0, 121.0, 159.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 166.0, 77.0, 71.0, 70.0, 71.0, 153.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 134.0, 92.0, 92.0, 93.0, 134.0, 92.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 57.0, 59.0, 57.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 68.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 78.0, 80.0, 78.0, 78.0, 76.0, 85.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 114.0, 111.0, 117.0, 115.0, 114.0, 112.0, 119.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.0}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 141.0, 142.0, 140.0, 131.0, 141.0, 160.0, 139.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [62.0, 66.0, 63.0, 64.0, 65.0, 62.0, 65.0, 64.0, 65.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1475.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.71941960519655], "unit": "score", "name": "Richards", "value": 209.234954}, {"lowerIsBetter": false, "replicates": [165.80998176090202], "unit": "score", "name": "DeltaBlue", "value": 398.7576580000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [947.8672985781991], "unit": "score", "name": "RayTrace", "value": 780.6883950000001}, {"lowerIsBetter": false, "replicates": [545.5537370430987], "unit": "score", "name": "Earley", "value": 1221.626679}, {"lowerIsBetter": false, "replicates": [10526.315789473685], "unit": "score", "name": "Boyer", "value": 63.313984999999995}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [527.1481286241434], "unit": "score", "name": "Splay", "value": 154.588427}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23249.06369668853}]} 11:04:08 INFO - RETURN: dromaeo_css: 7194.06 11:04:08 INFO - RETURN: kraken: 1475.70 11:04:08 INFO - RETURN: v8_7: 23249.06 11:04:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23249.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7194.06"}}} 11:04:08 INFO - Return code: 0 11:04:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:04:08 INFO - # TBPL SUCCESS # 11:04:08 INFO - Running post-action listener: _resource_record_post_action 11:04:08 INFO - Running post-run listener: _resource_record_post_run 11:04:09 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 319488; Write bytes: 506134528; Read time: 76; Write time: 370996 11:04:09 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239329280; Read time: 0; Write time: 238624 11:04:09 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 319488; Write bytes: 259919872; Read time: 76; Write time: 129992 11:04:09 INFO - Running post-run listener: _upload_blobber_files 11:04:09 INFO - Blob upload gear active. 11:04:09 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:04:09 INFO - Copying logs to upload dir... 11:04:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1253.275423 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-02-09 11:04:09.891892) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:04:09.895221) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010165 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455034796/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 11:04:09.945762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:04:09.946137) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455043395.33798-179962077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 11:04:09.995739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:04:09.996101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 11:04:09.996426) ========= ========= Total master_lag: 0.29 =========