builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1463007512.81 results: success (0) buildid: 20160511133016 builduid: 46a5a9b0eb66406fa30856d2c9f2b2e7 revision: 1532576c0435896ff83448c0e1eb0d38e0c07f33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.811778) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.812196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.812497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.822282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.822593) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 15:58:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 187M=0s 2016-05-11 15:58:33 (187 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.939036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.939313) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009576 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:32.984832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 15:58:32.985133) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1532576c0435896ff83448c0e1eb0d38e0c07f33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1532576c0435896ff83448c0e1eb0d38e0c07f33 --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 15:58:33,399 truncating revision to first 12 chars 2016-05-11 15:58:33,399 Setting DEBUG logging. 2016-05-11 15:58:33,399 attempt 1/10 2016-05-11 15:58:33,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1532576c0435?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 15:58:34,742 unpacking tar archive at: mozilla-inbound-1532576c0435/testing/mozharness/ program finished with exit code 0 elapsedTime=1.587615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 15:58:34.580996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:34.581300) ========= script_repo_revision: 1532576c0435896ff83448c0e1eb0d38e0c07f33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:34.581723) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:34.582008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 15:58:34.588225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-11 15:58:34.588577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:35 INFO - MultiFileLogger online at 20160511 15:58:35 in /builds/slave/test 15:58:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:58:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:35 INFO - {'append_to_log': False, 15:58:35 INFO - 'base_work_dir': '/builds/slave/test', 15:58:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:58:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:35 INFO - 'branch': 'Mozilla-Inbound', 15:58:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:35 INFO - 'config_files': ('talos/linux_config.py',), 15:58:35 INFO - 'default_actions': ('clobber', 15:58:35 INFO - 'read-buildbot-config', 15:58:35 INFO - 'download-and-extract', 15:58:35 INFO - 'populate-webroot', 15:58:35 INFO - 'create-virtualenv', 15:58:35 INFO - 'install', 15:58:35 INFO - 'run-tests'), 15:58:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:35 INFO - 'download_minidump_stackwalk': True, 15:58:35 INFO - 'download_symbols': 'ondemand', 15:58:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:35 INFO - 'installer_path': 'installer.exe', 15:58:35 INFO - 'log_level': 'info', 15:58:35 INFO - 'log_name': 'talos', 15:58:35 INFO - 'log_to_console': True, 15:58:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:35 INFO - 'opt_config_files': (), 15:58:35 INFO - 'pip_index': False, 15:58:35 INFO - 'sps_profile': False, 15:58:35 INFO - 'sps_profile_interval': 0, 15:58:35 INFO - 'suite': 'dromaeojs-e10s', 15:58:35 INFO - 'system_bits': '32', 15:58:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:35 INFO - 'title': 'talos-linux64-ix-026', 15:58:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:35 INFO - 'use_talos_json': True, 15:58:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:35 INFO - 'work_dir': 'build'} 15:58:35 INFO - ##### 15:58:35 INFO - ##### Running clobber step. 15:58:35 INFO - ##### 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: clobber 15:58:35 INFO - rmtree: /builds/slave/test/build 15:58:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - ##### 15:58:35 INFO - ##### Finished clobber step (success) 15:58:35 INFO - ##### 15:58:35 INFO - ##### 15:58:35 INFO - ##### Running read-buildbot-config step. 15:58:35 INFO - ##### 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: read_buildbot_config 15:58:35 INFO - Using buildbot properties: 15:58:35 INFO - { 15:58:35 INFO - "project": "", 15:58:35 INFO - "product": "firefox", 15:58:35 INFO - "script_repo_revision": "production", 15:58:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:58:35 INFO - "repository": "", 15:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:58:35 INFO - "buildid": "20160511133016", 15:58:35 INFO - "pgo_build": "True", 15:58:35 INFO - "basedir": "/builds/slave/test", 15:58:35 INFO - "buildnumber": 649, 15:58:35 INFO - "slavename": "talos-linux64-ix-026", 15:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:58:35 INFO - "platform": "ubuntu64_hw", 15:58:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:58:35 INFO - "branch": "mozilla-inbound", 15:58:35 INFO - "repo_path": "integration/mozilla-inbound", 15:58:35 INFO - "revision": "1532576c0435896ff83448c0e1eb0d38e0c07f33", 15:58:35 INFO - "stage_platform": "linux64-pgo", 15:58:35 INFO - "builduid": "46a5a9b0eb66406fa30856d2c9f2b2e7", 15:58:35 INFO - "slavebuilddir": "test" 15:58:35 INFO - } 15:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:58:35 INFO - Running post-action listener: _resource_record_post_action 15:58:35 INFO - ##### 15:58:35 INFO - ##### Finished read-buildbot-config step (success) 15:58:35 INFO - ##### 15:58:35 INFO - ##### 15:58:35 INFO - ##### Running download-and-extract step. 15:58:35 INFO - ##### 15:58:35 INFO - Running pre-action listener: _resource_record_pre_action 15:58:35 INFO - Running main action method: download_and_extract 15:58:35 INFO - mkdir: /builds/slave/test/build/tests 15:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:35 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:58:36 INFO - Downloaded 1361 bytes. 15:58:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:58:36 INFO - Using the following test package requirements: 15:58:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'jsshell-linux-x86_64.zip'], 15:58:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58: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')]} 15:58:36 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:37 INFO - Downloaded 23902591 bytes. 15:58:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:58:39 INFO - Return code: 0 15:58:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:39 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:58:41 INFO - Downloaded 23902591 bytes. 15:58:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:58:43 INFO - Return code: 0 15:58: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')]} 15:58:43 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:58:44 INFO - Downloaded 10840239 bytes. 15:58:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:58:44 INFO - Return code: 0 15:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:44 INFO - https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:58:46 INFO - Downloaded 58330979 bytes. 15:58:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:46 INFO - mkdir: /builds/slave/test/properties 15:58:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:46 INFO - Contents: 15:58:46 INFO - build_url:https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:58:46 INFO - Running post-action listener: _resource_record_post_action 15:58:46 INFO - Running post-action listener: set_extra_try_arguments 15:58:46 INFO - ##### 15:58:46 INFO - ##### Finished download-and-extract step (success) 15:58:46 INFO - ##### 15:58:46 INFO - ##### 15:58:46 INFO - ##### Running populate-webroot step. 15:58:46 INFO - ##### 15:58:46 INFO - Running pre-action listener: _resource_record_pre_action 15:58:46 INFO - Running main action method: populate_webroot 15:58:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:46 INFO - '--tppagecycles', 15:58:46 INFO - '7'], 15:58:46 INFO - 'tests': ['tsvgm']}}, 15:58:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:58:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:58:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:58:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['damp', 'tps']}, 15:58:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'tests': ['damp', 'tps']}, 15:58:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['dromaeo_dom']}, 15:58:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['a11yr', 15:58:46 INFO - 'ts_paint', 15:58:46 INFO - 'tpaint', 15:58:46 INFO - 'sessionrestore', 15:58:46 INFO - 'sessionrestore_no_auto_restore', 15:58:46 INFO - 'tabpaint']}, 15:58:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['tsvgx', 15:58:46 INFO - 'tsvgr_opacity', 15:58:46 INFO - 'tart', 15:58:46 INFO - 'tscrollx', 15:58:46 INFO - 'cart']}, 15:58:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:58:46 INFO - 'tsvgr_opacity', 15:58:46 INFO - 'tart', 15:58:46 INFO - 'tscrollx', 15:58:46 INFO - 'cart']}, 15:58:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'talos_options': ['--disable-e10s'], 15:58:46 INFO - 'tests': ['tp5o']}, 15:58:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'tests': ['tp5o']}, 15:58:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'talos_options': ['--disable-e10s', 15:58:46 INFO - '--xperf_path', 15:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:46 INFO - 'tests': ['tp5n']}, 15:58:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:46 INFO - 'talos_options': ['--xperf_path', 15:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:46 INFO - 'tests': ['tp5n']}}, 15:58:46 INFO - 'talos.zip': {'path': '', 15:58:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:46 INFO - Running post-action listener: _resource_record_post_action 15:58:46 INFO - ##### 15:58:46 INFO - ##### Finished populate-webroot step (success) 15:58:46 INFO - ##### 15:58:46 INFO - ##### 15:58:46 INFO - ##### Running create-virtualenv step. 15:58:46 INFO - ##### 15:58:46 INFO - Running pre-action listener: _resource_record_pre_action 15:58:46 INFO - Running main action method: create_virtualenv 15:58:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:58:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:47 INFO - Using real prefix '/usr' 15:58:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:49 INFO - Installing pip.................done. 15:58:49 INFO - Return code: 0 15:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:58:49 INFO - Running command: ['/builds/slave/test/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/build 15:58:49 INFO - Copy/paste: /builds/slave/test/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 15:58:49 INFO - Using env: {'DISPLAY': ':0', 15:58:49 INFO - 'HOME': '/home/cltbld', 15:58:49 INFO - 'LANG': 'en_US.UTF-8', 15:58:49 INFO - 'LANGUAGE': 'en_US:en', 15:58:49 INFO - 'LOGNAME': 'cltbld', 15:58:49 INFO - 'MAIL': '/var/mail/cltbld', 15:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:49 INFO - 'MOZ_NO_REMOTE': '1', 15:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:49 INFO - 'NO_EM_RESTART': '1', 15:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:49 INFO - 'PWD': '/builds/slave/test', 15:58:49 INFO - 'SHELL': '/bin/bash', 15:58:49 INFO - 'SHLVL': '1', 15:58:49 INFO - 'TERM': 'linux', 15:58:49 INFO - 'TMOUT': '86400', 15:58:49 INFO - 'USER': 'cltbld', 15:58:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:49 INFO - '_': '/tools/buildbot/bin/python'} 15:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:58:49 INFO - Cleaning up... 15:58:49 INFO - Return code: 0 15:58:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:58:49 INFO - Running command: ['/builds/slave/test/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/build 15:58:49 INFO - Copy/paste: /builds/slave/test/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 15:58:49 INFO - Using env: {'DISPLAY': ':0', 15:58:49 INFO - 'HOME': '/home/cltbld', 15:58:49 INFO - 'LANG': 'en_US.UTF-8', 15:58:49 INFO - 'LANGUAGE': 'en_US:en', 15:58:49 INFO - 'LOGNAME': 'cltbld', 15:58:49 INFO - 'MAIL': '/var/mail/cltbld', 15:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:49 INFO - 'MOZ_NO_REMOTE': '1', 15:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:49 INFO - 'NO_EM_RESTART': '1', 15:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:49 INFO - 'PWD': '/builds/slave/test', 15:58:49 INFO - 'SHELL': '/bin/bash', 15:58:49 INFO - 'SHLVL': '1', 15:58:49 INFO - 'TERM': 'linux', 15:58:49 INFO - 'TMOUT': '86400', 15:58:49 INFO - 'USER': 'cltbld', 15:58:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:49 INFO - '_': '/tools/buildbot/bin/python'} 15:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:49 INFO - Downloading/unpacking psutil>=0.7.1 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:51 INFO - Installing collected packages: psutil 15:58:51 INFO - Running setup.py install for psutil 15:58:51 INFO - building 'psutil._psutil_linux' extension 15:58:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:58:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:58:52 INFO - building 'psutil._psutil_posix' extension 15:58:52 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 15:58:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:52 INFO - Successfully installed psutil 15:58:52 INFO - Cleaning up... 15:58:52 INFO - Return code: 0 15:58:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:58:52 INFO - Running command: ['/builds/slave/test/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/build 15:58:52 INFO - Copy/paste: /builds/slave/test/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 15:58:52 INFO - Using env: {'DISPLAY': ':0', 15:58:52 INFO - 'HOME': '/home/cltbld', 15:58:52 INFO - 'LANG': 'en_US.UTF-8', 15:58:52 INFO - 'LANGUAGE': 'en_US:en', 15:58:52 INFO - 'LOGNAME': 'cltbld', 15:58:52 INFO - 'MAIL': '/var/mail/cltbld', 15:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:52 INFO - 'MOZ_NO_REMOTE': '1', 15:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:52 INFO - 'NO_EM_RESTART': '1', 15:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:52 INFO - 'PWD': '/builds/slave/test', 15:58:52 INFO - 'SHELL': '/bin/bash', 15:58:52 INFO - 'SHLVL': '1', 15:58:52 INFO - 'TERM': 'linux', 15:58:52 INFO - 'TMOUT': '86400', 15:58:52 INFO - 'USER': 'cltbld', 15:58:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:52 INFO - '_': '/tools/buildbot/bin/python'} 15:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:58:54 INFO - Installing collected packages: mozsystemmonitor 15:58:54 INFO - Running setup.py install for mozsystemmonitor 15:58:54 INFO - Successfully installed mozsystemmonitor 15:58:54 INFO - Cleaning up... 15:58:54 INFO - Return code: 0 15:58:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:58:54 INFO - Running command: ['/builds/slave/test/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/build 15:58:54 INFO - Copy/paste: /builds/slave/test/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 15:58:54 INFO - Using env: {'DISPLAY': ':0', 15:58:54 INFO - 'HOME': '/home/cltbld', 15:58:54 INFO - 'LANG': 'en_US.UTF-8', 15:58:54 INFO - 'LANGUAGE': 'en_US:en', 15:58:54 INFO - 'LOGNAME': 'cltbld', 15:58:54 INFO - 'MAIL': '/var/mail/cltbld', 15:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:54 INFO - 'MOZ_NO_REMOTE': '1', 15:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:54 INFO - 'NO_EM_RESTART': '1', 15:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:54 INFO - 'PWD': '/builds/slave/test', 15:58:54 INFO - 'SHELL': '/bin/bash', 15:58:54 INFO - 'SHLVL': '1', 15:58:54 INFO - 'TERM': 'linux', 15:58:54 INFO - 'TMOUT': '86400', 15:58:54 INFO - 'USER': 'cltbld', 15:58:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:54 INFO - '_': '/tools/buildbot/bin/python'} 15:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:54 INFO - Downloading/unpacking blobuploader==1.2.4 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:58:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 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 15:58:57 INFO - Downloading docopt-0.6.1.tar.gz 15:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:58:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:58:57 INFO - Running setup.py install for blobuploader 15:58:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:58:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:58:57 INFO - Running setup.py install for requests 15:58:57 INFO - Running setup.py install for docopt 15:58:57 INFO - Successfully installed blobuploader requests docopt 15:58:57 INFO - Cleaning up... 15:58:57 INFO - Return code: 0 15:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 15:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 15:58:57 INFO - Using env: {'DISPLAY': ':0', 15:58:57 INFO - 'HOME': '/home/cltbld', 15:58:57 INFO - 'LANG': 'en_US.UTF-8', 15:58:57 INFO - 'LANGUAGE': 'en_US:en', 15:58:57 INFO - 'LOGNAME': 'cltbld', 15:58:57 INFO - 'MAIL': '/var/mail/cltbld', 15:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:57 INFO - 'MOZ_NO_REMOTE': '1', 15:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:57 INFO - 'NO_EM_RESTART': '1', 15:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:57 INFO - 'PWD': '/builds/slave/test', 15:58:57 INFO - 'SHELL': '/bin/bash', 15:58:57 INFO - 'SHLVL': '1', 15:58:57 INFO - 'TERM': 'linux', 15:58:57 INFO - 'TMOUT': '86400', 15:58:57 INFO - 'USER': 'cltbld', 15:58:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:57 INFO - '_': '/tools/buildbot/bin/python'} 15:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:58:58 INFO - Running setup.py (path:/tmp/pip-b_gizB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:58:58 INFO - Running setup.py (path:/tmp/pip-LNTMzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:58:58 INFO - Running setup.py (path:/tmp/pip-SPDldJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:58:58 INFO - Running setup.py (path:/tmp/pip-n15kfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:58:58 INFO - Running setup.py (path:/tmp/pip-O5WOoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:58:58 INFO - Running setup.py (path:/tmp/pip-lviFZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:58:58 INFO - Running setup.py (path:/tmp/pip-WZN8Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:58:58 INFO - Running setup.py (path:/tmp/pip-L24w8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:58:58 INFO - Running setup.py (path:/tmp/pip-z4oeKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:58:58 INFO - Running setup.py (path:/tmp/pip-uA2ODb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:58:58 INFO - Running setup.py (path:/tmp/pip-OOEtfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:58:58 INFO - Running setup.py (path:/tmp/pip-xwoHMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:58:58 INFO - Running setup.py (path:/tmp/pip-su22nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:58:58 INFO - Running setup.py (path:/tmp/pip-DVbezi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:58 INFO - Running setup.py (path:/tmp/pip-K5xUzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:58:58 INFO - Running setup.py (path:/tmp/pip-YzkqNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:58:58 INFO - Running setup.py (path:/tmp/pip-z7yv1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:58:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:58:58 INFO - Running setup.py install for manifestparser 15:58:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for mozcrash 15:58:59 INFO - Running setup.py install for mozdebug 15:58:59 INFO - Running setup.py install for mozdevice 15:58:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for mozfile 15:58:59 INFO - Running setup.py install for mozhttpd 15:58:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for mozinfo 15:58:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for mozInstall 15:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for mozleak 15:58:59 INFO - Running setup.py install for mozlog 15:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:58:59 INFO - Running setup.py install for moznetwork 15:59:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Running setup.py install for mozprocess 15:59:00 INFO - Running setup.py install for mozprofile 15:59:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Running setup.py install for mozrunner 15:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Running setup.py install for mozscreenshot 15:59:00 INFO - Running setup.py install for moztest 15:59:00 INFO - Running setup.py install for mozversion 15:59:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:00 INFO - Cleaning up... 15:59:00 INFO - Return code: 0 15:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 15:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 15:59:00 INFO - Using env: {'DISPLAY': ':0', 15:59:00 INFO - 'HOME': '/home/cltbld', 15:59:00 INFO - 'LANG': 'en_US.UTF-8', 15:59:00 INFO - 'LANGUAGE': 'en_US:en', 15:59:00 INFO - 'LOGNAME': 'cltbld', 15:59:00 INFO - 'MAIL': '/var/mail/cltbld', 15:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:00 INFO - 'MOZ_NO_REMOTE': '1', 15:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:00 INFO - 'NO_EM_RESTART': '1', 15:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:00 INFO - 'PWD': '/builds/slave/test', 15:59:00 INFO - 'SHELL': '/bin/bash', 15:59:00 INFO - 'SHLVL': '1', 15:59:00 INFO - 'TERM': 'linux', 15:59:00 INFO - 'TMOUT': '86400', 15:59:00 INFO - 'USER': 'cltbld', 15:59:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:00 INFO - '_': '/tools/buildbot/bin/python'} 15:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:00 INFO - Running setup.py (path:/tmp/pip-2rk2Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:00 INFO - Running setup.py (path:/tmp/pip-ygyV4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:00 INFO - Running setup.py (path:/tmp/pip-aPuUAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:00 INFO - Running setup.py (path:/tmp/pip-avPvdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Running setup.py (path:/tmp/pip-QKiB8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Running setup.py (path:/tmp/pip-ytFDHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:01 INFO - Running setup.py (path:/tmp/pip-8vuzr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:01 INFO - Running setup.py (path:/tmp/pip-fAieeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:01 INFO - Running setup.py (path:/tmp/pip-wyvpnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:01 INFO - Running setup.py (path:/tmp/pip-UgeV7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:01 INFO - Running setup.py (path:/tmp/pip-DFTsSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:01 INFO - Running setup.py (path:/tmp/pip-l_2Gn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:01 INFO - Running setup.py (path:/tmp/pip-nAzxX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:01 INFO - Running setup.py (path:/tmp/pip-nxb3g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:01 INFO - Running setup.py (path:/tmp/pip-y1JLUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:01 INFO - Running setup.py (path:/tmp/pip-DDik8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:01 INFO - Running setup.py (path:/tmp/pip-QBL2X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:01 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 15:59:01 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 15:59:01 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 15:59:01 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 15:59:01 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 15:59:01 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 15:59:03 INFO - Downloading blessings-1.6.tar.gz 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:03 INFO - Installing collected packages: blessings 15:59:03 INFO - Running setup.py install for blessings 15:59:03 INFO - Successfully installed blessings 15:59:03 INFO - Cleaning up... 15:59:03 INFO - Return code: 0 15:59:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:04 INFO - Reading from file tmpfile_stdout 15:59:04 INFO - Current package versions: 15:59:04 INFO - argparse == 1.2.1 15:59:04 INFO - blessings == 1.6 15:59:04 INFO - blobuploader == 1.2.4 15:59:04 INFO - docopt == 0.6.1 15:59:04 INFO - manifestparser == 1.1 15:59:04 INFO - mozInstall == 1.12 15:59:04 INFO - mozcrash == 0.17 15:59:04 INFO - mozdebug == 0.1 15:59:04 INFO - mozdevice == 0.48 15:59:04 INFO - mozfile == 1.2 15:59:04 INFO - mozhttpd == 0.7 15:59:04 INFO - mozinfo == 0.9 15:59:04 INFO - mozleak == 0.1 15:59:04 INFO - mozlog == 3.2 15:59:04 INFO - moznetwork == 0.27 15:59:04 INFO - mozprocess == 0.22 15:59:04 INFO - mozprofile == 0.28 15:59:04 INFO - mozrunner == 6.11 15:59:04 INFO - mozscreenshot == 0.1 15:59:04 INFO - mozsystemmonitor == 0.0 15:59:04 INFO - moztest == 0.7 15:59:04 INFO - mozversion == 1.4 15:59:04 INFO - psutil == 3.1.1 15:59:04 INFO - requests == 1.2.3 15:59:04 INFO - wsgiref == 0.1.2 15:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 15:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 15:59:04 INFO - Using env: {'DISPLAY': ':0', 15:59:04 INFO - 'HOME': '/home/cltbld', 15:59:04 INFO - 'LANG': 'en_US.UTF-8', 15:59:04 INFO - 'LANGUAGE': 'en_US:en', 15:59:04 INFO - 'LOGNAME': 'cltbld', 15:59:04 INFO - 'MAIL': '/var/mail/cltbld', 15:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:04 INFO - 'MOZ_NO_REMOTE': '1', 15:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:04 INFO - 'NO_EM_RESTART': '1', 15:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:04 INFO - 'PWD': '/builds/slave/test', 15:59:04 INFO - 'SHELL': '/bin/bash', 15:59:04 INFO - 'SHLVL': '1', 15:59:04 INFO - 'TERM': 'linux', 15:59:04 INFO - 'TMOUT': '86400', 15:59:04 INFO - 'USER': 'cltbld', 15:59:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:04 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:04 INFO - Cleaning up... 15:59:04 INFO - Return code: 0 15:59:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:59:04 INFO - Running command: ['/builds/slave/test/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/build 15:59:04 INFO - Copy/paste: /builds/slave/test/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 15:59:04 INFO - Using env: {'DISPLAY': ':0', 15:59:04 INFO - 'HOME': '/home/cltbld', 15:59:04 INFO - 'LANG': 'en_US.UTF-8', 15:59:04 INFO - 'LANGUAGE': 'en_US:en', 15:59:04 INFO - 'LOGNAME': 'cltbld', 15:59:04 INFO - 'MAIL': '/var/mail/cltbld', 15:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:04 INFO - 'MOZ_NO_REMOTE': '1', 15:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:04 INFO - 'NO_EM_RESTART': '1', 15:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:04 INFO - 'PWD': '/builds/slave/test', 15:59:04 INFO - 'SHELL': '/bin/bash', 15:59:04 INFO - 'SHLVL': '1', 15:59:04 INFO - 'TERM': 'linux', 15:59:04 INFO - 'TMOUT': '86400', 15:59:04 INFO - 'USER': 'cltbld', 15:59:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:04 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Downloading/unpacking jsonschema 15:59:04 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 15:59:04 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 15:59:04 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 15:59:04 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 15:59:04 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 15:59:04 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 15:59:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:06 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:06 INFO - warning: no files found matching '*.txt' 15:59:06 INFO - no previously-included directories found matching 'build' 15:59:06 INFO - no previously-included directories found matching 'dist' 15:59:06 INFO - no previously-included directories found matching '.git*' 15:59:06 INFO - Installing collected packages: jsonschema, functools32 15:59:06 INFO - Running setup.py install for functools32 15:59:06 INFO - warning: no files found matching '*.txt' 15:59:06 INFO - no previously-included directories found matching 'build' 15:59:06 INFO - no previously-included directories found matching 'dist' 15:59:06 INFO - no previously-included directories found matching '.git*' 15:59:06 INFO - Successfully installed jsonschema functools32 15:59:06 INFO - Cleaning up... 15:59:06 INFO - Return code: 0 15:59:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59:06 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')]} 15:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:06 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')]} 15:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7fe6e82eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x227a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2345770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 15:59:06 INFO - Running command: ['/builds/slave/test/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/build 15:59:06 INFO - Copy/paste: /builds/slave/test/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 15:59:06 INFO - Using env: {'DISPLAY': ':0', 15:59:06 INFO - 'HOME': '/home/cltbld', 15:59:06 INFO - 'LANG': 'en_US.UTF-8', 15:59:06 INFO - 'LANGUAGE': 'en_US:en', 15:59:06 INFO - 'LOGNAME': 'cltbld', 15:59:06 INFO - 'MAIL': '/var/mail/cltbld', 15:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:06 INFO - 'MOZ_NO_REMOTE': '1', 15:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:06 INFO - 'NO_EM_RESTART': '1', 15:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:06 INFO - 'PWD': '/builds/slave/test', 15:59:06 INFO - 'SHELL': '/bin/bash', 15:59:06 INFO - 'SHLVL': '1', 15:59:06 INFO - 'TERM': 'linux', 15:59:06 INFO - 'TMOUT': '86400', 15:59:06 INFO - 'USER': 'cltbld', 15:59:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:06 INFO - '_': '/tools/buildbot/bin/python'} 15:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:06 INFO - Downloading/unpacking flake8 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:06 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 15:59:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:09 INFO - no previously-included directories found matching 'docs/_build' 15:59:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:09 INFO - Running setup.py install for pep8 15:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:09 INFO - no previously-included directories found matching 'docs/_build' 15:59:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:09 INFO - Cleaning up... 15:59:09 INFO - Return code: 0 15:59:09 INFO - Running post-action listener: _resource_record_post_action 15:59:09 INFO - Running post-action listener: _start_resource_monitoring 15:59:09 INFO - Starting resource monitoring. 15:59:09 INFO - ##### 15:59:09 INFO - ##### Finished create-virtualenv step (success) 15:59:09 INFO - ##### 15:59:09 INFO - ##### 15:59:09 INFO - ##### Running install step. 15:59:09 INFO - ##### 15:59:09 INFO - Running pre-action listener: _resource_record_pre_action 15:59:09 INFO - Running main action method: install 15:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:09 INFO - Reading from file tmpfile_stdout 15:59:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:09 INFO - Reading from file tmpfile_stdout 15:59:09 INFO - Output received: 15:59:09 INFO - Usage: mozinstall [options] installer 15:59:09 INFO - Options: 15:59:09 INFO - -h, --help show this help message and exit 15:59:09 INFO - -d DEST, --destination=DEST 15:59:09 INFO - Directory to install application into. [default: 15:59:09 INFO - "/builds/slave/test"] 15:59:09 INFO - --app=APP Application being installed. [default: firefox] 15:59:09 INFO - mkdir: /builds/slave/test/build/application 15:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:59:26 INFO - Reading from file tmpfile_stdout 15:59:26 INFO - Output received: 15:59:26 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - ##### 15:59:26 INFO - ##### Finished install step (success) 15:59:26 INFO - ##### 15:59:26 INFO - ##### 15:59:26 INFO - ##### Running run-tests step. 15:59:26 INFO - ##### 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: run_tests 15:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:26 INFO - Python 2.7.3 15:59:26 INFO - Return code: 0 15:59:26 INFO - grabbing minidump binary from tooltool 15:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:26 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/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d49c0>, '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 0x23d58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:59:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:59:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:59:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:26 INFO - Return code: 0 15:59:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:59:27 INFO - Return code: 0 15:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:59:27 INFO - Using env: {'DISPLAY': ':0', 15:59:27 INFO - 'HOME': '/home/cltbld', 15:59:27 INFO - 'LANG': 'en_US.UTF-8', 15:59:27 INFO - 'LANGUAGE': 'en_US:en', 15:59:27 INFO - 'LOGNAME': 'cltbld', 15:59:27 INFO - 'MAIL': '/var/mail/cltbld', 15:59:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:27 INFO - 'MOZ_NO_REMOTE': '1', 15:59:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:27 INFO - 'NO_EM_RESTART': '1', 15:59:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:27 INFO - 'PWD': '/builds/slave/test', 15:59:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:27 INFO - 'SHELL': '/bin/bash', 15:59:27 INFO - 'SHLVL': '1', 15:59:27 INFO - 'TERM': 'linux', 15:59:27 INFO - 'TMOUT': '86400', 15:59:27 INFO - 'USER': 'cltbld', 15:59:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697', 15:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:27 INFO - '_': '/tools/buildbot/bin/python'} 15:59:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:59:27 INFO - mozversion application_buildid: 20160511133016 15:59:27 INFO - mozversion application_changeset: 1532576c0435896ff83448c0e1eb0d38e0c07f33 15:59:27 INFO - mozversion application_display_name: Nightly 15:59:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:27 INFO - mozversion application_name: Firefox 15:59:27 INFO - mozversion application_remotingname: firefox 15:59:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:27 INFO - mozversion application_vendor: Mozilla 15:59:27 INFO - mozversion application_version: 49.0a1 15:59:27 INFO - mozversion platform_buildid: 20160511133016 15:59:27 INFO - mozversion platform_changeset: 1532576c0435896ff83448c0e1eb0d38e0c07f33 15:59:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:27 INFO - mozversion platform_version: 49.0a1 15:59:27 INFO - using testdate: 1463007567 15:59:27 INFO - actual date: 1463007567 15:59:27 INFO - starting webserver on 'localhost:53827' 15:59:27 INFO - SUITE-START | Running 2 tests 15:59:27 INFO - TEST-START | dromaeo_css 15:59:27 INFO - operating with platform_type : linux_ 15:59:27 INFO - Initialising browser for dromaeo_css test... 15:59:27 INFO - TEST-INFO | started process 18626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt4nvfe/profile http://localhost:53827/getInfo.html) 15:59:31 INFO - PROCESS | 18626 | 15:59:31 INFO - PROCESS | 18626 | (process:18695): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:59:32 INFO - PROCESS | 18626 | __metrics Screen width/height:1600/1200 15:59:32 INFO - PROCESS | 18626 | colorDepth:24 15:59:32 INFO - PROCESS | 18626 | Browser inner width/height: 1024/697 15:59:32 INFO - PROCESS | 18626 | __metrics 15:59:32 ERROR - PROCESS | 18626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:59:33 INFO - TEST-INFO | 18626: exit 0 15:59:33 INFO - Browser initialized. 15:59:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:33 INFO - TEST-INFO | started process 18746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt4nvfe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:34 INFO - PROCESS | 18746 | 15:59:34 INFO - PROCESS | 18746 | (process:18807): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:59:44 INFO - PROCESS | 18746 | RSS: Main: 161824768 15:59:44 INFO - PROCESS | 18746 | 16:00:34 INFO - PROCESS | 18746 | 1463007634458 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] 16:02:41 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53827/tests/dromaeo/cssquery-ext.html) 16:02:42 INFO - PROCESS | 18746 | RSS: Main: 164569088 16:02:42 INFO - PROCESS | 18746 | 16:05:44 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-ext.html (next: http://localhost:53827/tests/dromaeo/cssquery-jquery.html) 16:05:45 INFO - PROCESS | 18746 | RSS: Main: 165703680 16:05:45 INFO - PROCESS | 18746 | 16:08:47 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53827/tests/dromaeo/cssquery-mootools.html) 16:08:47 INFO - PROCESS | 18746 | RSS: Main: 166518784 16:08:47 INFO - PROCESS | 18746 | 16:11:49 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53827/tests/dromaeo/cssquery-prototype.html) 16:11:50 INFO - PROCESS | 18746 | RSS: Main: 164388864 16:11:50 INFO - PROCESS | 18746 | 16:14:52 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53827/tests/dromaeo/cssquery-yui.html) 16:14:53 INFO - PROCESS | 18746 | RSS: Main: 166002688 16:14:53 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | Cycle 1(1): loaded http://localhost:53827/tests/dromaeo/cssquery-yui.html (next: http://localhost:53827/tests/dromaeo/cssquery-dojo.html) 16:17:55 INFO - PROCESS | 18746 | RSS: Main: 167415808 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | __start_tp_report 16:17:55 INFO - PROCESS | 18746 | _x_x_mozilla_page_load 16:17:55 INFO - PROCESS | 18746 | _x_x_mozilla_page_load_details 16:17:55 INFO - PROCESS | 18746 | |i|pagename|runs| 16:17:55 INFO - PROCESS | 18746 | |0;dojo.html;3109.720125188734;3120.7815452918276;3130.4052230076286;3141.32461520773;3165.8575364108615;5237.86905327367;5287.762050707718;5334.706591137486;5356.625036247464;5384.43463436339;5146.665466744668;5292.2061690746405;5299.682019078858;5314.973425132869;5390.8921821563545;4786.664933454659;4797.6401769867225;4926.088673595378;4936.679115857476;5005.6996580205305;710.5659039799516;4632.675712700096;4701.43582770068;4777.665563410563;4981.078500477405;4754.429468463789;4783.473817880031;4807.639427042968;4807.663463557552;4867.123917694814;4766.73782941938;4813.518648135158;4836.637252206064;4843.515648435164;4874.366332376769;4631.305304204363;4708.623310135181;4759.952400476021;4803.759812009385;4865;5117.385913690344;5241.68549887008;5261.184516399964;5297.417284098785;5304.496072873071;5377.6504527206;5683.687397193153;5685.118806584986;5685.175649530836;5695.886082278373;5652.406497317764;5698.116791897262;5701.429857014306;5712.942870571283;5783.363829978699;5353.170258609922;5369.6509726867625;5393.164059570773;5394;5396.055690254189;5586.692731899703;5809.448102430262;5857.88284234313;5878.294604647384;5900.321463031806;5585.162225666101;5601.719914004365;5626.381098079208;5626.803061892896;5635.380108188096;5755.769769209185;5768.7980920668415;5778.942210577925;5794.391588883106;5798;5663.9716801415725;5668.518175955008;5693.17448969897;5780.306363236438;5795.333536643256;5710;5723.971380143156;5730.971345143331;5731.168980497888;5733.512651424592;4285.507166675872;4300;4300.634446072057;4311.33174357975;4339.804708788112;3849.634284742945;3859.980700096538;3870.4000879863665;3875.379939209713;3899.454076429302;5203.16749320107;5243.370795504564;5294;5409.945900541023;5489;5788.479036886701;5843.707814609253;5847.795327163529;5848.8537786554825;5849.415058494202;5197.66215196011;5420.24116623673;5454.645448045943;5498.752556134984;5517.69652669107;4836.056968891033;4844.636652251095;4845.200541910545;4861.781219845116;4889.315495830587;5932.911006334908;5935.287765468085;5940.881182376328;5961.850953726105;5962.046072628359;5622.746976386073;5779.711014449176;5839.970800145972;5841.853953651193;5907.3501914790195;6011.699415029144;6040.879182416415;6042.305134909541;6045.365236650265;6086.6652334122045;5400.1899715043055;5745.425457454388;5768.913466297925;5779.422057794187;5781.161731548986;5785.27684039495;5795.768169273182;5825.883482330414;5852.414758524284;5869.618474799125;5657.603967722384;5688;5725.570582206435;5726.141078838207;5736.569757268305;5345.064613692666;5524.75138618755;5685.800996965252;5699.572532060195;5705.201271821865;5426.213199086189;5510.972445137749;5514.365847927379;5523.364813046391;5525.364583072998;5546.805861794818;5595.216669666332;5633.690147041952;5634.718264086861;5672.376038635664;5256.053910296183;5507.917381239205;5560.833175004756;5569.275994120739;5645.971770141123 16:17:55 INFO - PROCESS | 18746 | |1;ext.html;565.8981383350998;597.3309892919929;609.1745684597367;611.9204503414556;618.3044075415161;41856.16287674245;43394.132117357716;43570.910727231836;43629.56370436291;46675.766621166935;41641.791791041076;44324.556754432444;44384.55615443845;44677.32984005242;44735.32897006548;8821.647134114644;8843.46939183651;8889.911100889005;8914.687985920495;8958.32812539059;8751.781205469882;8775.692850750225;8804;8806.603702833356;8872.512011839346;8843.95578022109;8844.55777211137;8854.734357969272;8892.8666070009;8907.955460222689;8789.296856251549;8793.868091978626;8799.824003519925;8810.207081362676;8876;8683.435576687558;8689.087645797226;8706.695265665672;8721.345899057596;8748.168923952215;39826.40260396097;39861;39996;40139;40314;3356.647552007053;3415.4364529852546;3446.3968805458944;3844.6347596978244;3951.46655201547;31105.844470777727;31171.53242701361;31367;31494;31683.36633267345;3817.7327587068917;3933.429652700371;3947.921041579152;3991.5808840071954;4109.465769449952;310441.99999999773;310456;310738;311781;313319;34289.142771430415;35428.114297142776;57238.42761572331;58500.41499585035;58742.706286468296;36769.26461470809;37039.4444083339;37169;37239.25521489555;37256.81371593125;12554;12713.491460341667;12717.427715752814;12726;12793.936030319788;10090.49547522621;10183.18534517237;10229.693109206586;10229.721284839396;10267.075963163352;8440.957795211107;8463.53450560225;8515.276201522816;8528.275096616857;8539;3347.3472672828566;3371.3762953853616;3374.3251349730153;3402.5236466894653;3417.8803741868915;1076.5209481780532;1145.3986657004973;1145.833854091152;1152.4024957120585;1177.7291223018583;31688.366232675216;31767;32064.83967580147;32266.35467290641;32440.35119297601;1071.0842229893485;1117.9105671546256;1129.2095533126844;1132.7224829916559;1160.1994623709782;16516.75224871628;17067.658646826992;17126.972381657142;17178;17252.568685782957;501924;513250;517508;518716;519428;55681.16478252829;56308;56346.718266409225;56438.43561564332;56800.715996419756;1358.2529608715167;1370.869767372098;1377.442135934948;1381.281733498575;1390.798334241509;30274;30733.69266307308;31168.53247201339;31321;31535.36929261448;48957.26564101613;49295.75352123217;49353;49564.752176238886;49575.50424495709;400642;404010;404972;405052;405889;27726.86136569385;28395.290117747223;29143.708562914948;29143.85428072846;30359.69640303657;46216.537834621224;46269.53730462787;47797.76101119472;48272.758636208;49358.75320623374;40894.38658420186;40915.59084409237;41208.1758364825;41895;42704.78647606742;38867.80566097265;40388.59611403848;40562.1887562253;40597.59402406056;41040.1791964165;40401.595984040956;41048.589514104475;41610.58389416067;42107.1578568433;43653.56346436495;33393.66606333906;34989.61495446549;35348.823255884585;35400.29199415946;35651.64348356483;26542.60186097249;26852.865735671196;26922.616195495677;27344.453110937273;27518.174454766387 16:17:55 INFO - PROCESS | 18746 | |2;jquery.html;389.34201199972046;391.19414007145275;392.1001302011882;397.3602499975041;410.2676722051139;13445.93277033616;17710.468685939428;18516.444506664822;19228.327008554705;19321.806781932177;14593.41626334948;15448.073115613042;15519.53441396757;16670.416535421264;17096.658066838656;5450.373207081177;5500.779968801243;5672.865426914634;5677.205191273225;5678.37537870836;5616.297962754656;5625.240592520019;5646;5670.319561652607;5705.087186050233;5503.449655034505;5592.7762889484375;5620.241267428885;5635.436456354373;5701.14482827575;5647.8588035299035;5655.802046928379;5657.066584013633;5688.459596338341;5716.256886604736;4805.255185446262;4979.6265280104135;4996.7501624918605;5001.549860512571;5018.64869459138;18784.530386740305;20234;20400.489987750276;20417.4895627609;21935.561288774294;2358.1157066100213;2409.9156529521383;2492.289697436222;2502.574562324391;2689.5024420482273;9687.225021998223;9733.270004749673;9907.058829411266;10015.649452269208;13985.440582376692;1773.9645207095787;1900.5818719881604;1939.4375631066973;1953.365156324186;1956.833669138125;80531;82267.5886620569;84100.15899840984;85130.57434712787;85306;10316.226283028653;10848.240623156304;10879.891201088047;10888.292261003167;10955.83566246507;14810.407583696748;14848.5545433635;14878.404863805543;14898.329575169144;14921.776173357408;6814.829629259309;7172.928270717331;7265.346118849329;7276.272372762682;7356.926430735732;6830.897536536956;6849.109615750021;6864.691088901011;6880.380765731108;6947.340002699735;4446.888827779331;4477.574630410106;4492.618127459203;4495.865124046284;4498.280275156025;1939.1177014458387;1945.1538580717433;1961.3429501117;1966.9409917702492;1969.222157247879;956.3257903178243;1040.2770074797943;1051.6476980211714;1085.9520562657074;1134.971625709364;16391.5902102446;16594.336226551044;17075.48773536796;17240.65518689644;17647;984.7193549838262;1012.4178597306578;1022.325265324882;1034.2966782587762;1065.211743309945;9355.158035776813;10051.396916185053;10119.544620492095;10129.442880641489;10159.187265018929;481502;485286;510590;520808;521100;55591.44408555944;85143.57428212943;87275.56362218276;90984;91627.54186229027;928.8792456980684;932.4358762948455;935.1163150822543;950.8240975419569;960.9759756006016;15845;15907.125108118702;15948;15981.200939952723;16221.35114595403;38518.80740596279;40991.795041024605;41501.37747933723;41936.3709544351;42245.36631950462;50054.74972625114;50433;53149.46850531445;53285.46714532805;59816.10275845953;7356.154042285206;7460.850782984201;8124.83750325002;8140.959295203723;8378.622961966848;12084.033277337967;12138.664746878014;13366.866331336561;13436.731265374443;13542.119762215425;11547.4803633835;11576.24754390962;11660.242084264495;11817.527298908291;11825.822612660644;11258.38078905668;11377.431128443379;11637.592684256011;11798.41007949582;11908.106891982963;11700.414979251174;11917.463714132711;11946.701332466759;12130;12193.451294691582;7791.610419479117;7867.291943725092;7877.803054923444;7895.092064412666;7928.445008849325;11579.884201158218;11815.232009919328;11828.112891533341;11965.102617303912;12084.516619335129 16:17:55 INFO - PROCESS | 18746 | |3;mootools.html;1518.2788175616583;1568.9686206275874;1756.938507152249;1863.7670291213599;1872.8969906655136;7578.924210757891;8366.330693544516;8443.915560844389;8943.15040071193;9008.68469603564;8530.530820804854;8800.383973121883;8805.20753132218;8817.779555511115;8841.33689973253;2308.780665836747;2348.342464110052;2349.9765002350014;2361.3506285771464;2361.9055237790467;2309.1109922679807;2336.042222688698;2360.5160942006846;2361.551305252005;2371.9644205336936;2304.377817989142;2309.4919117794057;2314.9421264468356;2336.485973085927;2337.602607556711;2290.911816886982;2299.609066458689;2302.5855346037793;2303.6199027160496;2322.222055611372;2295.8622482650926;2303.7120359955006;2305.7694230576976;2308.0536979838353;2315.6642286868478;8764.8685269721;8786.956065219632;8790.120987901222;8805.867911981326;8836.469811811312;5240.81657142002;5346.4118946915805;5349.144136938071;5349.251104845324;5352.652077614943;3389.847456864447;3451.706604938583;3515.0860776198115;3574.267275208576;3607.2965771674535;1134.8354488599107;1137.2153214282118;1154.0825044089968;1154.8787377325343;1172.2966220267856;11633.47649355781;11922.165448418615;12061.97473214769;12170.208936419105;12372.13395062346;4582.1293954148605;4640.074369136838;4684.718916864999;4685.554872287127;4711.340412342275;9572.856407153758;9589.089036541518;9622.182114520345;9665.90334096664;9671;5185.274061631375;5213.530782229617;5241.213817927342;5249.632525723163;5272.2882410874045;4260.467441569804;4746.454157771831;4912.336834527365;4919.950800492021;4997.050560393586;3800.8859734208017;3866.0141663875534;3884.7280690351968;3914.2758589661003;3935.153941902505;1109.4175557832202;1121.3608243301403;1124.9043831274432;1127.2503784983057;1128.48653862494;905.5562774240707;927.4018258223408;936.8922573903952;938.6855403439924;952.9952350238343;5480.314960629921;5548.167774833807;5643.661380317194;5671.517920976763;5742.712864356766;465.3368949247309;467.90407966366814;468.15030719244464;474.1749356120326;480.9495003024702;3803.1633040730994;3826.7512611680154;3828.9042773930873;3870.2259548090497;3897.3179693553516;10025.649102281532;10445.216608754374;10543.84184237237;10599.84100238497;10636.202284828514;10299.639512617172;10451.947740261403;10609.787804244026;10630.627928022483;10766.084882784895;8063.1130575636635;8102.918970810217;8106.959465202636;8138.755837324889;8173.305269052197;5172;5252.474752524717;5306.893862122659;5330.387005494263;5360.517553420211;9492.335536512377;9736.659216927374;9804.607815687292;9842.75393115178;9904.455254961047;9744.269179811685;9818.65634702782;9908.851367229641;9924.801503969737;9995.20038396941;6436.774712885027;6749.696263668048;6880.518363714692;6906.758263460755;6971.65141742921;8670.349723770869;8671.479711217347;8701.17338852808;8705.695300664447;8727.432716873383;7469.178390377163;7665.23347665229;7781.26078022587;7841.5687137208;7842.705953517606;7387.8153046174275;7403.629818509161;7449;7481.289277518627;7517.473776835569;7047.1895731989425;7112.110986126734;7137.85724285501;7150.392216661434;7230.6384680764695;4869.857262804355;4914.70511769295;4983.626228032839;4996.775145118406;5052.797888084436;4933.358663373739;4976.328195693535;5035.118854200427;5088.109580823415;5112.6165537585575 16:17:55 INFO - PROCESS | 18746 | |4;prototype.html;334.75061079495777;334.97320214382853;339.90142858571016;340.30917238006856;343.7816986213755;5339.837365866825;5426.810061647848;5438.8912221755545;5452.2094296327;5516.407288574369;5353.5984801139975;5405.243265942771;5406.135018397057;5413.323334583177;5420.9186862197;4002.5597184309704;4021.3565829467293;4169.561501282068;4169.60388763067;4187.539370669224;4161.667066634677;4201.558836322172;4217.367394890775;4227.387028880826;4229.36559516072;4169.6455801256925;4182.33082706767;4182.393552934823;4187.989764912829;4188.455500784894;4046.7774272415004;4164.771847061823;4188.2251783420015;4199.160167966388;4212.957870421287;3710.3135919854913;3718.86983955563;3719.702423806089;3730.794806285653;3736.9439458408146;5151.665141765773;5160.690358578498;5167.741612919376;5177;5189.636725429222;4711.316859055418;4791.209450440708;4803.855884323476;4813.951860481386;4818.855434336975;5589.804356847531;5619.409961953977;5627.5779316551425;5631.971840140773;5632.746526406321;4110.7328023678365;4113.197926404352;4114.177164567099;4115;4123.175364927027;5600.271964644611;5844.574501581838;5858.824235272906;5866.090755932794;5868.706564671749;4155.210510003089;4164.7917604119675;4175.749455032707;4181.60274773896;4203;4236.872893813191;4239.27932251518;4243.766592837362;4260.105377870682;4265.1469706058915;4678.5437645236525;4772.475027746945;4776.188048031843;4785.401824771903;4810.975945120252;5569.387367389584;5593.972030139905;5651.8304450866535;5656.886862262814;5709.3434255060365;1447.8117844680123;1450.6953539756557;1461.0868207370393;1461.1817382265965;1476.5791749351383;896.9908852540891;930.1070971867083;937.8311903857235;947.3131979314942;1007.8790545134631;5342.545883599938;5416.160495123262;5418.2685337479725;5427.995820773091;5444;5710.857828434329;5715.199872017921;5730.627509211888;5759.1649210865025;5772.826815195551;5079.288899554065;5380.7309634518115;5386.218998245233;5505.642133261325;5561.416051314553;3102.844857757103;3104.1153271317567;3114.3926934247606;3155.2742869139765;3161.5099659552807;5798.884022319615;6068.544859135583;6119.357467465941;6119.816405507842;6126.540509461719;5974.312954010345;6051.697415129314;6083.513318934474;6113.694315284218;6143.078538219213;6075.149479072933;6096.969515152485;6169.537284703665;6171.580536476636;6179.969100154471;5561.777528898961;5876.236089308362;5906.557008224315;5915.970420147872;5925.288965324189;5722.284714410699;5817.650940943557;5843.035899076604;5845.830833833335;5879.647221166743;5884.764609415575;6173.629582225081;6182.536309776875;6184.721687523982;6219.315875253809;4128.318827393447;4129.967508122969;4156.06488540076;4165.937510937399;4178.979105104455;5881.7650292339895;5926.555508336805;5963.986122359296;5967.940320596738;5988.431099045583;5667.392999220405;5725.198472213977;5757.481826635623;5784.652920824596;5799.82600521985;5697.3448053474385;5706.828795136153;5751.913721294268;5800.303963524404;5807.680577568105;5378.762884536501;5459.69971651563;5632.7183640816975;5643.548516118619;5662.405447428126;5655.519280861173;5736.311642602747;5754.618891466102;5755.453231942959;5786.566007549535;5635.633683810539;5658.660480371191;5665.705389317333;5669.86602679474;5681.806820567727 16:17:55 INFO - PROCESS | 18746 | |5;yui.html;799.992000079999;814.5682788122296;823.7569916874521;828.9129641387658;864.2135656552539;14455.638609034779;15879.761803572956;16412.425565105223;16480.258388372524;16647.084410357427;15934.20328983549;15941.681166376666;15964.121973291465;15988.600284992852;16016.519504414857;818.4107442641304;820.5856042698429;846.8941382327209;853.9914600853974;858.4934888415834;840.3193413335188;842.5239739547167;844.4848642328175;846.0989046665312;851.8040850604365;876.1457578860624;879.7052987249248;880.885484886967;882.0561998661435;882.9293656507464;862.8662557303596;871.4771137317622;872.4939535069644;873.8645509945968;874.0865795243985;636.9968150159219;637.4804534304527;638.0747915522464;639.9648019358933;641.2433328672165;14978.62553436162;15129.773053404208;15257.08457492554;15273.923630381889;15296.541103766906;14516.564503064925;14666.633334166625;14772.409103635842;14820;14820.036697614729;11108.00027997476;11438.542458301741;11529.48117334722;11577.884221157849;11672.70818229551;3827.311084004878;3834.8657796976972;3879.0884142226555;3929.1945151244213;3936.488256526633;55854;55878.44121558814;57234.141487877714;57241;58251.417485825026;11530.942345288388;11605.88394116065;11654.184207105422;11779.293242405483;11850.585229516926;20536.79463205379;20722.48193795167;20867.686984695243;20874.37376878696;20882.269120580706;8505.10696376884;8681.479111253346;8693.608787604573;8754.993175784739;8878.245349145265;4898.510148985073;4921.926171107436;4926.753662316942;4974.403071631427;5019.799208031711;3534.2754735279204;3623.9818800905828;3626.8730594429594;3639.7816131032223;3652.160003199279;657.3754932813846;667.6394746836654;687.220005293985;687.3779229797042;693.0989713372595;654.0614218596329;698.6611493425685;720.6756959368305;794.8926894869235;806.6531391501593;9082.40964337316;9410.670626528175;9468.147866691894;9546.556074649583;9641.769051554147;660.8182749743763;680.669875110571;751.8045308219902;778.7507997440878;779.8830175473611;4518.88702782433;4834.903301934012;4862.5380588844;4885.096257192431;4906.31311616374;57414;63053.684731576046;66604;67051.32948670548;68447.31552684409;57593.71203144041;58750;59011.704941475014;60748.69625651932;61507.38492615106;54854;55854.44145558492;56098;56150.31549053535;56278;9468.526573671426;9599.47202903819;9604.423734575948;9758;9839.212862970802;34030.979070627924;34621.65378346285;35064.82467587646;35172.472412914336;36546;43035;46691.766541167075;48117;48283.51716482931;48707.269390958456;12328.568500102454;12331.383430828244;12335.444904979118;12503.749925001268;12524.436400361823;14107.788383174466;14237.50168744089;14331.713365732836;14555.05392149507;14692.559223223321;13530.458781648624;13535.932320338336;13669.863301366859;13808.792868106786;14165.575032749033;13328.133671311334;13356.732865342445;13576.1854288743;13837.861621383658;14063.156210627396;13251.271180085188;13319.400626972003;13425.597232083053;13621.38703758353;13870.375833087333;11188.496517656888;11295.717607059889;11405.144614153805;11635.069194464253;11814.822777658514;10759.193060520649;11049.33703977764;11146.832797508207;11149.665510034712;11197.888021119685 16:17:55 INFO - PROCESS | 18746 | __end_tp_report 16:17:55 INFO - PROCESS | 18746 | __start_cc_report 16:17:55 INFO - PROCESS | 18746 | _x_x_mozilla_cycle_collect,292 16:17:55 INFO - PROCESS | 18746 | __end_cc_report 16:17:55 INFO - PROCESS | 18746 | __startTimestamp1463008675659__endTimestamp 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | ------- Summary: start ------- 16:17:55 INFO - PROCESS | 18746 | Number of tests: 6 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#0] dojo.html Cycles:165 Average:5285.95 Median:5523.36 stddev:721.59 (13.1%) stddev-sans-first:703.32 16:17:55 INFO - PROCESS | 18746 | Values: 3109.7 3120.8 3130.4 3141.3 3165.9 5237.9 5287.8 5334.7 5356.6 5384.4 5146.7 5292.2 5299.7 5315.0 5390.9 4786.7 4797.6 4926.1 4936.7 5005.7 710.6 4632.7 4701.4 4777.7 4981.1 4754.4 4783.5 4807.6 4807.7 4867.1 4766.7 4813.5 4836.6 4843.5 4874.4 4631.3 4708.6 4760.0 4803.8 4865.0 5117.4 5241.7 5261.2 5297.4 5304.5 5377.7 5683.7 5685.1 5685.2 5695.9 5652.4 5698.1 5701.4 5712.9 5783.4 5353.2 5369.7 5393.2 5394.0 5396.1 5586.7 5809.4 5857.9 5878.3 5900.3 5585.2 5601.7 5626.4 5626.8 5635.4 5755.8 5768.8 5778.9 5794.4 5798.0 5664.0 5668.5 5693.2 5780.3 5795.3 5710.0 5724.0 5731.0 5731.2 5733.5 4285.5 4300.0 4300.6 4311.3 4339.8 3849.6 3860.0 3870.4 3875.4 3899.5 5203.2 5243.4 5294.0 5409.9 5489.0 5788.5 5843.7 5847.8 5848.9 5849.4 5197.7 5420.2 5454.6 5498.8 5517.7 4836.1 4844.6 4845.2 4861.8 4889.3 5932.9 5935.3 5940.9 5961.9 5962.0 5622.7 5779.7 5840.0 5841.9 5907.4 6011.7 6040.9 6042.3 6045.4 6086.7 5400.2 5745.4 5768.9 5779.4 5781.2 5785.3 5795.8 5825.9 5852.4 5869.6 5657.6 5688.0 5725.6 5726.1 5736.6 5345.1 5524.8 5685.8 5699.6 5705.2 5426.2 5511.0 5514.4 5523.4 5525.4 5546.8 5595.2 5633.7 5634.7 5672.4 5256.1 5507.9 5560.8 5569.3 5646.0 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#1] ext.html Cycles:180 Average:55923.48 Median:220390.50 stddev:111015.23 (50.4%) stddev-sans-first:111248.85 16:17:55 INFO - PROCESS | 18746 | Values: 565.9 597.3 609.2 611.9 618.3 41856.2 43394.1 43570.9 43629.6 46675.8 41641.8 44324.6 44384.6 44677.3 44735.3 8821.6 8843.5 8889.9 8914.7 8958.3 8751.8 8775.7 8804.0 8806.6 8872.5 8844.0 8844.6 8854.7 8892.9 8908.0 8789.3 8793.9 8799.8 8810.2 8876.0 8683.4 8689.1 8706.7 8721.3 8748.2 39826.4 39861.0 39996.0 40139.0 40314.0 3356.6 3415.4 3446.4 3844.6 3951.5 31105.8 31171.5 31367.0 31494.0 31683.4 3817.7 3933.4 3947.9 3991.6 4109.5 310442.0 310456.0 310738.0 311781.0 313319.0 34289.1 35428.1 57238.4 58500.4 58742.7 36769.3 37039.4 37169.0 37239.3 37256.8 12554.0 12713.5 12717.4 12726.0 12793.9 10090.5 10183.2 10229.7 10229.7 10267.1 8441.0 8463.5 8515.3 8528.3 8539.0 3347.3 3371.4 3374.3 3402.5 3417.9 1076.5 1145.4 1145.8 1152.4 1177.7 31688.4 31767.0 32064.8 32266.4 32440.4 1071.1 1117.9 1129.2 1132.7 1160.2 16516.8 17067.7 17127.0 17178.0 17252.6 501924.0 513250.0 517508.0 518716.0 519428.0 55681.2 56308.0 56346.7 56438.4 56800.7 1358.3 1370.9 1377.4 1381.3 1390.8 30274.0 30733.7 31168.5 31321.0 31535.4 48957.3 49295.8 49353.0 49564.8 49575.5 400642.0 404010.0 404972.0 405052.0 405889.0 27726.9 28395.3 29143.7 29143.9 30359.7 46216.5 46269.5 47797.8 48272.8 49358.8 40894.4 40915.6 41208.2 41895.0 42704.8 38867.8 40388.6 40562.2 40597.6 41040.2 40401.6 41048.6 41610.6 42107.2 43653.6 33393.7 34989.6 35348.8 35400.3 35651.6 26542.6 26852.9 26922.6 27344.5 27518.2 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#2] jquery.html Cycles:180 Average:28570.37 Median:390.27 stddev:82968.21 (21259.3%) stddev-sans-first:83173.97 16:17:55 INFO - PROCESS | 18746 | Values: 389.3 391.2 392.1 397.4 410.3 13445.9 17710.5 18516.4 19228.3 19321.8 14593.4 15448.1 15519.5 16670.4 17096.7 5450.4 5500.8 5672.9 5677.2 5678.4 5616.3 5625.2 5646.0 5670.3 5705.1 5503.4 5592.8 5620.2 5635.4 5701.1 5647.9 5655.8 5657.1 5688.5 5716.3 4805.3 4979.6 4996.8 5001.5 5018.6 18784.5 20234.0 20400.5 20417.5 21935.6 2358.1 2409.9 2492.3 2502.6 2689.5 9687.2 9733.3 9907.1 10015.6 13985.4 1774.0 1900.6 1939.4 1953.4 1956.8 80531.0 82267.6 84100.2 85130.6 85306.0 10316.2 10848.2 10879.9 10888.3 10955.8 14810.4 14848.6 14878.4 14898.3 14921.8 6814.8 7172.9 7265.3 7276.3 7356.9 6830.9 6849.1 6864.7 6880.4 6947.3 4446.9 4477.6 4492.6 4495.9 4498.3 1939.1 1945.2 1961.3 1966.9 1969.2 956.3 1040.3 1051.6 1086.0 1135.0 16391.6 16594.3 17075.5 17240.7 17647.0 984.7 1012.4 1022.3 1034.3 1065.2 9355.2 10051.4 10119.5 10129.4 10159.2 481502.0 485286.0 510590.0 520808.0 521100.0 55591.4 85143.6 87275.6 90984.0 91627.5 928.9 932.4 935.1 950.8 961.0 15845.0 15907.1 15948.0 15981.2 16221.4 38518.8 40991.8 41501.4 41936.4 42245.4 50054.7 50433.0 53149.5 53285.5 59816.1 7356.2 7460.9 8124.8 8141.0 8378.6 12084.0 12138.7 13366.9 13436.7 13542.1 11547.5 11576.2 11660.2 11817.5 11825.8 11258.4 11377.4 11637.6 11798.4 11908.1 11700.4 11917.5 11946.7 12130.0 12193.5 7791.6 7867.3 7877.8 7895.1 7928.4 11579.9 11815.2 11828.1 11965.1 12084.5 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#3] mootools.html Cycles:180 Average:5648.72 Median:5016.08 stddev:3203.74 (63.9%) stddev-sans-first:3197.69 16:17:55 INFO - PROCESS | 18746 | Values: 1518.3 1569.0 1756.9 1863.8 1872.9 7578.9 8366.3 8443.9 8943.2 9008.7 8530.5 8800.4 8805.2 8817.8 8841.3 2308.8 2348.3 2350.0 2361.4 2361.9 2309.1 2336.0 2360.5 2361.6 2372.0 2304.4 2309.5 2314.9 2336.5 2337.6 2290.9 2299.6 2302.6 2303.6 2322.2 2295.9 2303.7 2305.8 2308.1 2315.7 8764.9 8787.0 8790.1 8805.9 8836.5 5240.8 5346.4 5349.1 5349.3 5352.7 3389.8 3451.7 3515.1 3574.3 3607.3 1134.8 1137.2 1154.1 1154.9 1172.3 11633.5 11922.2 12062.0 12170.2 12372.1 4582.1 4640.1 4684.7 4685.6 4711.3 9572.9 9589.1 9622.2 9665.9 9671.0 5185.3 5213.5 5241.2 5249.6 5272.3 4260.5 4746.5 4912.3 4920.0 4997.1 3800.9 3866.0 3884.7 3914.3 3935.2 1109.4 1121.4 1124.9 1127.3 1128.5 905.6 927.4 936.9 938.7 953.0 5480.3 5548.2 5643.7 5671.5 5742.7 465.3 467.9 468.2 474.2 480.9 3803.2 3826.8 3828.9 3870.2 3897.3 10025.6 10445.2 10543.8 10599.8 10636.2 10299.6 10451.9 10609.8 10630.6 10766.1 8063.1 8102.9 8107.0 8138.8 8173.3 5172.0 5252.5 5306.9 5330.4 5360.5 9492.3 9736.7 9804.6 9842.8 9904.5 9744.3 9818.7 9908.9 9924.8 9995.2 6436.8 6749.7 6880.5 6906.8 6971.7 8670.3 8671.5 8701.2 8705.7 8727.4 7469.2 7665.2 7781.3 7841.6 7842.7 7387.8 7403.6 7449.0 7481.3 7517.5 7047.2 7112.1 7137.9 7150.4 7230.6 4869.9 4914.7 4983.6 4996.8 5052.8 4933.4 4976.3 5035.1 5088.1 5112.6 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#4] prototype.html Cycles:180 Average:4792.94 Median:5433.44 stddev:1420.80 (26.1%) stddev-sans-first:1384.82 16:17:55 INFO - PROCESS | 18746 | Values: 334.8 335.0 339.9 340.3 343.8 5339.8 5426.8 5438.9 5452.2 5516.4 5353.6 5405.2 5406.1 5413.3 5420.9 4002.6 4021.4 4169.6 4169.6 4187.5 4161.7 4201.6 4217.4 4227.4 4229.4 4169.6 4182.3 4182.4 4188.0 4188.5 4046.8 4164.8 4188.2 4199.2 4213.0 3710.3 3718.9 3719.7 3730.8 3736.9 5151.7 5160.7 5167.7 5177.0 5189.6 4711.3 4791.2 4803.9 4814.0 4818.9 5589.8 5619.4 5627.6 5632.0 5632.7 4110.7 4113.2 4114.2 4115.0 4123.2 5600.3 5844.6 5858.8 5866.1 5868.7 4155.2 4164.8 4175.7 4181.6 4203.0 4236.9 4239.3 4243.8 4260.1 4265.1 4678.5 4772.5 4776.2 4785.4 4811.0 5569.4 5594.0 5651.8 5656.9 5709.3 1447.8 1450.7 1461.1 1461.2 1476.6 897.0 930.1 937.8 947.3 1007.9 5342.5 5416.2 5418.3 5428.0 5444.0 5710.9 5715.2 5730.6 5759.2 5772.8 5079.3 5380.7 5386.2 5505.6 5561.4 3102.8 3104.1 3114.4 3155.3 3161.5 5798.9 6068.5 6119.4 6119.8 6126.5 5974.3 6051.7 6083.5 6113.7 6143.1 6075.1 6097.0 6169.5 6171.6 6180.0 5561.8 5876.2 5906.6 5916.0 5925.3 5722.3 5817.7 5843.0 5845.8 5879.6 5884.8 6173.6 6182.5 6184.7 6219.3 4128.3 4130.0 4156.1 4165.9 4179.0 5881.8 5926.6 5964.0 5967.9 5988.4 5667.4 5725.2 5757.5 5784.7 5799.8 5697.3 5706.8 5751.9 5800.3 5807.7 5378.8 5459.7 5632.7 5643.5 5662.4 5655.5 5736.3 5754.6 5755.5 5786.6 5635.6 5658.7 5665.7 5669.9 5681.8 16:17:55 INFO - PROCESS | 18746 | 16:17:55 INFO - PROCESS | 18746 | [#5] yui.html Cycles:180 Average:15746.50 Median:4848.72 stddev:18127.49 (373.9%) stddev-sans-first:18143.59 16:17:55 INFO - PROCESS | 18746 | Values: 800.0 814.6 823.8 828.9 864.2 14455.6 15879.8 16412.4 16480.3 16647.1 15934.2 15941.7 15964.1 15988.6 16016.5 818.4 820.6 846.9 854.0 858.5 840.3 842.5 844.5 846.1 851.8 876.1 879.7 880.9 882.1 882.9 862.9 871.5 872.5 873.9 874.1 637.0 637.5 638.1 640.0 641.2 14978.6 15129.8 15257.1 15273.9 15296.5 14516.6 14666.6 14772.4 14820.0 14820.0 11108.0 11438.5 11529.5 11577.9 11672.7 3827.3 3834.9 3879.1 3929.2 3936.5 55854.0 55878.4 57234.1 57241.0 58251.4 11530.9 11605.9 11654.2 11779.3 11850.6 20536.8 20722.5 20867.7 20874.4 20882.3 8505.1 8681.5 8693.6 8755.0 8878.2 4898.5 4921.9 4926.8 4974.4 5019.8 3534.3 3624.0 3626.9 3639.8 3652.2 657.4 667.6 687.2 687.4 693.1 654.1 698.7 720.7 794.9 806.7 9082.4 9410.7 9468.1 9546.6 9641.8 660.8 680.7 751.8 778.8 779.9 4518.9 4834.9 4862.5 4885.1 4906.3 57414.0 63053.7 66604.0 67051.3 68447.3 57593.7 58750.0 59011.7 60748.7 61507.4 54854.0 55854.4 56098.0 56150.3 56278.0 9468.5 9599.5 9604.4 9758.0 9839.2 34031.0 34621.7 35064.8 35172.5 36546.0 43035.0 46691.8 48117.0 48283.5 48707.3 12328.6 12331.4 12335.4 12503.7 12524.4 14107.8 14237.5 14331.7 14555.1 14692.6 13530.5 13535.9 13669.9 13808.8 14165.6 13328.1 13356.7 13576.2 13837.9 14063.2 13251.3 13319.4 13425.6 13621.4 13870.4 11188.5 11295.7 11405.1 11635.1 11814.8 10759.2 11049.3 11146.8 11149.7 11197.9 16:17:55 INFO - PROCESS | 18746 | -------- Summary: end -------- 16:17:55 INFO - PROCESS | 18746 | 16:17:56 INFO - TEST-INFO | 18746: exit 0 16:17:56 INFO - TEST-OK | dromaeo_css | took 1108394ms 16:17:56 INFO - TEST-START | kraken 16:17:56 INFO - operating with platform_type : linux_ 16:17:56 INFO - Initialising browser for kraken test... 16:17:56 INFO - TEST-INFO | started process 18981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJyE8u/profile http://localhost:53827/getInfo.html) 16:17:59 INFO - PROCESS | 18981 | 16:17:59 INFO - PROCESS | 18981 | (process:19047): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:00 INFO - PROCESS | 18981 | __metrics Screen width/height:1600/1200 16:18:00 INFO - PROCESS | 18981 | colorDepth:24 16:18:00 INFO - PROCESS | 18981 | Browser inner width/height: 1024/697 16:18:00 INFO - PROCESS | 18981 | __metrics 16:18:00 ERROR - PROCESS | 18981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:18:01 INFO - TEST-INFO | 18981: exit 0 16:18:01 INFO - Browser initialized. 16:18:01 INFO - Running cycle 1/1 for kraken test... 16:18:01 INFO - TEST-INFO | started process 19098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJyE8u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:02 INFO - PROCESS | 19098 | 16:18:02 INFO - PROCESS | 19098 | (process:19159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:12 INFO - PROCESS | 19098 | RSS: Main: 161583104 16:18:12 INFO - PROCESS | 19098 | 16:18:15 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53827/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:15 INFO - PROCESS | 19098 | RSS: Main: 166166528 16:18:15 INFO - PROCESS | 19098 | 16:18:18 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53827/tests/kraken/driver.html?testName=audio-dft) 16:18:19 INFO - PROCESS | 19098 | RSS: Main: 166309888 16:18:19 INFO - PROCESS | 19098 | 16:18:22 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53827/tests/kraken/driver.html?testName=audio-fft) 16:18:22 INFO - PROCESS | 19098 | RSS: Main: 161656832 16:18:22 INFO - PROCESS | 19098 | 16:18:24 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53827/tests/kraken/driver.html?testName=audio-oscillator) 16:18:25 INFO - PROCESS | 19098 | RSS: Main: 162009088 16:18:25 INFO - PROCESS | 19098 | 16:18:27 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53827/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:28 INFO - PROCESS | 19098 | RSS: Main: 161968128 16:18:28 INFO - PROCESS | 19098 | 16:18:31 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53827/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:32 INFO - PROCESS | 19098 | RSS: Main: 162209792 16:18:32 INFO - PROCESS | 19098 | 16:18:35 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53827/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:36 INFO - PROCESS | 19098 | RSS: Main: 160886784 16:18:36 INFO - PROCESS | 19098 | 16:18:39 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53827/tests/kraken/driver.html?testName=json-parse-financial) 16:18:39 INFO - PROCESS | 19098 | RSS: Main: 162054144 16:18:39 INFO - PROCESS | 19098 | 16:18:41 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53827/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:42 INFO - PROCESS | 19098 | RSS: Main: 162279424 16:18:42 INFO - PROCESS | 19098 | 16:18:43 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:44 INFO - PROCESS | 19098 | RSS: Main: 162451456 16:18:44 INFO - PROCESS | 19098 | 16:18:46 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:47 INFO - PROCESS | 19098 | RSS: Main: 162381824 16:18:47 INFO - PROCESS | 19098 | 16:18:49 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:50 INFO - PROCESS | 19098 | RSS: Main: 162836480 16:18:50 INFO - PROCESS | 19098 | 16:18:53 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:18:53 INFO - PROCESS | 19098 | RSS: Main: 162820096 16:18:53 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | Cycle 1(1): loaded http://localhost:53827/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53827/tests/kraken/driver.html?testName=ai-astar) 16:18:55 INFO - PROCESS | 19098 | RSS: Main: 164179968 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | __start_tp_report 16:18:55 INFO - PROCESS | 19098 | _x_x_mozilla_page_load 16:18:55 INFO - PROCESS | 19098 | _x_x_mozilla_page_load_details 16:18:55 INFO - PROCESS | 19098 | |i|pagename|runs| 16:18:55 INFO - PROCESS | 19098 | |0;ai-astar;110;114;106;112;114;114;106;113;111;114 16:18:55 INFO - PROCESS | 19098 | |1;audio-beat-detection;155;133;155;207;130;160;155;133;179;131 16:18:55 INFO - PROCESS | 19098 | |2;audio-dft;163;164;164;164;163;163;166;170;176;165 16:18:55 INFO - PROCESS | 19098 | |3;audio-fft;77;78;80;161;79;77;79;77;168;79 16:18:55 INFO - PROCESS | 19098 | |4;audio-oscillator;93;92;175;94;93;93;142;95;93;141 16:18:55 INFO - PROCESS | 19098 | |5;imaging-gaussian-blur;119;119;119;120;119;120;119;119;119;119 16:18:55 INFO - PROCESS | 19098 | |6;imaging-darkroom;149;150;149;149;149;151;149;148;149;148 16:18:55 INFO - PROCESS | 19098 | |7;imaging-desaturate;100;96;97;95;98;96;97;97;96;97 16:18:55 INFO - PROCESS | 19098 | |8;json-parse-financial;60;59;58;58;59;59;58;109;56;58 16:18:55 INFO - PROCESS | 19098 | |9;json-stringify-tinderbox;60;60;60;60;60;61;60;59;65;60 16:18:55 INFO - PROCESS | 19098 | |10;stanford-crypto-aes;86;82;83;81;83;86;84;81;83;82 16:18:55 INFO - PROCESS | 19098 | |11;stanford-crypto-ccm;132;130;134;133;145;138;142;131;190;139 16:18:55 INFO - PROCESS | 19098 | |12;stanford-crypto-pbkdf2;175;170;173;169;171;167;170;166;164;169 16:18:55 INFO - PROCESS | 19098 | |13;stanford-crypto-sha256-iterative;67;71;67;68;67;70;68;67;66;67 16:18:55 INFO - PROCESS | 19098 | __end_tp_report 16:18:55 INFO - PROCESS | 19098 | __start_cc_report 16:18:55 INFO - PROCESS | 19098 | _x_x_mozilla_cycle_collect,740 16:18:55 INFO - PROCESS | 19098 | __end_cc_report 16:18:55 INFO - PROCESS | 19098 | __startTimestamp1463008735800__endTimestamp 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | ------- Summary: start ------- 16:18:55 INFO - PROCESS | 19098 | Number of tests: 14 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:3.17 (2.8%) stddev-sans-first:3.32 16:18:55 INFO - PROCESS | 19098 | Values: 110.0 114.0 106.0 112.0 114.0 114.0 106.0 113.0 111.0 114.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:155.00 stddev:24.63 (15.9%) stddev-sans-first:26.12 16:18:55 INFO - PROCESS | 19098 | Values: 155.0 133.0 155.0 207.0 130.0 160.0 155.0 133.0 179.0 131.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#2] audio-dft Cycles:10 Average:165.80 Median:164.50 stddev:4.16 (2.5%) stddev-sans-first:4.28 16:18:55 INFO - PROCESS | 19098 | Values: 163.0 164.0 164.0 164.0 163.0 163.0 166.0 170.0 176.0 165.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#3] audio-fft Cycles:10 Average:95.50 Median:78.50 stddev:36.42 (46.4%) stddev-sans-first:38.01 16:18:55 INFO - PROCESS | 19098 | Values: 77.0 78.0 80.0 161.0 79.0 77.0 79.0 77.0 168.0 79.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:93.00 stddev:30.11 (32.4%) stddev-sans-first:31.21 16:18:55 INFO - PROCESS | 19098 | Values: 93.0 92.0 175.0 94.0 93.0 93.0 142.0 95.0 93.0 141.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#5] imaging-gaussian-blur Cycles:10 Average:119.20 Median:119.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:18:55 INFO - PROCESS | 19098 | Values: 119.0 119.0 119.0 120.0 119.0 120.0 119.0 119.0 119.0 119.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 16:18:55 INFO - PROCESS | 19098 | Values: 149.0 150.0 149.0 149.0 149.0 151.0 149.0 148.0 149.0 148.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:1.37 (1.4%) stddev-sans-first:0.88 16:18:55 INFO - PROCESS | 19098 | Values: 100.0 96.0 97.0 95.0 98.0 96.0 97.0 97.0 96.0 97.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:58.50 stddev:16.06 (27.4%) stddev-sans-first:16.98 16:18:55 INFO - PROCESS | 19098 | Values: 60.0 59.0 58.0 58.0 59.0 59.0 58.0 109.0 56.0 58.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.74 16:18:55 INFO - PROCESS | 19098 | Values: 60.0 60.0 60.0 60.0 60.0 61.0 60.0 59.0 65.0 60.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.79 (2.2%) stddev-sans-first:1.56 16:18:55 INFO - PROCESS | 19098 | Values: 86.0 82.0 83.0 81.0 83.0 86.0 84.0 81.0 83.0 82.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:138.50 stddev:17.78 (12.8%) stddev-sans-first:18.53 16:18:55 INFO - PROCESS | 19098 | Values: 132.0 130.0 134.0 133.0 145.0 138.0 142.0 131.0 190.0 139.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:3.24 (1.9%) stddev-sans-first:2.73 16:18:55 INFO - PROCESS | 19098 | Values: 175.0 170.0 173.0 169.0 171.0 167.0 170.0 166.0 164.0 169.0 16:18:55 INFO - PROCESS | 19098 | 16:18:55 INFO - PROCESS | 19098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 16:18:55 INFO - PROCESS | 19098 | Values: 67.0 71.0 67.0 68.0 67.0 70.0 68.0 67.0 66.0 67.0 16:18:55 INFO - PROCESS | 19098 | -------- Summary: end -------- 16:18:55 INFO - PROCESS | 19098 | 16:18:56 INFO - TEST-INFO | 19098: exit 0 16:18:56 INFO - TEST-OK | kraken | took 60350ms 16:18:56 INFO - SUITE-END | took 1168s 16:18:56 INFO - Completed test suite (00:19:29) 16:18:56 INFO - javascript benchmark 16:18:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7005.191726876714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.720125188734, 3120.7815452918276, 3130.4052230076286, 3141.32461520773, 3165.8575364108615, 5237.86905327367, 5287.762050707718, 5334.706591137486, 5356.625036247464, 5384.43463436339, 5146.665466744668, 5292.2061690746405, 5299.682019078858, 5314.973425132869, 5390.8921821563545, 4786.664933454659, 4797.6401769867225, 4926.088673595378, 4936.679115857476, 5005.6996580205305, 710.5659039799516, 4632.675712700096, 4701.43582770068, 4777.665563410563, 4981.078500477405, 4754.429468463789, 4783.473817880031, 4807.639427042968, 4807.663463557552, 4867.123917694814, 4766.73782941938, 4813.518648135158, 4836.637252206064, 4843.515648435164, 4874.366332376769, 4631.305304204363, 4708.623310135181, 4759.952400476021, 4803.759812009385, 4865.0, 5117.385913690344, 5241.68549887008, 5261.184516399964, 5297.417284098785, 5304.496072873071, 5377.6504527206, 5683.687397193153, 5685.118806584986, 5685.175649530836, 5695.886082278373, 5652.406497317764, 5698.116791897262, 5701.429857014306, 5712.942870571283, 5783.363829978699, 5353.170258609922, 5369.6509726867625, 5393.164059570773, 5394.0, 5396.055690254189, 5586.692731899703, 5809.448102430262, 5857.88284234313, 5878.294604647384, 5900.321463031806, 5585.162225666101, 5601.719914004365, 5626.381098079208, 5626.803061892896, 5635.380108188096, 5755.769769209185, 5768.7980920668415, 5778.942210577925, 5794.391588883106, 5798.0, 5663.9716801415725, 5668.518175955008, 5693.17448969897, 5780.306363236438, 5795.333536643256, 5710.0, 5723.971380143156, 5730.971345143331, 5731.168980497888, 5733.512651424592, 4285.507166675872, 4300.0, 4300.634446072057, 4311.33174357975, 4339.804708788112, 3849.634284742945, 3859.980700096538, 3870.4000879863665, 3875.379939209713, 3899.454076429302, 5203.16749320107, 5243.370795504564, 5294.0, 5409.945900541023, 5489.0, 5788.479036886701, 5843.707814609253, 5847.795327163529, 5848.8537786554825, 5849.415058494202, 5197.66215196011, 5420.24116623673, 5454.645448045943, 5498.752556134984, 5517.69652669107, 4836.056968891033, 4844.636652251095, 4845.200541910545, 4861.781219845116, 4889.315495830587, 5932.911006334908, 5935.287765468085, 5940.881182376328, 5961.850953726105, 5962.046072628359, 5622.746976386073, 5779.711014449176, 5839.970800145972, 5841.853953651193, 5907.3501914790195, 6011.699415029144, 6040.879182416415, 6042.305134909541, 6045.365236650265, 6086.6652334122045, 5400.1899715043055, 5745.425457454388, 5768.913466297925, 5779.422057794187, 5781.161731548986, 5785.27684039495, 5795.768169273182, 5825.883482330414, 5852.414758524284, 5869.618474799125, 5657.603967722384, 5688.0, 5725.570582206435, 5726.141078838207, 5736.569757268305, 5345.064613692666, 5524.75138618755, 5685.800996965252, 5699.572532060195, 5705.201271821865, 5426.213199086189, 5510.972445137749, 5514.365847927379, 5523.364813046391, 5525.364583072998, 5546.805861794818, 5595.216669666332, 5633.690147041952, 5634.718264086861, 5672.376038635664, 5256.053910296183, 5507.917381239205, 5560.833175004756, 5569.275994120739, 5645.971770141123], "value": 5237.811391805233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8981383350998, 597.3309892919929, 609.1745684597367, 611.9204503414556, 618.3044075415161, 41856.16287674245, 43394.132117357716, 43570.910727231836, 43629.56370436291, 46675.766621166935, 41641.791791041076, 44324.556754432444, 44384.55615443845, 44677.32984005242, 44735.32897006548, 8821.647134114644, 8843.46939183651, 8889.911100889005, 8914.687985920495, 8958.32812539059, 8751.781205469882, 8775.692850750225, 8804.0, 8806.603702833356, 8872.512011839346, 8843.95578022109, 8844.55777211137, 8854.734357969272, 8892.8666070009, 8907.955460222689, 8789.296856251549, 8793.868091978626, 8799.824003519925, 8810.207081362676, 8876.0, 8683.435576687558, 8689.087645797226, 8706.695265665672, 8721.345899057596, 8748.168923952215, 39826.40260396097, 39861.0, 39996.0, 40139.0, 40314.0, 3356.647552007053, 3415.4364529852546, 3446.3968805458944, 3844.6347596978244, 3951.46655201547, 31105.844470777727, 31171.53242701361, 31367.0, 31494.0, 31683.36633267345, 3817.7327587068917, 3933.429652700371, 3947.921041579152, 3991.5808840071954, 4109.465769449952, 310441.99999999773, 310456.0, 310738.0, 311781.0, 313319.0, 34289.142771430415, 35428.114297142776, 57238.42761572331, 58500.41499585035, 58742.706286468296, 36769.26461470809, 37039.4444083339, 37169.0, 37239.25521489555, 37256.81371593125, 12554.0, 12713.491460341667, 12717.427715752814, 12726.0, 12793.936030319788, 10090.49547522621, 10183.18534517237, 10229.693109206586, 10229.721284839396, 10267.075963163352, 8440.957795211107, 8463.53450560225, 8515.276201522816, 8528.275096616857, 8539.0, 3347.3472672828566, 3371.3762953853616, 3374.3251349730153, 3402.5236466894653, 3417.8803741868915, 1076.5209481780532, 1145.3986657004973, 1145.833854091152, 1152.4024957120585, 1177.7291223018583, 31688.366232675216, 31767.0, 32064.83967580147, 32266.35467290641, 32440.35119297601, 1071.0842229893485, 1117.9105671546256, 1129.2095533126844, 1132.7224829916559, 1160.1994623709782, 16516.75224871628, 17067.658646826992, 17126.972381657142, 17178.0, 17252.568685782957, 501924.0, 513250.0, 517508.0, 518716.0, 519428.0, 55681.16478252829, 56308.0, 56346.718266409225, 56438.43561564332, 56800.715996419756, 1358.2529608715167, 1370.869767372098, 1377.442135934948, 1381.281733498575, 1390.798334241509, 30274.0, 30733.69266307308, 31168.53247201339, 31321.0, 31535.36929261448, 48957.26564101613, 49295.75352123217, 49353.0, 49564.752176238886, 49575.50424495709, 400642.0, 404010.0, 404972.0, 405052.0, 405889.0, 27726.86136569385, 28395.290117747223, 29143.708562914948, 29143.85428072846, 30359.69640303657, 46216.537834621224, 46269.53730462787, 47797.76101119472, 48272.758636208, 49358.75320623374, 40894.38658420186, 40915.59084409237, 41208.1758364825, 41895.0, 42704.78647606742, 38867.80566097265, 40388.59611403848, 40562.1887562253, 40597.59402406056, 41040.1791964165, 40401.595984040956, 41048.589514104475, 41610.58389416067, 42107.1578568433, 43653.56346436495, 33393.66606333906, 34989.61495446549, 35348.823255884585, 35400.29199415946, 35651.64348356483, 26542.60186097249, 26852.865735671196, 26922.616195495677, 27344.453110937273, 27518.174454766387], "value": 18432.61957283144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.34201199972046, 391.19414007145275, 392.1001302011882, 397.3602499975041, 410.2676722051139, 13445.93277033616, 17710.468685939428, 18516.444506664822, 19228.327008554705, 19321.806781932177, 14593.41626334948, 15448.073115613042, 15519.53441396757, 16670.416535421264, 17096.658066838656, 5450.373207081177, 5500.779968801243, 5672.865426914634, 5677.205191273225, 5678.37537870836, 5616.297962754656, 5625.240592520019, 5646.0, 5670.319561652607, 5705.087186050233, 5503.449655034505, 5592.7762889484375, 5620.241267428885, 5635.436456354373, 5701.14482827575, 5647.8588035299035, 5655.802046928379, 5657.066584013633, 5688.459596338341, 5716.256886604736, 4805.255185446262, 4979.6265280104135, 4996.7501624918605, 5001.549860512571, 5018.64869459138, 18784.530386740305, 20234.0, 20400.489987750276, 20417.4895627609, 21935.561288774294, 2358.1157066100213, 2409.9156529521383, 2492.289697436222, 2502.574562324391, 2689.5024420482273, 9687.225021998223, 9733.270004749673, 9907.058829411266, 10015.649452269208, 13985.440582376692, 1773.9645207095787, 1900.5818719881604, 1939.4375631066973, 1953.365156324186, 1956.833669138125, 80531.0, 82267.5886620569, 84100.15899840984, 85130.57434712787, 85306.0, 10316.226283028653, 10848.240623156304, 10879.891201088047, 10888.292261003167, 10955.83566246507, 14810.407583696748, 14848.5545433635, 14878.404863805543, 14898.329575169144, 14921.776173357408, 6814.829629259309, 7172.928270717331, 7265.346118849329, 7276.272372762682, 7356.926430735732, 6830.897536536956, 6849.109615750021, 6864.691088901011, 6880.380765731108, 6947.340002699735, 4446.888827779331, 4477.574630410106, 4492.618127459203, 4495.865124046284, 4498.280275156025, 1939.1177014458387, 1945.1538580717433, 1961.3429501117, 1966.9409917702492, 1969.222157247879, 956.3257903178243, 1040.2770074797943, 1051.6476980211714, 1085.9520562657074, 1134.971625709364, 16391.5902102446, 16594.336226551044, 17075.48773536796, 17240.65518689644, 17647.0, 984.7193549838262, 1012.4178597306578, 1022.325265324882, 1034.2966782587762, 1065.211743309945, 9355.158035776813, 10051.396916185053, 10119.544620492095, 10129.442880641489, 10159.187265018929, 481502.0, 485286.0, 510590.0, 520808.0, 521100.0, 55591.44408555944, 85143.57428212943, 87275.56362218276, 90984.0, 91627.54186229027, 928.8792456980684, 932.4358762948455, 935.1163150822543, 950.8240975419569, 960.9759756006016, 15845.0, 15907.125108118702, 15948.0, 15981.200939952723, 16221.35114595403, 38518.80740596279, 40991.795041024605, 41501.37747933723, 41936.3709544351, 42245.36631950462, 50054.74972625114, 50433.0, 53149.46850531445, 53285.46714532805, 59816.10275845953, 7356.154042285206, 7460.850782984201, 8124.83750325002, 8140.959295203723, 8378.622961966848, 12084.033277337967, 12138.664746878014, 13366.866331336561, 13436.731265374443, 13542.119762215425, 11547.4803633835, 11576.24754390962, 11660.242084264495, 11817.527298908291, 11825.822612660644, 11258.38078905668, 11377.431128443379, 11637.592684256011, 11798.41007949582, 11908.106891982963, 11700.414979251174, 11917.463714132711, 11946.701332466759, 12130.0, 12193.451294691582, 7791.610419479117, 7867.291943725092, 7877.803054923444, 7895.092064412666, 7928.445008849325, 11579.884201158218, 11815.232009919328, 11828.112891533341, 11965.102617303912, 12084.516619335129], "value": 8858.950575362023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.2788175616583, 1568.9686206275874, 1756.938507152249, 1863.7670291213599, 1872.8969906655136, 7578.924210757891, 8366.330693544516, 8443.915560844389, 8943.15040071193, 9008.68469603564, 8530.530820804854, 8800.383973121883, 8805.20753132218, 8817.779555511115, 8841.33689973253, 2308.780665836747, 2348.342464110052, 2349.9765002350014, 2361.3506285771464, 2361.9055237790467, 2309.1109922679807, 2336.042222688698, 2360.5160942006846, 2361.551305252005, 2371.9644205336936, 2304.377817989142, 2309.4919117794057, 2314.9421264468356, 2336.485973085927, 2337.602607556711, 2290.911816886982, 2299.609066458689, 2302.5855346037793, 2303.6199027160496, 2322.222055611372, 2295.8622482650926, 2303.7120359955006, 2305.7694230576976, 2308.0536979838353, 2315.6642286868478, 8764.8685269721, 8786.956065219632, 8790.120987901222, 8805.867911981326, 8836.469811811312, 5240.81657142002, 5346.4118946915805, 5349.144136938071, 5349.251104845324, 5352.652077614943, 3389.847456864447, 3451.706604938583, 3515.0860776198115, 3574.267275208576, 3607.2965771674535, 1134.8354488599107, 1137.2153214282118, 1154.0825044089968, 1154.8787377325343, 1172.2966220267856, 11633.47649355781, 11922.165448418615, 12061.97473214769, 12170.208936419105, 12372.13395062346, 4582.1293954148605, 4640.074369136838, 4684.718916864999, 4685.554872287127, 4711.340412342275, 9572.856407153758, 9589.089036541518, 9622.182114520345, 9665.90334096664, 9671.0, 5185.274061631375, 5213.530782229617, 5241.213817927342, 5249.632525723163, 5272.2882410874045, 4260.467441569804, 4746.454157771831, 4912.336834527365, 4919.950800492021, 4997.050560393586, 3800.8859734208017, 3866.0141663875534, 3884.7280690351968, 3914.2758589661003, 3935.153941902505, 1109.4175557832202, 1121.3608243301403, 1124.9043831274432, 1127.2503784983057, 1128.48653862494, 905.5562774240707, 927.4018258223408, 936.8922573903952, 938.6855403439924, 952.9952350238343, 5480.314960629921, 5548.167774833807, 5643.661380317194, 5671.517920976763, 5742.712864356766, 465.3368949247309, 467.90407966366814, 468.15030719244464, 474.1749356120326, 480.9495003024702, 3803.1633040730994, 3826.7512611680154, 3828.9042773930873, 3870.2259548090497, 3897.3179693553516, 10025.649102281532, 10445.216608754374, 10543.84184237237, 10599.84100238497, 10636.202284828514, 10299.639512617172, 10451.947740261403, 10609.787804244026, 10630.627928022483, 10766.084882784895, 8063.1130575636635, 8102.918970810217, 8106.959465202636, 8138.755837324889, 8173.305269052197, 5172.0, 5252.474752524717, 5306.893862122659, 5330.387005494263, 5360.517553420211, 9492.335536512377, 9736.659216927374, 9804.607815687292, 9842.75393115178, 9904.455254961047, 9744.269179811685, 9818.65634702782, 9908.851367229641, 9924.801503969737, 9995.20038396941, 6436.774712885027, 6749.696263668048, 6880.518363714692, 6906.758263460755, 6971.65141742921, 8670.349723770869, 8671.479711217347, 8701.17338852808, 8705.695300664447, 8727.432716873383, 7469.178390377163, 7665.23347665229, 7781.26078022587, 7841.5687137208, 7842.705953517606, 7387.8153046174275, 7403.629818509161, 7449.0, 7481.289277518627, 7517.473776835569, 7047.1895731989425, 7112.110986126734, 7137.85724285501, 7150.392216661434, 7230.6384680764695, 4869.857262804355, 4914.70511769295, 4983.626228032839, 4996.775145118406, 5052.797888084436, 4933.358663373739, 4976.328195693535, 5035.118854200427, 5088.109580823415, 5112.6165537585575], "value": 4467.057347274975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.75061079495777, 334.97320214382853, 339.90142858571016, 340.30917238006856, 343.7816986213755, 5339.837365866825, 5426.810061647848, 5438.8912221755545, 5452.2094296327, 5516.407288574369, 5353.5984801139975, 5405.243265942771, 5406.135018397057, 5413.323334583177, 5420.9186862197, 4002.5597184309704, 4021.3565829467293, 4169.561501282068, 4169.60388763067, 4187.539370669224, 4161.667066634677, 4201.558836322172, 4217.367394890775, 4227.387028880826, 4229.36559516072, 4169.6455801256925, 4182.33082706767, 4182.393552934823, 4187.989764912829, 4188.455500784894, 4046.7774272415004, 4164.771847061823, 4188.2251783420015, 4199.160167966388, 4212.957870421287, 3710.3135919854913, 3718.86983955563, 3719.702423806089, 3730.794806285653, 3736.9439458408146, 5151.665141765773, 5160.690358578498, 5167.741612919376, 5177.0, 5189.636725429222, 4711.316859055418, 4791.209450440708, 4803.855884323476, 4813.951860481386, 4818.855434336975, 5589.804356847531, 5619.409961953977, 5627.5779316551425, 5631.971840140773, 5632.746526406321, 4110.7328023678365, 4113.197926404352, 4114.177164567099, 4115.0, 4123.175364927027, 5600.271964644611, 5844.574501581838, 5858.824235272906, 5866.090755932794, 5868.706564671749, 4155.210510003089, 4164.7917604119675, 4175.749455032707, 4181.60274773896, 4203.0, 4236.872893813191, 4239.27932251518, 4243.766592837362, 4260.105377870682, 4265.1469706058915, 4678.5437645236525, 4772.475027746945, 4776.188048031843, 4785.401824771903, 4810.975945120252, 5569.387367389584, 5593.972030139905, 5651.8304450866535, 5656.886862262814, 5709.3434255060365, 1447.8117844680123, 1450.6953539756557, 1461.0868207370393, 1461.1817382265965, 1476.5791749351383, 896.9908852540891, 930.1070971867083, 937.8311903857235, 947.3131979314942, 1007.8790545134631, 5342.545883599938, 5416.160495123262, 5418.2685337479725, 5427.995820773091, 5444.0, 5710.857828434329, 5715.199872017921, 5730.627509211888, 5759.1649210865025, 5772.826815195551, 5079.288899554065, 5380.7309634518115, 5386.218998245233, 5505.642133261325, 5561.416051314553, 3102.844857757103, 3104.1153271317567, 3114.3926934247606, 3155.2742869139765, 3161.5099659552807, 5798.884022319615, 6068.544859135583, 6119.357467465941, 6119.816405507842, 6126.540509461719, 5974.312954010345, 6051.697415129314, 6083.513318934474, 6113.694315284218, 6143.078538219213, 6075.149479072933, 6096.969515152485, 6169.537284703665, 6171.580536476636, 6179.969100154471, 5561.777528898961, 5876.236089308362, 5906.557008224315, 5915.970420147872, 5925.288965324189, 5722.284714410699, 5817.650940943557, 5843.035899076604, 5845.830833833335, 5879.647221166743, 5884.764609415575, 6173.629582225081, 6182.536309776875, 6184.721687523982, 6219.315875253809, 4128.318827393447, 4129.967508122969, 4156.06488540076, 4165.937510937399, 4178.979105104455, 5881.7650292339895, 5926.555508336805, 5963.986122359296, 5967.940320596738, 5988.431099045583, 5667.392999220405, 5725.198472213977, 5757.481826635623, 5784.652920824596, 5799.82600521985, 5697.3448053474385, 5706.828795136153, 5751.913721294268, 5800.303963524404, 5807.680577568105, 5378.762884536501, 5459.69971651563, 5632.7183640816975, 5643.548516118619, 5662.405447428126, 5655.519280861173, 5736.311642602747, 5754.618891466102, 5755.453231942959, 5786.566007549535, 5635.633683810539, 5658.660480371191, 5665.705389317333, 5669.86602679474, 5681.806820567727], "value": 4338.794380339426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.992000079999, 814.5682788122296, 823.7569916874521, 828.9129641387658, 864.2135656552539, 14455.638609034779, 15879.761803572956, 16412.425565105223, 16480.258388372524, 16647.084410357427, 15934.20328983549, 15941.681166376666, 15964.121973291465, 15988.600284992852, 16016.519504414857, 818.4107442641304, 820.5856042698429, 846.8941382327209, 853.9914600853974, 858.4934888415834, 840.3193413335188, 842.5239739547167, 844.4848642328175, 846.0989046665312, 851.8040850604365, 876.1457578860624, 879.7052987249248, 880.885484886967, 882.0561998661435, 882.9293656507464, 862.8662557303596, 871.4771137317622, 872.4939535069644, 873.8645509945968, 874.0865795243985, 636.9968150159219, 637.4804534304527, 638.0747915522464, 639.9648019358933, 641.2433328672165, 14978.62553436162, 15129.773053404208, 15257.08457492554, 15273.923630381889, 15296.541103766906, 14516.564503064925, 14666.633334166625, 14772.409103635842, 14820.0, 14820.036697614729, 11108.00027997476, 11438.542458301741, 11529.48117334722, 11577.884221157849, 11672.70818229551, 3827.311084004878, 3834.8657796976972, 3879.0884142226555, 3929.1945151244213, 3936.488256526633, 55854.0, 55878.44121558814, 57234.141487877714, 57241.0, 58251.417485825026, 11530.942345288388, 11605.88394116065, 11654.184207105422, 11779.293242405483, 11850.585229516926, 20536.79463205379, 20722.48193795167, 20867.686984695243, 20874.37376878696, 20882.269120580706, 8505.10696376884, 8681.479111253346, 8693.608787604573, 8754.993175784739, 8878.245349145265, 4898.510148985073, 4921.926171107436, 4926.753662316942, 4974.403071631427, 5019.799208031711, 3534.2754735279204, 3623.9818800905828, 3626.8730594429594, 3639.7816131032223, 3652.160003199279, 657.3754932813846, 667.6394746836654, 687.220005293985, 687.3779229797042, 693.0989713372595, 654.0614218596329, 698.6611493425685, 720.6756959368305, 794.8926894869235, 806.6531391501593, 9082.40964337316, 9410.670626528175, 9468.147866691894, 9546.556074649583, 9641.769051554147, 660.8182749743763, 680.669875110571, 751.8045308219902, 778.7507997440878, 779.8830175473611, 4518.88702782433, 4834.903301934012, 4862.5380588844, 4885.096257192431, 4906.31311616374, 57414.0, 63053.684731576046, 66604.0, 67051.32948670548, 68447.31552684409, 57593.71203144041, 58750.0, 59011.704941475014, 60748.69625651932, 61507.38492615106, 54854.0, 55854.44145558492, 56098.0, 56150.31549053535, 56278.0, 9468.526573671426, 9599.47202903819, 9604.423734575948, 9758.0, 9839.212862970802, 34030.979070627924, 34621.65378346285, 35064.82467587646, 35172.472412914336, 36546.0, 43035.0, 46691.766541167075, 48117.0, 48283.51716482931, 48707.269390958456, 12328.568500102454, 12331.383430828244, 12335.444904979118, 12503.749925001268, 12524.436400361823, 14107.788383174466, 14237.50168744089, 14331.713365732836, 14555.05392149507, 14692.559223223321, 13530.458781648624, 13535.932320338336, 13669.863301366859, 13808.792868106786, 14165.575032749033, 13328.133671311334, 13356.732865342445, 13576.1854288743, 13837.861621383658, 14063.156210627396, 13251.271180085188, 13319.400626972003, 13425.597232083053, 13621.38703758353, 13870.375833087333, 11188.496517656888, 11295.717607059889, 11405.144614153805, 11635.069194464253, 11814.822777658514, 10759.193060520649, 11049.33703977764, 11146.832797508207, 11149.665510034712, 11197.888021119685], "value": 7128.015057526436, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 106.0, 112.0, 114.0, 114.0, 106.0, 113.0, 111.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 155.0, 207.0, 130.0, 160.0, 155.0, 133.0, 179.0, 131.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 164.0, 163.0, 163.0, 166.0, 170.0, 176.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 80.0, 161.0, 79.0, 77.0, 79.0, 77.0, 168.0, 79.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 175.0, 94.0, 93.0, 93.0, 142.0, 95.0, 93.0, 141.0], "value": 111.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 120.0, 119.0, 120.0, 119.0, 119.0, 119.0, 119.0], "value": 119.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 149.0, 149.0, 151.0, 149.0, 148.0, 149.0, 148.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 97.0, 95.0, 98.0, 96.0, 97.0, 97.0, 96.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0, 109.0, 56.0, 58.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 65.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 83.0, 81.0, 83.0, 86.0, 84.0, 81.0, 83.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 134.0, 133.0, 145.0, 138.0, 142.0, 131.0, 190.0, 139.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 173.0, 169.0, 171.0, 167.0, 170.0, 166.0, 164.0, 169.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 68.0, 67.0, 70.0, 68.0, 67.0, 66.0, 67.0], "value": 67.8, "unit": "score"}]}]} 16:18:57 INFO - Return code: 0 16:18:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:18:57 ERROR - # TBPL SUCCESS # 16:18:57 INFO - Running post-action listener: _resource_record_post_action 16:18:57 INFO - ##### 16:18:57 INFO - ##### Finished run-tests step (success) 16:18:57 INFO - ##### 16:18:57 INFO - Running post-run listener: _resource_record_post_run 16:18:58 INFO - Total resource usage - Wall time: 1187s; CPU: 26.0%; Read bytes: 12288; Write bytes: 547278848; Read time: 352; Write time: 394248 16:18:58 INFO - install - Wall time: 17s; CPU: 27.0%; Read bytes: 4096; Write bytes: 252092416; Read time: 184; Write time: 202884 16:18:58 INFO - run-tests - Wall time: 1170s; CPU: 26.0%; Read bytes: 8192; Write bytes: 295186432; Read time: 168; Write time: 191364 16:18:58 INFO - Running post-run listener: _upload_blobber_files 16:18:58 INFO - Blob upload gear active. 16:18:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:18:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:18:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:18:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:18:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:18:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:18:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:18:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:18:59 INFO - (blobuploader) - INFO - Done attempting. 16:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:00 INFO - (blobuploader) - INFO - Done attempting. 16:19:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:00 INFO - Return code: 0 16:19:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56b712fbd26030e77bfd1174040f80ba455a04a90afd4c85bc6fbde19814f6016c482f01c443f1fa8e653f48db71349014b0b45dde9d47f7db4268979a808fb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd96a8c21153dcbb00162862a360147d58d11c52b1f4062d8e213625cb444c41e9166a69b2292a487c786f980be8517ef042376990a1bfc265b30b060042fef8"} 16:19:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:00 INFO - Contents: 16:19:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56b712fbd26030e77bfd1174040f80ba455a04a90afd4c85bc6fbde19814f6016c482f01c443f1fa8e653f48db71349014b0b45dde9d47f7db4268979a808fb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd96a8c21153dcbb00162862a360147d58d11c52b1f4062d8e213625cb444c41e9166a69b2292a487c786f980be8517ef042376990a1bfc265b30b060042fef8"} 16:19:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:00 INFO - Copying logs to upload dir... 16:19:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.268132 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-11 16:18:59.875060) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 16:18:59.879140) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56b712fbd26030e77bfd1174040f80ba455a04a90afd4c85bc6fbde19814f6016c482f01c443f1fa8e653f48db71349014b0b45dde9d47f7db4268979a808fb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd96a8c21153dcbb00162862a360147d58d11c52b1f4062d8e213625cb444c41e9166a69b2292a487c786f980be8517ef042376990a1bfc265b30b060042fef8"} build_url:https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005380 build_url: 'https://queue.taskcluster.net/v1/task/E7u2GtFMRdK3hzvXNP-dBA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/56b712fbd26030e77bfd1174040f80ba455a04a90afd4c85bc6fbde19814f6016c482f01c443f1fa8e653f48db71349014b0b45dde9d47f7db4268979a808fb8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dd96a8c21153dcbb00162862a360147d58d11c52b1f4062d8e213625cb444c41e9166a69b2292a487c786f980be8517ef042376990a1bfc265b30b060042fef8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 16:18:59.894561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 16:18:59.894940) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1463006739.102506-286254697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002141 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 16:18:59.977735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 16:18:59.978043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 16:18:59.978356) ========= ========= Total master_lag: 0.16 =========