builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1465460044.53 results: success (0) buildid: 20160608223144 builduid: 0a167c9014094b94bf0ef145dacc2dd1 revision: 9c34a1f781d95fc255187762aa795728169f9a04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.528172) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.528771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.529062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.593812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.594167) ========= 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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 01:14:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-06-09 01:14:04 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129175 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.773649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.774158) ========= 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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.145278 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:04.940031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 01:14:04.940634) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9c34a1f781d95fc255187762aa795728169f9a04 --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 9c34a1f781d95fc255187762aa795728169f9a04 --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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 01:14:05,004 truncating revision to first 12 chars 2016-06-09 01:14:05,004 Setting DEBUG logging. 2016-06-09 01:14:05,005 attempt 1/10 2016-06-09 01:14:05,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9c34a1f781d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 01:14:06,373 unpacking tar archive at: mozilla-inbound-9c34a1f781d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.754708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 01:14:06.711086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:06.711500) ========= script_repo_revision: 9c34a1f781d95fc255187762aa795728169f9a04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:06.712049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:06.712372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 01:14:06.723760) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-09 01:14:06.724240) ========= /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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:14:06 INFO - MultiFileLogger online at 20160609 01:14:06 in /builds/slave/test 01:14:06 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 01:14:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:14:06 INFO - {'append_to_log': False, 01:14:06 INFO - 'base_work_dir': '/builds/slave/test', 01:14:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:14:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:14:06 INFO - 'branch': 'Mozilla-Inbound', 01:14:06 INFO - 'buildbot_json_path': 'buildprops.json', 01:14:06 INFO - 'config_files': ('talos/linux_config.py',), 01:14:06 INFO - 'default_actions': ('clobber', 01:14:06 INFO - 'read-buildbot-config', 01:14:06 INFO - 'download-and-extract', 01:14:06 INFO - 'populate-webroot', 01:14:06 INFO - 'create-virtualenv', 01:14:06 INFO - 'install', 01:14:06 INFO - 'run-tests'), 01:14:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:14:06 INFO - 'download_minidump_stackwalk': True, 01:14:06 INFO - 'download_symbols': 'ondemand', 01:14:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:14:06 INFO - 'tooltool.py': '/tools/tooltool.py', 01:14:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:14:06 INFO - '/tools/misc-python/virtualenv.py')}, 01:14:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:14:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:14:06 INFO - 'installer_path': 'installer.exe', 01:14:06 INFO - 'log_level': 'info', 01:14:06 INFO - 'log_name': 'talos', 01:14:06 INFO - 'log_to_console': True, 01:14:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:14:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:14:06 INFO - 'opt_config_files': (), 01:14:06 INFO - 'pip_index': False, 01:14:06 INFO - 'sps_profile': False, 01:14:06 INFO - 'sps_profile_interval': 0, 01:14:06 INFO - 'suite': 'dromaeojs-e10s', 01:14:06 INFO - 'system_bits': '32', 01:14:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:14:06 INFO - 'title': 'talos-linux64-ix-043', 01:14:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:14:06 INFO - 'use_talos_json': True, 01:14:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:14:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:14:06 INFO - 'work_dir': 'build'} 01:14:06 INFO - ##### 01:14:06 INFO - ##### Running clobber step. 01:14:06 INFO - ##### 01:14:06 INFO - Running pre-action listener: _resource_record_pre_action 01:14:06 INFO - Running main action method: clobber 01:14:06 INFO - rmtree: /builds/slave/test/build 01:14:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:14:12 INFO - Running post-action listener: _resource_record_post_action 01:14:12 INFO - ##### 01:14:12 INFO - ##### Finished clobber step (success) 01:14:12 INFO - ##### 01:14:12 INFO - ##### 01:14:12 INFO - ##### Running read-buildbot-config step. 01:14:12 INFO - ##### 01:14:12 INFO - Running pre-action listener: _resource_record_pre_action 01:14:12 INFO - Running main action method: read_buildbot_config 01:14:12 INFO - Using buildbot properties: 01:14:12 INFO - { 01:14:12 INFO - "project": "", 01:14:12 INFO - "product": "firefox", 01:14:12 INFO - "script_repo_revision": "production", 01:14:12 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:14:12 INFO - "repository": "", 01:14:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:14:12 INFO - "buildid": "20160608223144", 01:14:12 INFO - "pgo_build": "True", 01:14:12 INFO - "basedir": "/builds/slave/test", 01:14:12 INFO - "buildnumber": 839, 01:14:12 INFO - "slavename": "talos-linux64-ix-043", 01:14:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:14:12 INFO - "platform": "ubuntu64_hw", 01:14:12 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:14:12 INFO - "branch": "mozilla-inbound", 01:14:12 INFO - "repo_path": "integration/mozilla-inbound", 01:14:12 INFO - "revision": "9c34a1f781d95fc255187762aa795728169f9a04", 01:14:12 INFO - "stage_platform": "linux64-pgo", 01:14:12 INFO - "builduid": "0a167c9014094b94bf0ef145dacc2dd1", 01:14:12 INFO - "slavebuilddir": "test" 01:14:12 INFO - } 01:14:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:14:12 INFO - Running post-action listener: _resource_record_post_action 01:14:12 INFO - ##### 01:14:12 INFO - ##### Finished read-buildbot-config step (success) 01:14:12 INFO - ##### 01:14:12 INFO - ##### 01:14:12 INFO - ##### Running download-and-extract step. 01:14:12 INFO - ##### 01:14:12 INFO - Running pre-action listener: _resource_record_pre_action 01:14:12 INFO - Running main action method: download_and_extract 01:14:12 INFO - mkdir: /builds/slave/test/build/tests 01:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:12 INFO - https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:14:12 INFO - Downloaded 1361 bytes. 01:14:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:14:12 INFO - Using the following test package requirements: 01:14:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:14:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:14:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'jsshell-linux-x86_64.zip'], 01:14:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:14:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:14:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:14:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:14:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:14:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:14:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:14:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:12 INFO - https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:18 INFO - Downloaded 24451574 bytes. 01:14:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:19 INFO - Return code: 0 01:14:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:14:19 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')]} 01:14:19 INFO - https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:14:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:14:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:14:20 INFO - Downloaded 24451574 bytes. 01:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:14:22 INFO - Return code: 0 01:14:22 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')]} 01:14:22 INFO - https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:14:23 INFO - Downloaded 10833377 bytes. 01:14:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:14:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:14:23 INFO - Return code: 0 01:14:23 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')]} 01:14:23 INFO - https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:14:24 INFO - Downloaded 59339198 bytes. 01:14:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:24 INFO - mkdir: /builds/slave/test/properties 01:14:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:14:24 INFO - Writing to file /builds/slave/test/properties/build_url 01:14:24 INFO - Contents: 01:14:24 INFO - build_url:https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:14:25 INFO - Running post-action listener: _resource_record_post_action 01:14:25 INFO - Running post-action listener: set_extra_try_arguments 01:14:25 INFO - ##### 01:14:25 INFO - ##### Finished download-and-extract step (success) 01:14:25 INFO - ##### 01:14:25 INFO - ##### 01:14:25 INFO - ##### Running populate-webroot step. 01:14:25 INFO - ##### 01:14:25 INFO - Running pre-action listener: _resource_record_pre_action 01:14:25 INFO - Running main action method: populate_webroot 01:14:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:14:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:14:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:14:25 INFO - '--tppagecycles', 01:14:25 INFO - '7'], 01:14:25 INFO - 'tests': ['tsvgm']}}, 01:14:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:14:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:14:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:14:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:14:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:14:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['damp', 'tps']}, 01:14:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'tests': ['damp', 'tps']}, 01:14:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['dromaeo_dom']}, 01:14:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:14:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'other-e10s': {'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['a11yr', 01:14:25 INFO - 'ts_paint', 01:14:25 INFO - 'tpaint', 01:14:25 INFO - 'sessionrestore', 01:14:25 INFO - 'sessionrestore_no_auto_restore', 01:14:25 INFO - 'tabpaint']}, 01:14:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['tsvgx', 01:14:25 INFO - 'tsvgr_opacity', 01:14:25 INFO - 'tart', 01:14:25 INFO - 'tscrollx', 01:14:25 INFO - 'cart']}, 01:14:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:14:25 INFO - 'tsvgr_opacity', 01:14:25 INFO - 'tart', 01:14:25 INFO - 'tscrollx', 01:14:25 INFO - 'cart']}, 01:14:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'talos_options': ['--disable-e10s'], 01:14:25 INFO - 'tests': ['tp5o']}, 01:14:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'tests': ['tp5o']}, 01:14:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'talos_options': ['--disable-e10s', 01:14:25 INFO - '--xperf_path', 01:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:25 INFO - 'tests': ['tp5n']}, 01:14:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:14:25 INFO - 'talos_options': ['--xperf_path', 01:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:14:25 INFO - 'tests': ['tp5n']}}, 01:14:25 INFO - 'talos.zip': {'path': '', 01:14:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:14:25 INFO - Running post-action listener: _resource_record_post_action 01:14:25 INFO - ##### 01:14:25 INFO - ##### Finished populate-webroot step (success) 01:14:25 INFO - ##### 01:14:25 INFO - ##### 01:14:25 INFO - ##### Running create-virtualenv step. 01:14:25 INFO - ##### 01:14:25 INFO - Running pre-action listener: _resource_record_pre_action 01:14:25 INFO - Running main action method: create_virtualenv 01:14:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:14:25 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 01:14:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:14:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:14:25 INFO - Using real prefix '/usr' 01:14:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:14:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:14:29 INFO - Installing pip.................done. 01:14:29 INFO - Return code: 0 01:14:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:29 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:29 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 01:14:29 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 01:14:29 INFO - Using env: {'DISPLAY': ':0', 01:14:29 INFO - 'HOME': '/home/cltbld', 01:14:29 INFO - 'LANG': 'en_US.UTF-8', 01:14:29 INFO - 'LANGUAGE': 'en_US:en', 01:14:29 INFO - 'LOGNAME': 'cltbld', 01:14:29 INFO - 'MAIL': '/var/mail/cltbld', 01:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:29 INFO - 'MOZ_NO_REMOTE': '1', 01:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:29 INFO - 'NO_EM_RESTART': '1', 01:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:29 INFO - 'PWD': '/builds/slave/test', 01:14:29 INFO - 'SHELL': '/bin/bash', 01:14:29 INFO - 'SHLVL': '1', 01:14:29 INFO - 'TERM': 'linux', 01:14:29 INFO - 'TMOUT': '86400', 01:14:29 INFO - 'USER': 'cltbld', 01:14:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:29 INFO - '_': '/tools/buildbot/bin/python'} 01:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:30 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 01:14:30 INFO - Cleaning up... 01:14:30 INFO - Return code: 0 01:14:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:30 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:30 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>=3.1.1'] in /builds/slave/test/build 01:14:30 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>=3.1.1 01:14:30 INFO - Using env: {'DISPLAY': ':0', 01:14:30 INFO - 'HOME': '/home/cltbld', 01:14:30 INFO - 'LANG': 'en_US.UTF-8', 01:14:30 INFO - 'LANGUAGE': 'en_US:en', 01:14:30 INFO - 'LOGNAME': 'cltbld', 01:14:30 INFO - 'MAIL': '/var/mail/cltbld', 01:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:30 INFO - 'MOZ_NO_REMOTE': '1', 01:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:30 INFO - 'NO_EM_RESTART': '1', 01:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:30 INFO - 'PWD': '/builds/slave/test', 01:14:30 INFO - 'SHELL': '/bin/bash', 01:14:30 INFO - 'SHLVL': '1', 01:14:30 INFO - 'TERM': 'linux', 01:14:30 INFO - 'TMOUT': '86400', 01:14:30 INFO - 'USER': 'cltbld', 01:14:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:30 INFO - '_': '/tools/buildbot/bin/python'} 01:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:30 INFO - Downloading/unpacking psutil>=3.1.1 01:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:14:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:32 INFO - Installing collected packages: psutil 01:14:32 INFO - Running setup.py install for psutil 01:14:32 INFO - building 'psutil._psutil_linux' extension 01:14:32 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 01:14:34 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 01:14:34 INFO - building 'psutil._psutil_posix' extension 01:14:34 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 01:14:34 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 01:14:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:14:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:14:34 INFO - Successfully installed psutil 01:14:34 INFO - Cleaning up... 01:14:34 INFO - Return code: 0 01:14:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:34 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:34 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.3'] in /builds/slave/test/build 01:14:34 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.3 01:14:34 INFO - Using env: {'DISPLAY': ':0', 01:14:34 INFO - 'HOME': '/home/cltbld', 01:14:34 INFO - 'LANG': 'en_US.UTF-8', 01:14:34 INFO - 'LANGUAGE': 'en_US:en', 01:14:34 INFO - 'LOGNAME': 'cltbld', 01:14:34 INFO - 'MAIL': '/var/mail/cltbld', 01:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:34 INFO - 'MOZ_NO_REMOTE': '1', 01:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:34 INFO - 'NO_EM_RESTART': '1', 01:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:34 INFO - 'PWD': '/builds/slave/test', 01:14:34 INFO - 'SHELL': '/bin/bash', 01:14:34 INFO - 'SHLVL': '1', 01:14:34 INFO - 'TERM': 'linux', 01:14:34 INFO - 'TMOUT': '86400', 01:14:34 INFO - 'USER': 'cltbld', 01:14:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:34 INFO - '_': '/tools/buildbot/bin/python'} 01:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:14:35 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 01:14:35 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 01:14:35 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 01:14:35 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 01:14:35 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 01:14:35 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 01:14:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:14:36 INFO - Installing collected packages: mozsystemmonitor 01:14:36 INFO - Running setup.py install for mozsystemmonitor 01:14:37 INFO - Successfully installed mozsystemmonitor 01:14:37 INFO - Cleaning up... 01:14:37 INFO - Return code: 0 01:14:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:37 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:37 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==2.5.1'] in /builds/slave/test/build 01:14:37 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==2.5.1 01:14:37 INFO - Using env: {'DISPLAY': ':0', 01:14:37 INFO - 'HOME': '/home/cltbld', 01:14:37 INFO - 'LANG': 'en_US.UTF-8', 01:14:37 INFO - 'LANGUAGE': 'en_US:en', 01:14:37 INFO - 'LOGNAME': 'cltbld', 01:14:37 INFO - 'MAIL': '/var/mail/cltbld', 01:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:37 INFO - 'MOZ_NO_REMOTE': '1', 01:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:37 INFO - 'NO_EM_RESTART': '1', 01:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:37 INFO - 'PWD': '/builds/slave/test', 01:14:37 INFO - 'SHELL': '/bin/bash', 01:14:37 INFO - 'SHLVL': '1', 01:14:37 INFO - 'TERM': 'linux', 01:14:37 INFO - 'TMOUT': '86400', 01:14:37 INFO - 'USER': 'cltbld', 01:14:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:37 INFO - '_': '/tools/buildbot/bin/python'} 01:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:37 INFO - Downloading/unpacking jsonschema==2.5.1 01:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:14:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:39 INFO - warning: no files found matching '*.txt' 01:14:39 INFO - no previously-included directories found matching 'build' 01:14:39 INFO - no previously-included directories found matching 'dist' 01:14:39 INFO - no previously-included directories found matching '.git*' 01:14:39 INFO - Installing collected packages: jsonschema, functools32 01:14:39 INFO - Running setup.py install for functools32 01:14:39 INFO - warning: no files found matching '*.txt' 01:14:39 INFO - no previously-included directories found matching 'build' 01:14:39 INFO - no previously-included directories found matching 'dist' 01:14:39 INFO - no previously-included directories found matching '.git*' 01:14:39 INFO - Successfully installed jsonschema functools32 01:14:39 INFO - Cleaning up... 01:14:39 INFO - Return code: 0 01:14:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:39 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:39 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 01:14:39 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 01:14:39 INFO - Using env: {'DISPLAY': ':0', 01:14:39 INFO - 'HOME': '/home/cltbld', 01:14:39 INFO - 'LANG': 'en_US.UTF-8', 01:14:39 INFO - 'LANGUAGE': 'en_US:en', 01:14:39 INFO - 'LOGNAME': 'cltbld', 01:14:39 INFO - 'MAIL': '/var/mail/cltbld', 01:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:39 INFO - 'MOZ_NO_REMOTE': '1', 01:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:39 INFO - 'NO_EM_RESTART': '1', 01:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:39 INFO - 'PWD': '/builds/slave/test', 01:14:39 INFO - 'SHELL': '/bin/bash', 01:14:39 INFO - 'SHLVL': '1', 01:14:39 INFO - 'TERM': 'linux', 01:14:39 INFO - 'TMOUT': '86400', 01:14:39 INFO - 'USER': 'cltbld', 01:14:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:39 INFO - '_': '/tools/buildbot/bin/python'} 01:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:39 INFO - Downloading/unpacking blobuploader==1.2.4 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:39 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 01:14:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:14:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:14:41 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 01:14:41 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 01:14:41 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 01:14:41 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 01:14:41 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 01:14:41 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 01:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:14:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:42 INFO - Downloading docopt-0.6.1.tar.gz 01:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:14:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:14:42 INFO - Running setup.py install for blobuploader 01:14:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:14:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:14:42 INFO - Running setup.py install for requests 01:14:43 INFO - Running setup.py install for docopt 01:14:43 INFO - Successfully installed blobuploader requests docopt 01:14:43 INFO - Cleaning up... 01:14:43 INFO - Return code: 0 01:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:43 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:43 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 01:14:43 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 01:14:43 INFO - Using env: {'DISPLAY': ':0', 01:14:43 INFO - 'HOME': '/home/cltbld', 01:14:43 INFO - 'LANG': 'en_US.UTF-8', 01:14:43 INFO - 'LANGUAGE': 'en_US:en', 01:14:43 INFO - 'LOGNAME': 'cltbld', 01:14:43 INFO - 'MAIL': '/var/mail/cltbld', 01:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:43 INFO - 'MOZ_NO_REMOTE': '1', 01:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:43 INFO - 'NO_EM_RESTART': '1', 01:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:43 INFO - 'PWD': '/builds/slave/test', 01:14:43 INFO - 'SHELL': '/bin/bash', 01:14:43 INFO - 'SHLVL': '1', 01:14:43 INFO - 'TERM': 'linux', 01:14:43 INFO - 'TMOUT': '86400', 01:14:43 INFO - 'USER': 'cltbld', 01:14:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:43 INFO - '_': '/tools/buildbot/bin/python'} 01:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:43 INFO - Running setup.py (path:/tmp/pip-dNeThU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:43 INFO - Running setup.py (path:/tmp/pip-CWBBUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:43 INFO - Running setup.py (path:/tmp/pip-PgJkH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:43 INFO - Running setup.py (path:/tmp/pip-6O3eCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:43 INFO - Running setup.py (path:/tmp/pip-4oKMtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:43 INFO - Running setup.py (path:/tmp/pip-jHUTth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:43 INFO - Running setup.py (path:/tmp/pip-SMxHRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:43 INFO - Running setup.py (path:/tmp/pip-Qb2GWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:43 INFO - Running setup.py (path:/tmp/pip-aY8ZIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:44 INFO - Running setup.py (path:/tmp/pip-oSps8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:44 INFO - Running setup.py (path:/tmp/pip-C74x58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:44 INFO - Running setup.py (path:/tmp/pip-yQm9qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:44 INFO - Running setup.py (path:/tmp/pip-wo5Hse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:44 INFO - Running setup.py (path:/tmp/pip-Z1nUKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:44 INFO - Running setup.py (path:/tmp/pip-Jfu0Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:44 INFO - Running setup.py (path:/tmp/pip-XHn4ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:44 INFO - Running setup.py (path:/tmp/pip-5gFQsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:14:44 INFO - Running setup.py install for manifestparser 01:14:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:14:44 INFO - Running setup.py install for mozcrash 01:14:44 INFO - Running setup.py install for mozdebug 01:14:44 INFO - Running setup.py install for mozdevice 01:14:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozfile 01:14:45 INFO - Running setup.py install for mozhttpd 01:14:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozinfo 01:14:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozInstall 01:14:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozleak 01:14:45 INFO - Running setup.py install for mozlog 01:14:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for moznetwork 01:14:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozprocess 01:14:45 INFO - Running setup.py install for mozprofile 01:14:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:14:45 INFO - Running setup.py install for mozrunner 01:14:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:14:46 INFO - Running setup.py install for mozscreenshot 01:14:46 INFO - Running setup.py install for moztest 01:14:46 INFO - Running setup.py install for mozversion 01:14:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:14:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:14:46 INFO - Cleaning up... 01:14:46 INFO - Return code: 0 01:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:46 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')]} 01:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:46 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')]} 01:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:46 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:46 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 01:14:46 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 01:14:46 INFO - Using env: {'DISPLAY': ':0', 01:14:46 INFO - 'HOME': '/home/cltbld', 01:14:46 INFO - 'LANG': 'en_US.UTF-8', 01:14:46 INFO - 'LANGUAGE': 'en_US:en', 01:14:46 INFO - 'LOGNAME': 'cltbld', 01:14:46 INFO - 'MAIL': '/var/mail/cltbld', 01:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:46 INFO - 'MOZ_NO_REMOTE': '1', 01:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:46 INFO - 'NO_EM_RESTART': '1', 01:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:46 INFO - 'PWD': '/builds/slave/test', 01:14:46 INFO - 'SHELL': '/bin/bash', 01:14:46 INFO - 'SHLVL': '1', 01:14:46 INFO - 'TERM': 'linux', 01:14:46 INFO - 'TMOUT': '86400', 01:14:46 INFO - 'USER': 'cltbld', 01:14:46 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:46 INFO - '_': '/tools/buildbot/bin/python'} 01:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:14:46 INFO - Running setup.py (path:/tmp/pip-g2MOmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:14:46 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)) 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:14:46 INFO - Running setup.py (path:/tmp/pip-KMafo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:14:46 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)) 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:14:46 INFO - Running setup.py (path:/tmp/pip-hdK7O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:14:46 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)) 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:14:46 INFO - Running setup.py (path:/tmp/pip-cb1C38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:14:46 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)) 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:14:46 INFO - Running setup.py (path:/tmp/pip-gpIEHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:14:46 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)) 01:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:14:46 INFO - Running setup.py (path:/tmp/pip-liUXkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:14:47 INFO - Running setup.py (path:/tmp/pip-jPJlVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:14:47 INFO - Running setup.py (path:/tmp/pip-euDlpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:14:47 INFO - Running setup.py (path:/tmp/pip-IA25la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:14:47 INFO - Running setup.py (path:/tmp/pip-mXSAGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:14:47 INFO - Running setup.py (path:/tmp/pip-Msau3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:14:47 INFO - Running setup.py (path:/tmp/pip-DHjJtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:14:47 INFO - Running setup.py (path:/tmp/pip-2qI8fR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:14:47 INFO - Running setup.py (path:/tmp/pip-cP4qf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:47 INFO - Running setup.py (path:/tmp/pip-gv_4sX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:14:47 INFO - Running setup.py (path:/tmp/pip-xvg4pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:14:47 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)) 01:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:14:47 INFO - Running setup.py (path:/tmp/pip-Zn8KXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:14:47 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)) 01:14:47 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)) 01:14:47 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)) 01:14:47 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)) 01:14:47 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)) 01:14:47 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)) 01:14:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:14:49 INFO - Downloading blessings-1.6.tar.gz 01:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:14:49 INFO - Installing collected packages: blessings 01:14:49 INFO - Running setup.py install for blessings 01:14:49 INFO - Successfully installed blessings 01:14:49 INFO - Cleaning up... 01:14:50 INFO - Return code: 0 01:14:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:50 INFO - Reading from file tmpfile_stdout 01:14:50 INFO - Current package versions: 01:14:50 INFO - argparse == 1.2.1 01:14:50 INFO - blessings == 1.6 01:14:50 INFO - blobuploader == 1.2.4 01:14:50 INFO - docopt == 0.6.1 01:14:50 INFO - functools32 == 3.2.3-2 01:14:50 INFO - jsonschema == 2.5.1 01:14:50 INFO - manifestparser == 1.1 01:14:50 INFO - mozInstall == 1.12 01:14:50 INFO - mozcrash == 0.17 01:14:50 INFO - mozdebug == 0.1 01:14:50 INFO - mozdevice == 0.48 01:14:50 INFO - mozfile == 1.2 01:14:50 INFO - mozhttpd == 0.7 01:14:50 INFO - mozinfo == 0.9 01:14:50 INFO - mozleak == 0.1 01:14:50 INFO - mozlog == 3.2 01:14:50 INFO - moznetwork == 0.27 01:14:50 INFO - mozprocess == 0.22 01:14:50 INFO - mozprofile == 0.28 01:14:50 INFO - mozrunner == 6.11 01:14:50 INFO - mozscreenshot == 0.1 01:14:50 INFO - mozsystemmonitor == 0.3 01:14:50 INFO - moztest == 0.7 01:14:50 INFO - mozversion == 1.4 01:14:50 INFO - psutil == 3.1.1 01:14:50 INFO - requests == 1.2.3 01:14:50 INFO - wsgiref == 0.1.2 01:14:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:14:50 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')]} 01:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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')]} 01:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:50 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 01:14:50 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 01:14:50 INFO - Using env: {'DISPLAY': ':0', 01:14:50 INFO - 'HOME': '/home/cltbld', 01:14:50 INFO - 'LANG': 'en_US.UTF-8', 01:14:50 INFO - 'LANGUAGE': 'en_US:en', 01:14:50 INFO - 'LOGNAME': 'cltbld', 01:14:50 INFO - 'MAIL': '/var/mail/cltbld', 01:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:50 INFO - 'MOZ_NO_REMOTE': '1', 01:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:50 INFO - 'NO_EM_RESTART': '1', 01:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:50 INFO - 'PWD': '/builds/slave/test', 01:14:50 INFO - 'SHELL': '/bin/bash', 01:14:50 INFO - 'SHLVL': '1', 01:14:50 INFO - 'TERM': 'linux', 01:14:50 INFO - 'TMOUT': '86400', 01:14:50 INFO - 'USER': 'cltbld', 01:14:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:50 INFO - '_': '/tools/buildbot/bin/python'} 01:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 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)) 01:14:50 INFO - Cleaning up... 01:14:50 INFO - Return code: 0 01:14:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:14:50 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')]} 01:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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')]} 01:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:50 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 01:14:50 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 01:14:50 INFO - Using env: {'DISPLAY': ':0', 01:14:50 INFO - 'HOME': '/home/cltbld', 01:14:50 INFO - 'LANG': 'en_US.UTF-8', 01:14:50 INFO - 'LANGUAGE': 'en_US:en', 01:14:50 INFO - 'LOGNAME': 'cltbld', 01:14:50 INFO - 'MAIL': '/var/mail/cltbld', 01:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:50 INFO - 'MOZ_NO_REMOTE': '1', 01:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:50 INFO - 'NO_EM_RESTART': '1', 01:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:50 INFO - 'PWD': '/builds/slave/test', 01:14:50 INFO - 'SHELL': '/bin/bash', 01:14:50 INFO - 'SHLVL': '1', 01:14:50 INFO - 'TERM': 'linux', 01:14:50 INFO - 'TMOUT': '86400', 01:14:50 INFO - 'USER': 'cltbld', 01:14:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:50 INFO - '_': '/tools/buildbot/bin/python'} 01:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:14:50 INFO - Cleaning up... 01:14:50 INFO - Return code: 0 01:14:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:14:50 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')]} 01:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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')]} 01:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14:50 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 0x7febb19fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2650020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, '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': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', '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 01:14:50 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 01:14:50 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 01:14:50 INFO - Using env: {'DISPLAY': ':0', 01:14:50 INFO - 'HOME': '/home/cltbld', 01:14:50 INFO - 'LANG': 'en_US.UTF-8', 01:14:50 INFO - 'LANGUAGE': 'en_US:en', 01:14:50 INFO - 'LOGNAME': 'cltbld', 01:14:50 INFO - 'MAIL': '/var/mail/cltbld', 01:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:50 INFO - 'MOZ_NO_REMOTE': '1', 01:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:50 INFO - 'NO_EM_RESTART': '1', 01:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:50 INFO - 'PWD': '/builds/slave/test', 01:14:50 INFO - 'SHELL': '/bin/bash', 01:14:50 INFO - 'SHLVL': '1', 01:14:50 INFO - 'TERM': 'linux', 01:14:50 INFO - 'TMOUT': '86400', 01:14:50 INFO - 'USER': 'cltbld', 01:14:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:50 INFO - '_': '/tools/buildbot/bin/python'} 01:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:50 INFO - Downloading/unpacking flake8 01:14:50 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 01:14:50 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 01:14:50 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 01:14:50 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 01:14:50 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 01:14:50 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 01:14:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:14:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:14:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:14:53 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 01:14:53 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 01:14:53 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 01:14:53 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 01:14:53 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 01:14:53 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 01:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:14:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:53 INFO - no previously-included directories found matching 'docs/_build' 01:14:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:14:53 INFO - Running setup.py install for pep8 01:14:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:53 INFO - no previously-included directories found matching 'docs/_build' 01:14:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:14:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:14:53 INFO - Cleaning up... 01:14:53 INFO - Return code: 0 01:14:53 INFO - Running post-action listener: _resource_record_post_action 01:14:53 INFO - Running post-action listener: _start_resource_monitoring 01:14:53 INFO - Starting resource monitoring. 01:14:53 INFO - ##### 01:14:53 INFO - ##### Finished create-virtualenv step (success) 01:14:53 INFO - ##### 01:14:53 INFO - ##### 01:14:53 INFO - ##### Running install step. 01:14:53 INFO - ##### 01:14:53 INFO - Running pre-action listener: _resource_record_pre_action 01:14:53 INFO - Running main action method: install 01:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:53 INFO - Reading from file tmpfile_stdout 01:14:53 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:54 INFO - Reading from file tmpfile_stdout 01:14:54 INFO - Output received: 01:14:54 INFO - Usage: mozinstall [options] installer 01:14:54 INFO - Options: 01:14:54 INFO - -h, --help show this help message and exit 01:14:54 INFO - -d DEST, --destination=DEST 01:14:54 INFO - Directory to install application into. [default: 01:14:54 INFO - "/builds/slave/test"] 01:14:54 INFO - --app=APP Application being installed. [default: firefox] 01:14:54 INFO - mkdir: /builds/slave/test/build/application 01:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:15:10 INFO - Reading from file tmpfile_stdout 01:15:10 INFO - Output received: 01:15:10 INFO - /builds/slave/test/build/application/firefox/firefox 01:15:10 INFO - Running post-action listener: _resource_record_post_action 01:15:10 INFO - ##### 01:15:10 INFO - ##### Finished install step (success) 01:15:10 INFO - ##### 01:15:10 INFO - ##### 01:15:10 INFO - ##### Running run-tests step. 01:15:10 INFO - ##### 01:15:10 INFO - Running pre-action listener: _resource_record_pre_action 01:15:10 INFO - Running main action method: run_tests 01:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:15:10 INFO - Python 2.7.3 01:15:10 INFO - Return code: 0 01:15:10 INFO - grabbing minidump binary from tooltool 01:15:10 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')]} 01:15:10 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 0x26e22e0>, '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 0x264e140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x264e5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:15:10 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 01:15:10 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 01:15:10 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 01:15:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:15:11 INFO - Return code: 0 01:15:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:15:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:15:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:15:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:15:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:15:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:15:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:15:11 INFO - Return code: 0 01:15:11 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/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:15:11 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/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 01:15:11 INFO - Using env: {'DISPLAY': ':0', 01:15:11 INFO - 'HOME': '/home/cltbld', 01:15:11 INFO - 'LANG': 'en_US.UTF-8', 01:15:11 INFO - 'LANGUAGE': 'en_US:en', 01:15:11 INFO - 'LOGNAME': 'cltbld', 01:15:11 INFO - 'MAIL': '/var/mail/cltbld', 01:15:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:15:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:15:11 INFO - 'MOZ_NO_REMOTE': '1', 01:15:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:15:11 INFO - 'NO_EM_RESTART': '1', 01:15:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:15:11 INFO - 'PWD': '/builds/slave/test', 01:15:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:15:11 INFO - 'SHELL': '/bin/bash', 01:15:11 INFO - 'SHLVL': '1', 01:15:11 INFO - 'TERM': 'linux', 01:15:11 INFO - 'TMOUT': '86400', 01:15:11 INFO - 'USER': 'cltbld', 01:15:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912', 01:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:15:11 INFO - '_': '/tools/buildbot/bin/python'} 01:15:11 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/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 01:15:12 INFO - mozversion application_buildid: 20160608223144 01:15:12 INFO - mozversion application_changeset: 9c34a1f781d95fc255187762aa795728169f9a04 01:15:12 INFO - mozversion application_display_name: Nightly 01:15:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:15:12 INFO - mozversion application_name: Firefox 01:15:12 INFO - mozversion application_remotingname: firefox 01:15:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:12 INFO - mozversion application_vendor: Mozilla 01:15:12 INFO - mozversion application_version: 50.0a1 01:15:12 INFO - mozversion platform_buildid: 20160608223144 01:15:12 INFO - mozversion platform_changeset: 9c34a1f781d95fc255187762aa795728169f9a04 01:15:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:15:12 INFO - mozversion platform_version: 50.0a1 01:15:12 INFO - using testdate: 1465460112 01:15:12 INFO - actual date: 1465460112 01:15:12 INFO - starting webserver on 'localhost:59539' 01:15:12 INFO - SUITE-START | Running 2 tests 01:15:12 INFO - TEST-START | dromaeo_css 01:15:12 INFO - operating with platform_type : linux_ 01:15:12 INFO - Initialising browser for dromaeo_css test... 01:15:12 INFO - TEST-INFO | started process 3361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDdilv/profile http://localhost:59539/getInfo.html) 01:15:19 INFO - PROCESS | 3361 | __metrics Screen width/height:1600/1200 01:15:19 INFO - PROCESS | 3361 | colorDepth:24 01:15:19 INFO - PROCESS | 3361 | Browser inner width/height: 1024/697 01:15:19 INFO - PROCESS | 3361 | __metrics 01:15:20 ERROR - PROCESS | 3361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:15:21 INFO - TEST-INFO | 3361: exit 0 01:15:21 INFO - Browser initialized. 01:15:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:15:21 INFO - TEST-INFO | started process 3483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDdilv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:15:33 INFO - PROCESS | 3483 | RSS: Main: 184950784 01:15:33 INFO - PROCESS | 3483 | 01:16:22 INFO - PROCESS | 3483 | 1465460182717 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] 01:18:30 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59539/tests/dromaeo/cssquery-ext.html) 01:18:31 INFO - PROCESS | 3483 | RSS: Main: 187609088 01:18:31 INFO - PROCESS | 3483 | 01:21:33 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-ext.html (next: http://localhost:59539/tests/dromaeo/cssquery-jquery.html) 01:21:34 INFO - PROCESS | 3483 | RSS: Main: 187133952 01:21:34 INFO - PROCESS | 3483 | 01:24:36 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59539/tests/dromaeo/cssquery-mootools.html) 01:24:36 INFO - PROCESS | 3483 | RSS: Main: 188329984 01:24:36 INFO - PROCESS | 3483 | 01:27:38 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59539/tests/dromaeo/cssquery-prototype.html) 01:27:39 INFO - PROCESS | 3483 | RSS: Main: 185810944 01:27:39 INFO - PROCESS | 3483 | 01:30:41 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59539/tests/dromaeo/cssquery-yui.html) 01:30:42 INFO - PROCESS | 3483 | RSS: Main: 187879424 01:30:42 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:59539/tests/dromaeo/cssquery-yui.html (next: http://localhost:59539/tests/dromaeo/cssquery-dojo.html) 01:33:44 INFO - PROCESS | 3483 | RSS: Main: 188743680 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | __start_tp_report 01:33:44 INFO - PROCESS | 3483 | _x_x_mozilla_page_load 01:33:44 INFO - PROCESS | 3483 | _x_x_mozilla_page_load_details 01:33:44 INFO - PROCESS | 3483 | |i|pagename|runs| 01:33:44 INFO - PROCESS | 3483 | |0;dojo.html;3087.5214341777023;3138.7802853800213;3161.383530211608;3172.0642410488904;3198.0246024962394;5415.485528874756;5454.4545545445435;5469.34367875855;5524.66851988881;5559.471850174237;5318.335208098988;5348.197770334452;5433.592480563963;5477.123660214366;5481.862953426166;4930.926036109452;4982.701037937717;5049.24261360797;5087.9745601272125;5137.229415587654;4956.876078098058;5105.770240339194;5129.820456284031;5140.640155189139;5143.022825663131;4871.415430148387;4951.108800415924;4954.925676114861;4983.302337672729;4992.051510213066;4966.478519755446;4969.204927211665;4976.178930476467;4979.875503112451;5070.594352451832;4943.728094954776;4944.53026962438;4961.603071754251;4973.104841128596;5018.89962200754;5260.789568417297;5342.652727572696;5348.384935732402;5442.292501974757;5478.753456094445;5801.071828507418;5809.970950145264;5815.621984570989;5819.7672093116225;5836.2996440427;5731.856703582402;5855.648661080349;5858.297004359504;5873.412658734135;5882.97058514709;5469.781208751645;5484.424135465759;5536.640118392332;5593.972030139905;5611.466910643441;6043.8186854394435;6072.21061262042;6074.453299203093;6079.908801367983;6087.239095113111;5628.6622802631155;5778.104393818965;5849.64902105875;5849.853753656193;5874.530037596982;5857;5953.553483488756;5972.85067873298;5975.014122669798;6026.9095963560585;5634.32388113429;5813.970930145322;5911.527077833763;5912.142739302777;5915.3788852170765;5666.801661941812;5811.186433899257;5915.585908986416;5957.553183511254;5973.133895585116;4477.462704475483;4510.864674059783;4514.909701805946;4540.6821522493765;4552.180607490617;3989.6608788252743;3995;4007.6793856491413;4023.295923213426;4026;5520.834374968757;5577.05190117681;5593.720313984284;5634.577406694432;5635.718214089279;5887.852803679856;5888.205092312483;5890.087036509348;5906.232189815382;5924.052151655715;5550.139728342114;5605.971970140205;5608.130739735348;5615.18579805934;5618.213450116987;4937.333459982857;5032.798688052437;5108.821191258288;5116.437191908887;5119.10415677255;6098.72555734993;6132.478739307119;6134.8159555213415;6157.168782214344;6168.167297414881;5706.771729130788;5946.791862284886;5961.493273071837;5968.194293770285;5969.552283578836;5968.880622387441;6043.486303664062;6066.423689749467;6090.177825993612;6109.144719739329;5803.680797556006;5808.883822323445;5814.592978491465;5818.854528636818;5827.24245848037;5733.913991290217;5870.970645146917;5881.911771323348;5882.000059989898;5918.644881306963;5602.047651899105;5775.566832487664;5868.413158684098;5893.675847828411;5929.792457263975;5710.400407957105;5733.283339582552;5770.769169233184;5856.180134781219;5857.912131318119;5497.257870187634;5743.4543718346695;5760.510356619734;5762.2221000164445;5764.740586673526;5740.052891272893;5808.5353171747;5829.6793676346515;5868.882622347614;5870.618409803349;5681.147827825859;5703.828885133453;5713.942860571341;5722.599418040697;5735.9139612905 01:33:44 INFO - PROCESS | 3483 | |1;ext.html;549.1817192383347;595.2291782142125;612.1032687113378;613.5674349583543;615.1111643674892;41228.38157427641;42338.15323693524;42766.358504622454;46008.30987535189;46581.53418465814;44551.55448445515;45187.774061129734;45188.548114518846;45259;45459.09081818361;8902.643894244238;9027;9056.411333263317;9063.728088157366;9071.818563628723;8810.955945220265;8905.599248033821;8908.73273801787;8914.777130571756;8930.240929520998;8917.152870477326;8950.507722075283;8953.23897468716;8997.820043599124;9006.954965225164;8829.426087304304;8841.911580884238;8844.11558844117;8844.646214151426;8844.73465796027;8857.070007649232;8940.776480587972;8944.910550894472;8952.820943581091;8961.507117108556;42170;42553;42605.78697106495;42652.146957061;42758;3651.3427583035045;3690.8892733218045;3772.1512659651635;4148;4167.6457501112445;31784.841075794706;32193;32645.6735432645;32819.17952051194;33023.6697633023;4399.36209249657;4423.690341676084;4441.71128876622;4524.366588677588;4582.816687332503;240375;240816.55100694014;241074;241410;242037;33831.830840845636;34792.47811282833;55497.445025550034;55809.44190558124;55894.720526397105;35942.28115437729;35990.46014309787;36070.458943115875;36089.63910360915;36236.09409764724;15309.770353444706;15402.537923862303;15403.614909627126;15411.075335479907;15473.922630386776;12694.555690550786;12816.295103769196;12816.55142070023;12818.55135070268;12874.871251287368;8098.35213182944;8113.472624279403;8177.79555511117;8241.546714930617;8256.504609723435;3170.286685495745;3183.9363212735616;3240.8703651854134;3251.788633738847;3265.4448743713624;993.6671215143008;1002.5087707023506;1029.8506716526063;1054.6835949215206;1127.9436028198722;31406;31680.683193168235;31775;32344.83827580847;32735.83632081824;1056.1392465140887;1094.6661268313242;1100.1968562948932;1130.0394664535079;1135.199684222621;16069.196540172945;16220.107894065939;16422.507324780276;16677.24952377146;16677.833221667872;598096;602261;605025;606397;607492;54863.17705234425;55694.443055568925;55883;55930.720346398004;56218.71890640521;1254.8691015915167;1313.1989486413281;1326.8805807477374;1357.8574249703836;1358.3683587131834;30462.695373045986;30873.691263087083;31277.530837037008;31381.372372552876;31520.211994700316;49972;50207.49792502028;50791.23813142732;50867.74566127146;50966.74516627393;500130;505982;509754;510904;511721;26893.462130756885;27564;27711.861440692668;27854.58218126689;27876.721232788223;44931.55068449405;45232.32151517796;45695.314570282135;46248.537514624426;46373.504256542874;39334.80332598319;39642.80178599089;39695.2060958785;40458;41132.58867411288;37952.430713538764;38896.61103389043;39044.804775975936;39351.40972885352;39397.80301098476;39108.608913910495;39337.213255735296;39935.80032099937;40769.1846163081;40816.1836763269;35779.642203577634;35832.67087639295;35857.282854342244;36711.63288367082;37231.25537489181;28108.85945570259;28159.15522534327;28166.2958426041;28255;28308.292292692848 01:33:44 INFO - PROCESS | 3483 | |2;jquery.html;349.9877504287349;352.45369677000656;361.8353649089664;367.5240563470306;369.57683452446946;17761.64476710465;18956.620867582657;19028.36635170682;19814.108365123568;19966.70049949252;17878.10609469528;18296;18460.076996150172;18773.718394224063;18809.24763009478;5293.179557168635;5459.290292262001;5463.453654634544;5487.451254874501;5498.862528436781;5371.81198658047;5373.140297552392;5490.917636235459;5511.5315198208;5538.307711536058;5366.9463305367035;5418.593605479585;5424.674519528821;5426.21319908613;5454.7272636368225;5204.34945631796;5432.2123292122615;5451.972740136313;5468.179773034077;5484.698341591211;4798.904021919542;4803.3995750531185;4808.302796094582;4827.613790896755;4827.85516434504;21033.368998929902;21872.23447179357;22039.228626997978;22054.779452205432;22681.88659056694;2299.655051742252;2330.196082351586;2589.3138318345655;2930.1209637108996;3025.8184508929535;13845.30773461333;14285.928570357186;14334.283285835667;14497.782533262009;14508.129512229194;1864.580469394389;1867.598466329732;1888.3673969220329;1904.8952307623076;1941.107090738262;74085.6295718518;75124.62437687832;76199;76223.61888190579;76256.23743762603;9309.581068851918;9447.858282125637;9488.857667134998;9664.95167524172;9673.70978870635;12415.813762793565;12582.37088145589;12622.179558328862;12670.746585068247;12698.873011269769;7679.923200768033;7819;7831.06027276719;7848.686052557834;7951.801204969806;7722.227777222233;7741.303282704584;7839.843203135905;7905.525668459796;7998.040235171817;5990.161377407167;6117.755289788448;6251.468625166821;6320.968395158086;6350.904736428957;1664.2095004872588;1686.9709477218887;1698.7451882217765;1705.2411676803704;1732.3503686117706;949.3591825517748;973.1728031173587;1034.9948250258851;1065.63235683689;1088.9183311251688;17445.91277043632;18716.251349946124;19605.50986225356;19647.803521964885;19672.213111475667;999.835027220515;1027.732789474727;1027.8047171037479;1042.5829668132808;1051.5057922776282;10752.19358548112;11207.831882521768;11343.205975581795;11362;11436.714082148013;487456;488730;493503;502438;503567;56863.71568142133;74727.62636186785;76598;79555.20444795594;83232;900.3742399032609;1012.6810054832852;1022.6778564752079;1023.3399457350116;1024.626011505795;17569.121543922498;17745.378911738026;17764.555886102433;17839.821601783817;18025.2789888403;39250.80374598109;39362.80318598389;39655.40516892307;39704.2059158821;41067.178656426106;50534;51651.48348516467;51861.22208166805;51936;52822.47177528175;7419;7587;7670.7315243966195;7675.2324767522805;7891.605419729105;12610.747785044432;13221.801672974721;13225.206487610774;13233.536826211037;13285.335733213107;11190.83213751778;11355.772884542428;11567.074634029426;11622.535098595961;11701.88298117008;11331.490082946122;11465.885341146482;11472.139589530985;11659.417029148679;11860.110491712983;11608.606967163656;11630.418479076181;11706.76586468283;11949.22330048544;11980.760384792082;7716.382689384724;7760;7762.262585054411;7774.611269436618;7890.921090789018;11498.367589782642;11548.769024619292;11580.478878450658;11704.063674906158;11768.52925882955 01:33:44 INFO - PROCESS | 3483 | |3;mootools.html;1456.9635759106025;1477.2687519677759;1558.4233833481605;1682.8906121102127;1716.776819013528;7462.440316976222;8239.382046346525;8335.208155225258;8848.026717061126;8856.11438856115;8437.493750374966;8470.407071504982;8567.443116197459;8587.78530536737;8591.957040214791;2235.4634887626935;2250.1674380479244;2262.400463877074;2268.5349503351854;2274.363178310076;2195.5060111474872;2216.6896634471104;2220.955580888381;2227.676986836908;2235.16181431963;2214.3467677035233;2225.310153852303;2233.6091184042807;2242.686023956647;2253.7746225377414;2121.352987338861;2135.391413447168;2144.024468866662;2146.6350720377573;2149.011454730826;2159.1471368809234;2164.9891750541306;2171.6308227601344;2172.239716099353;2173.076442511926;8684.175003374668;8735;8754.562271886443;8760.299176065962;8772.736817895473;4948.87627809304;4998.000399920031;5043.1426657467955;5050.494950504957;5057.721825299607;3223.3069889973535;3326.101952472843;3450.8447119879665;3451.5858097028517;3482.791032538056;1088.7659153282002;1091.8089334366455;1095.9835602465969;1096.8793432722393;1115.6374178391975;12014.459349329214;12024.0981926355;12120.878791212062;12139.939300303531;12142.514299428012;4271.337942618899;4283.271843786564;4343.457067866517;4410.16206920684;4425.623821975104;10125.594976201017;10167.593296268215;10178.338408003456;10203.693889183336;10206.744831379276;4979.103761322996;4980.178270585386;4997.375328083989;5127.154019586801;5136.5890728741615;4003.7597744135446;4569.634429245652;4732.976335118371;4736.905261894743;4757.476677565465;3790;3809.542854857435;3826.253880493333;3916.1971795781797;3920.5491368492417;1142.737170450801;1182.3733421286731;1186.2348785033778;1187.7565099154654;1198.161287099034;907.9137481939205;982.29274922056;1008.8738907636546;1013.7313611892854;1025.3027941000043;5833.241678581757;5992.400759923973;6006.12911127884;6028.849278768066;6055.091736239511;379.87084391307087;386.44159189970225;396.33613697057314;398.25128757934897;403.4654083339587;4216.945763559111;4340.453382519196;4358.607725304738;4379.824807007684;4406.625436837905;10307.381557106597;10504.264701470824;10644.042036216622;10663.466826658636;10685.732856678645;10287.588496460057;10447.477626118816;10457.581696732046;10488.790224195473;10583.576656933636;7784.610769461504;7815.515052140189;7871.763847084597;7892;7899.170587088388;5767.653940763567;5783.450572195635;5793.246877906014;5818.214541036906;5866.882662346815;9666.130048295687;9800.558974846006;9854.507274636382;9868.111869931741;9885.308028437941;9660.275479339218;9804.36271642341;9940.751481213027;10000.199984001409;10012.899871001197;6639.7012134455035;7314.232005639544;7644.0827100748265;7645.120811106794;7698.730544430918;8400.831983360176;8498.830023399621;8526.91473085286;8564.400491965502;8593.871091933752;7605.35354494852;7881.369490440637;7888.053433587776;7935.444518883623;8004.119546849725;7620.542767433972;7637.427192960661;7662.157162712208;7665.6933722650465;7696.345810605937;6699.464042876461;6740.224874139537;6796.830079248059;6821.181458224846;6831.863362732618;5133.614978876524;5188.896222075613;5209.166533354645;5278.076336640996;5300.70846103468;5133.512316329943;5319.973400133129;5336.893262134658;5347.7593508293;5360.437154098763 01:33:44 INFO - PROCESS | 3483 | |4;prototype.html;307.05886458006216;308.327845297252;310.1455490124706;312.8482685897338;314.1048013162486;5598.832035038945;5614.775408983635;5679.176519404684;5689.6017278790505;5694.231278777369;5540.750666220019;5548.361938377087;5578.804741834037;5586.888262234753;5633.295838020247;4008;4174.1651669666035;4290.5709429057;4316.611504964552;4354.281543545311;4309.762963037032;4328.415663885383;4331.5884990925815;4333.978330108361;4339.284018137019;4294.9570504295025;4303.268444364466;4318.287482565373;4324.6107850293465;4329.588689074533;4023.135025969416;4229.936550951738;4266.549373213123;4269.295566231568;4326.264535029052;3668.394714872043;3691.8892433227047;3695.1870588470492;3698.0569954661387;3698.981505092457;5481.506664400184;5488.862778430571;5492.368377636543;5499.395066542677;5507.642003269774;4685.320628508847;4890.706557606555;4909.2881532177635;4909.8772530686665;4917.434495033045;5852.858692554953;5873.6211834207215;5878.971180043475;5893.852653683649;5898.696729831266;4102.569230230843;4106.281400754886;4119.588041195856;4128.876133715993;4142.91714165718;5949.839781242659;6053.334133245339;6105.877882442371;6122.571420000646;6159;4092.1611069730634;4097.590240975938;4116.361963895601;4123.649489793341;4128.215639028635;4143.544210136883;4168.499780026416;4188.68584856137;4192.958070419257;4197.181549597799;4673.434399476146;4880.608501834146;4891.290762839369;4896.583790377857;4908.165611845995;5810.215620891126;5814.215080964101;5917.408259174048;5965.433283838029;5972.940270597325;1431.6184881589315;1436.2531483628454;1449.6013596260902;1449.8763458319886;1450.5285782120852;862.8964524257129;888.3159966825638;914.7255823253131;924.8497243907941;934.1265916368218;5529.645236916981;5623.268975033219;5623.971880140573;5633.859153521113;5664.97167514168;6000.409891378788;6000.669963151981;6010.278766547955;6022.789202377896;6044.516438684895;5392.110301800159;5646.181303710939;5657.830265092054;5658.773649053992;5662.207290979266;3167.55654208411;3210.7431405487505;3219.645838957713;3231.7054891027165;3264.6735326467165;5885.941140588625;6185.505159587312;6215.098810672517;6242.500599952084;6269.7492100316385;6138.754449821957;6142.201513803267;6164;6184.81445556634;6210.813675589739;6137.324894261627;6174.845628859314;6216.595921265194;6302.527310451735;6303.149074874925;5957.910631340446;6040.493195323891;6054.33402325735;6096.817095487142;6125.938740612715;6011.27864656244;6017.562887030759;6036.939630603638;6047.576669633084;6060.000099983454;6092.177556029879;6227.564070515021;6234.625922444668;6262.624242545462;6281.183446151971;4092.7544347339253;4126.546079931265;4129.793510324532;4167.791610419527;4171.374293855946;6109.51123910095;6111.511079113571;6146.477549408351;6175.783847565313;6177.980633195652;5684.124239001037;5914.2311499504785;6005.399460054135;6012.969935150296;6036.69816509164;5898.882022359615;5940.435658612425;5950.19672344228;5980.372060933713;5988.850278742892;5350.652207606493;5808.883822323614;5861.472467477947;5865.296164460292;5877.766448749448;5895.260898035004;5923.104606525871;5930.851728706817;5946.28644562638;5948.821535353946;5586.804461843816;5809.448102430262;5822.214001109796;5849.385814489588;5862.267216597926 01:33:44 INFO - PROCESS | 3483 | |5;yui.html;714.1465948191913;762.9389648828094;796.7251298302091;817.595290331286;854.2098558833078;14141.858581414182;15696;16059;16100.03399796013;16147.83852161478;14443.855561444383;14628.34172462239;14726.26368681567;14742;14824.407023719039;601.3955974245898;703.9436845052384;704.8097013806282;720.8233982674226;721.1778572427437;709.6097146569366;711.0578483509371;711.7615598774416;714.7998560403096;721.6572128239097;753.8605358008758;756.0889128600052;756.3457609168057;756.3570964680006;757.526545908807;745.2361329637112;748.2255865179513;749.4229443328634;749.741339237962;753.0699586011272;547.9589030822705;548.9835304940818;550.5485501888453;551.1017042221154;551.1017042221193;15301.61745956349;15377.461788837449;15389.538313850491;15394.692106157814;15430.228488575527;14137.858621413758;14685.706285874223;14977.251137443192;15027.624309392244;15027.699446011018;11742.941285293518;12095.334756588383;12135.393230338535;12327.568535101318;12491.875081249162;3814.9427758583643;3843.846246150151;3889.8833035008997;3906.58980807014;3963.4451176835264;74378.25621743768;77256.61371693105;77292.61353693252;78545;79300.20699792985;10836.40399778004;11187.94406027981;11530.702213189586;11806.291622502677;11858.644240672622;21062.2628208012;21187.576248474943;21207.893960530408;21406.892965535073;21886.233981810878;8825.514596697243;8921.776955576162;8930.419522731132;9000.549972501349;9190.172884440433;4742.1227072991605;4801.663883528119;4821.783019764119;4863.635227357891;4922.827701030446;3473.2879759649213;3647.708183345326;3662.926741465156;3663;3663.670269675689;603.2429301226932;623.8783437229697;630.338144947803;639.5203597302024;664.4750646988824;606.7936901453527;610.6702380714453;655.4428735574724;659.0049025970723;693.1612748574181;9624;9754.122129008423;9917.92509853476;9943.403395796275;9980;614.3549273263056;661.5258733976289;690.8169335126196;730.3244498838553;732.8900664900308;4654.162250794821;4668.159731248408;4728.1252968201;4730.52694730531;4795.832145874878;95352;98342;100500.49749751204;107858;110882;62270.688646556475;79326.60336698279;93323.53338233402;95446.52276738572;97432.51283743678;76781.23218767741;77045.61477192579;83455.58272208722;86748.5662571683;89654.55172724224;9525.666601668909;10128.746781330527;10329.638462653771;10453.68638940833;10467.94766026165;46266.53733462622;50444;50583.74708126436;51409.74295128501;52625.21062184147;64655.353446464935;64995;73152.63423682848;74013.4355567756;74501.25498744943;12626.635290363694;12726.363681816058;12783.23300601967;12950.158239714388;13121.803172952223;14435.855641443452;14448.927755361156;14503.637409064857;14848.925755371587;14874.330655120762;13340.866591333963;13894;14218.146911184947;15025.398984040516;15029.549113526611;13228.933855330662;13257.734845303234;13373.799393008918;13404.061715679809;13669.111507751964;10700.411477368509;12744.299063551594;13375.197488150741;13596.11625244356;14398.640033998814;11533;11949.761004779682;11962.282263064244;11978.161528692908;12109.69725756863;11805.645830625095;11849.763004740029;11886;11930.821037684615;12117.151799374311 01:33:44 INFO - PROCESS | 3483 | __end_tp_report 01:33:44 INFO - PROCESS | 3483 | __start_cc_report 01:33:44 INFO - PROCESS | 3483 | _x_x_mozilla_cycle_collect,350 01:33:44 INFO - PROCESS | 3483 | __end_cc_report 01:33:44 INFO - PROCESS | 3483 | __startTimestamp1465461224980__endTimestamp 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | ------- Summary: start ------- 01:33:44 INFO - PROCESS | 3483 | Number of tests: 6 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | [#0] dojo.html Cycles:165 Average:5469.35 Median:5706.77 stddev:629.16 (11.0%) stddev-sans-first:602.70 01:33:44 INFO - PROCESS | 3483 | Values: 3087.5 3138.8 3161.4 3172.1 3198.0 5415.5 5454.5 5469.3 5524.7 5559.5 5318.3 5348.2 5433.6 5477.1 5481.9 4930.9 4982.7 5049.2 5088.0 5137.2 4956.9 5105.8 5129.8 5140.6 5143.0 4871.4 4951.1 4954.9 4983.3 4992.1 4966.5 4969.2 4976.2 4979.9 5070.6 4943.7 4944.5 4961.6 4973.1 5018.9 5260.8 5342.7 5348.4 5442.3 5478.8 5801.1 5810.0 5815.6 5819.8 5836.3 5731.9 5855.6 5858.3 5873.4 5883.0 5469.8 5484.4 5536.6 5594.0 5611.5 6043.8 6072.2 6074.5 6079.9 6087.2 5628.7 5778.1 5849.6 5849.9 5874.5 5857.0 5953.6 5972.9 5975.0 6026.9 5634.3 5814.0 5911.5 5912.1 5915.4 5666.8 5811.2 5915.6 5957.6 5973.1 4477.5 4510.9 4514.9 4540.7 4552.2 3989.7 3995.0 4007.7 4023.3 4026.0 5520.8 5577.1 5593.7 5634.6 5635.7 5887.9 5888.2 5890.1 5906.2 5924.1 5550.1 5606.0 5608.1 5615.2 5618.2 4937.3 5032.8 5108.8 5116.4 5119.1 6098.7 6132.5 6134.8 6157.2 6168.2 5706.8 5946.8 5961.5 5968.2 5969.6 5968.9 6043.5 6066.4 6090.2 6109.1 5803.7 5808.9 5814.6 5818.9 5827.2 5733.9 5871.0 5881.9 5882.0 5918.6 5602.0 5775.6 5868.4 5893.7 5929.8 5710.4 5733.3 5770.8 5856.2 5857.9 5497.3 5743.5 5760.5 5762.2 5764.7 5740.1 5808.5 5829.7 5868.9 5870.6 5681.1 5703.8 5713.9 5722.6 5735.9 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | [#1] ext.html Cycles:180 Average:59418.96 Median:40613.59 stddev:127552.73 (314.1%) stddev-sans-first:127833.97 01:33:44 INFO - PROCESS | 3483 | Values: 549.2 595.2 612.1 613.6 615.1 41228.4 42338.2 42766.4 46008.3 46581.5 44551.6 45187.8 45188.5 45259.0 45459.1 8902.6 9027.0 9056.4 9063.7 9071.8 8811.0 8905.6 8908.7 8914.8 8930.2 8917.2 8950.5 8953.2 8997.8 9007.0 8829.4 8841.9 8844.1 8844.6 8844.7 8857.1 8940.8 8944.9 8952.8 8961.5 42170.0 42553.0 42605.8 42652.1 42758.0 3651.3 3690.9 3772.2 4148.0 4167.6 31784.8 32193.0 32645.7 32819.2 33023.7 4399.4 4423.7 4441.7 4524.4 4582.8 240375.0 240816.6 241074.0 241410.0 242037.0 33831.8 34792.5 55497.4 55809.4 55894.7 35942.3 35990.5 36070.5 36089.6 36236.1 15309.8 15402.5 15403.6 15411.1 15473.9 12694.6 12816.3 12816.6 12818.6 12874.9 8098.4 8113.5 8177.8 8241.5 8256.5 3170.3 3183.9 3240.9 3251.8 3265.4 993.7 1002.5 1029.9 1054.7 1127.9 31406.0 31680.7 31775.0 32344.8 32735.8 1056.1 1094.7 1100.2 1130.0 1135.2 16069.2 16220.1 16422.5 16677.2 16677.8 598096.0 602261.0 605025.0 606397.0 607492.0 54863.2 55694.4 55883.0 55930.7 56218.7 1254.9 1313.2 1326.9 1357.9 1358.4 30462.7 30873.7 31277.5 31381.4 31520.2 49972.0 50207.5 50791.2 50867.7 50966.7 500130.0 505982.0 509754.0 510904.0 511721.0 26893.5 27564.0 27711.9 27854.6 27876.7 44931.6 45232.3 45695.3 46248.5 46373.5 39334.8 39642.8 39695.2 40458.0 41132.6 37952.4 38896.6 39044.8 39351.4 39397.8 39108.6 39337.2 39935.8 40769.2 40816.2 35779.6 35832.7 35857.3 36711.6 37231.3 28108.9 28159.2 28166.3 28255.0 28308.3 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | [#2] jquery.html Cycles:180 Average:28150.94 Median:1687.90 stddev:81164.75 (4808.6%) stddev-sans-first:81365.59 01:33:44 INFO - PROCESS | 3483 | Values: 350.0 352.5 361.8 367.5 369.6 17761.6 18956.6 19028.4 19814.1 19966.7 17878.1 18296.0 18460.1 18773.7 18809.2 5293.2 5459.3 5463.5 5487.5 5498.9 5371.8 5373.1 5490.9 5511.5 5538.3 5366.9 5418.6 5424.7 5426.2 5454.7 5204.3 5432.2 5452.0 5468.2 5484.7 4798.9 4803.4 4808.3 4827.6 4827.9 21033.4 21872.2 22039.2 22054.8 22681.9 2299.7 2330.2 2589.3 2930.1 3025.8 13845.3 14285.9 14334.3 14497.8 14508.1 1864.6 1867.6 1888.4 1904.9 1941.1 74085.6 75124.6 76199.0 76223.6 76256.2 9309.6 9447.9 9488.9 9665.0 9673.7 12415.8 12582.4 12622.2 12670.7 12698.9 7679.9 7819.0 7831.1 7848.7 7951.8 7722.2 7741.3 7839.8 7905.5 7998.0 5990.2 6117.8 6251.5 6321.0 6350.9 1664.2 1687.0 1698.7 1705.2 1732.4 949.4 973.2 1035.0 1065.6 1088.9 17445.9 18716.3 19605.5 19647.8 19672.2 999.8 1027.7 1027.8 1042.6 1051.5 10752.2 11207.8 11343.2 11362.0 11436.7 487456.0 488730.0 493503.0 502438.0 503567.0 56863.7 74727.6 76598.0 79555.2 83232.0 900.4 1012.7 1022.7 1023.3 1024.6 17569.1 17745.4 17764.6 17839.8 18025.3 39250.8 39362.8 39655.4 39704.2 41067.2 50534.0 51651.5 51861.2 51936.0 52822.5 7419.0 7587.0 7670.7 7675.2 7891.6 12610.7 13221.8 13225.2 13233.5 13285.3 11190.8 11355.8 11567.1 11622.5 11701.9 11331.5 11465.9 11472.1 11659.4 11860.1 11608.6 11630.4 11706.8 11949.2 11980.8 7716.4 7760.0 7762.3 7774.6 7890.9 11498.4 11548.8 11580.5 11704.1 11768.5 01:33:44 INFO - PROCESS | 3483 | 01:33:44 INFO - PROCESS | 3483 | [#3] mootools.html Cycles:180 Average:5660.27 Median:4497.63 stddev:3243.75 (72.1%) stddev-sans-first:3237.47 01:33:44 INFO - PROCESS | 3483 | Values: 1457.0 1477.3 1558.4 1682.9 1716.8 7462.4 8239.4 8335.2 8848.0 8856.1 8437.5 8470.4 8567.4 8587.8 8592.0 2235.5 2250.2 2262.4 2268.5 2274.4 2195.5 2216.7 2221.0 2227.7 2235.2 2214.3 2225.3 2233.6 2242.7 2253.8 2121.4 2135.4 2144.0 2146.6 2149.0 2159.1 2165.0 2171.6 2172.2 2173.1 8684.2 8735.0 8754.6 8760.3 8772.7 4948.9 4998.0 5043.1 5050.5 5057.7 3223.3 3326.1 3450.8 3451.6 3482.8 1088.8 1091.8 1096.0 1096.9 1115.6 12014.5 12024.1 12120.9 12139.9 12142.5 4271.3 4283.3 4343.5 4410.2 4425.6 10125.6 10167.6 10178.3 10203.7 10206.7 4979.1 4980.2 4997.4 5127.2 5136.6 4003.8 4569.6 4733.0 4736.9 4757.5 3790.0 3809.5 3826.3 3916.2 3920.5 1142.7 1182.4 1186.2 1187.8 1198.2 907.9 982.3 1008.9 1013.7 1025.3 5833.2 5992.4 6006.1 6028.8 6055.1 379.9 386.4 396.3 398.3 403.5 4216.9 4340.5 4358.6 4379.8 4406.6 10307.4 10504.3 10644.0 10663.5 10685.7 10287.6 10447.5 10457.6 10488.8 10583.6 7784.6 7815.5 7871.8 7892.0 7899.2 5767.7 5783.5 5793.2 5818.2 5866.9 9666.1 9800.6 9854.5 9868.1 9885.3 9660.3 9804.4 9940.8 10000.2 10012.9 6639.7 7314.2 7644.1 7645.1 7698.7 8400.8 8498.8 8526.9 8564.4 8593.9 7605.4 7881.4 7888.1 7935.4 8004.1 7620.5 7637.4 7662.2 7665.7 7696.3 6699.5 6740.2 6796.8 6821.2 6831.9 5133.6 5188.9 5209.2 5278.1 5300.7 5133.5 5320.0 5336.9 5347.8 5360.4 01:33:44 INFO - PROCESS | 3483 | 01:33:45 INFO - PROCESS | 3483 | [#4] prototype.html Cycles:180 Average:4919.35 Median:5658.30 stddev:1494.09 (26.4%) stddev-sans-first:1457.63 01:33:45 INFO - PROCESS | 3483 | Values: 307.1 308.3 310.1 312.8 314.1 5598.8 5614.8 5679.2 5689.6 5694.2 5540.8 5548.4 5578.8 5586.9 5633.3 4008.0 4174.2 4290.6 4316.6 4354.3 4309.8 4328.4 4331.6 4334.0 4339.3 4295.0 4303.3 4318.3 4324.6 4329.6 4023.1 4229.9 4266.5 4269.3 4326.3 3668.4 3691.9 3695.2 3698.1 3699.0 5481.5 5488.9 5492.4 5499.4 5507.6 4685.3 4890.7 4909.3 4909.9 4917.4 5852.9 5873.6 5879.0 5893.9 5898.7 4102.6 4106.3 4119.6 4128.9 4142.9 5949.8 6053.3 6105.9 6122.6 6159.0 4092.2 4097.6 4116.4 4123.6 4128.2 4143.5 4168.5 4188.7 4193.0 4197.2 4673.4 4880.6 4891.3 4896.6 4908.2 5810.2 5814.2 5917.4 5965.4 5972.9 1431.6 1436.3 1449.6 1449.9 1450.5 862.9 888.3 914.7 924.8 934.1 5529.6 5623.3 5624.0 5633.9 5665.0 6000.4 6000.7 6010.3 6022.8 6044.5 5392.1 5646.2 5657.8 5658.8 5662.2 3167.6 3210.7 3219.6 3231.7 3264.7 5885.9 6185.5 6215.1 6242.5 6269.7 6138.8 6142.2 6164.0 6184.8 6210.8 6137.3 6174.8 6216.6 6302.5 6303.1 5957.9 6040.5 6054.3 6096.8 6125.9 6011.3 6017.6 6036.9 6047.6 6060.0 6092.2 6227.6 6234.6 6262.6 6281.2 4092.8 4126.5 4129.8 4167.8 4171.4 6109.5 6111.5 6146.5 6175.8 6178.0 5684.1 5914.2 6005.4 6013.0 6036.7 5898.9 5940.4 5950.2 5980.4 5988.9 5350.7 5808.9 5861.5 5865.3 5877.8 5895.3 5923.1 5930.9 5946.3 5948.8 5586.8 5809.4 5822.2 5849.4 5862.3 01:33:45 INFO - PROCESS | 3483 | 01:33:45 INFO - PROCESS | 3483 | [#5] yui.html Cycles:180 Average:19954.84 Median:4729.33 stddev:27610.67 (583.8%) stddev-sans-first:27650.33 01:33:45 INFO - PROCESS | 3483 | Values: 714.1 762.9 796.7 817.6 854.2 14141.9 15696.0 16059.0 16100.0 16147.8 14443.9 14628.3 14726.3 14742.0 14824.4 601.4 703.9 704.8 720.8 721.2 709.6 711.1 711.8 714.8 721.7 753.9 756.1 756.3 756.4 757.5 745.2 748.2 749.4 749.7 753.1 548.0 549.0 550.5 551.1 551.1 15301.6 15377.5 15389.5 15394.7 15430.2 14137.9 14685.7 14977.3 15027.6 15027.7 11742.9 12095.3 12135.4 12327.6 12491.9 3814.9 3843.8 3889.9 3906.6 3963.4 74378.3 77256.6 77292.6 78545.0 79300.2 10836.4 11187.9 11530.7 11806.3 11858.6 21062.3 21187.6 21207.9 21406.9 21886.2 8825.5 8921.8 8930.4 9000.5 9190.2 4742.1 4801.7 4821.8 4863.6 4922.8 3473.3 3647.7 3662.9 3663.0 3663.7 603.2 623.9 630.3 639.5 664.5 606.8 610.7 655.4 659.0 693.2 9624.0 9754.1 9917.9 9943.4 9980.0 614.4 661.5 690.8 730.3 732.9 4654.2 4668.2 4728.1 4730.5 4795.8 95352.0 98342.0 100500.5 107858.0 110882.0 62270.7 79326.6 93323.5 95446.5 97432.5 76781.2 77045.6 83455.6 86748.6 89654.6 9525.7 10128.7 10329.6 10453.7 10467.9 46266.5 50444.0 50583.7 51409.7 52625.2 64655.4 64995.0 73152.6 74013.4 74501.3 12626.6 12726.4 12783.2 12950.2 13121.8 14435.9 14448.9 14503.6 14848.9 14874.3 13340.9 13894.0 14218.1 15025.4 15029.5 13228.9 13257.7 13373.8 13404.1 13669.1 10700.4 12744.3 13375.2 13596.1 14398.6 11533.0 11949.8 11962.3 11978.2 12109.7 11805.6 11849.8 11886.0 11930.8 12117.2 01:33:45 INFO - PROCESS | 3483 | -------- Summary: end -------- 01:33:45 INFO - PROCESS | 3483 | 01:33:45 INFO - TEST-INFO | 3483: exit 0 01:33:45 INFO - TEST-OK | dromaeo_css | took 1113525ms 01:33:45 INFO - TEST-START | kraken 01:33:45 INFO - operating with platform_type : linux_ 01:33:45 INFO - Initialising browser for kraken test... 01:33:45 INFO - TEST-INFO | started process 3719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPyb_pZ/profile http://localhost:59539/getInfo.html) 01:33:50 INFO - PROCESS | 3719 | __metrics Screen width/height:1600/1200 01:33:50 INFO - PROCESS | 3719 | colorDepth:24 01:33:50 INFO - PROCESS | 3719 | Browser inner width/height: 1024/697 01:33:50 INFO - PROCESS | 3719 | __metrics 01:33:50 ERROR - PROCESS | 3719 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 01:33:51 INFO - TEST-INFO | 3719: exit 0 01:33:51 INFO - Browser initialized. 01:33:51 INFO - Running cycle 1/1 for kraken test... 01:33:51 INFO - TEST-INFO | started process 3838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPyb_pZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:03 INFO - PROCESS | 3838 | RSS: Main: 185077760 01:34:03 INFO - PROCESS | 3838 | 01:34:06 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59539/tests/kraken/driver.html?testName=audio-beat-detection) 01:34:07 INFO - PROCESS | 3838 | RSS: Main: 189923328 01:34:07 INFO - PROCESS | 3838 | 01:34:09 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59539/tests/kraken/driver.html?testName=audio-dft) 01:34:10 INFO - PROCESS | 3838 | RSS: Main: 189382656 01:34:10 INFO - PROCESS | 3838 | 01:34:13 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59539/tests/kraken/driver.html?testName=audio-fft) 01:34:13 INFO - PROCESS | 3838 | RSS: Main: 184475648 01:34:13 INFO - PROCESS | 3838 | 01:34:16 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59539/tests/kraken/driver.html?testName=audio-oscillator) 01:34:16 INFO - PROCESS | 3838 | RSS: Main: 185094144 01:34:16 INFO - PROCESS | 3838 | 01:34:18 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:34:19 INFO - PROCESS | 3838 | RSS: Main: 185401344 01:34:19 INFO - PROCESS | 3838 | 01:34:22 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59539/tests/kraken/driver.html?testName=imaging-darkroom) 01:34:23 INFO - PROCESS | 3838 | RSS: Main: 185864192 01:34:23 INFO - PROCESS | 3838 | 01:34:26 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59539/tests/kraken/driver.html?testName=imaging-desaturate) 01:34:27 INFO - PROCESS | 3838 | RSS: Main: 183451648 01:34:27 INFO - PROCESS | 3838 | 01:34:30 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59539/tests/kraken/driver.html?testName=json-parse-financial) 01:34:30 INFO - PROCESS | 3838 | RSS: Main: 184287232 01:34:30 INFO - PROCESS | 3838 | 01:34:32 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:34:32 INFO - PROCESS | 3838 | RSS: Main: 184958976 01:34:32 INFO - PROCESS | 3838 | 01:34:34 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:34:35 INFO - PROCESS | 3838 | RSS: Main: 185499648 01:34:35 INFO - PROCESS | 3838 | 01:34:37 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:34:38 INFO - PROCESS | 3838 | RSS: Main: 185503744 01:34:38 INFO - PROCESS | 3838 | 01:34:40 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:34:41 INFO - PROCESS | 3838 | RSS: Main: 185663488 01:34:41 INFO - PROCESS | 3838 | 01:34:44 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:34:44 INFO - PROCESS | 3838 | RSS: Main: 185610240 01:34:44 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | Cycle 1(1): loaded http://localhost:59539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59539/tests/kraken/driver.html?testName=ai-astar) 01:34:46 INFO - PROCESS | 3838 | RSS: Main: 186257408 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | __start_tp_report 01:34:46 INFO - PROCESS | 3838 | _x_x_mozilla_page_load 01:34:46 INFO - PROCESS | 3838 | _x_x_mozilla_page_load_details 01:34:46 INFO - PROCESS | 3838 | |i|pagename|runs| 01:34:46 INFO - PROCESS | 3838 | |0;ai-astar;113;106;112;110;112;110;113;112;112;111 01:34:46 INFO - PROCESS | 3838 | |1;audio-beat-detection;152;127;154;179;128;159;159;128;190;129 01:34:46 INFO - PROCESS | 3838 | |2;audio-dft;161;163;163;165;162;185;162;161;162;161 01:34:46 INFO - PROCESS | 3838 | |3;audio-fft;74;74;74;159;78;76;75;75;168;75 01:34:46 INFO - PROCESS | 3838 | |4;audio-oscillator;85;85;157;85;88;85;153;85;84;147 01:34:46 INFO - PROCESS | 3838 | |5;imaging-gaussian-blur;117;118;118;118;118;117;117;117;117;118 01:34:46 INFO - PROCESS | 3838 | |6;imaging-darkroom;146;147;147;146;149;146;148;146;146;149 01:34:46 INFO - PROCESS | 3838 | |7;imaging-desaturate;95;96;96;96;96;96;97;96;96;96 01:34:46 INFO - PROCESS | 3838 | |8;json-parse-financial;55;54;54;54;56;59;55;56;55;55 01:34:46 INFO - PROCESS | 3838 | |9;json-stringify-tinderbox;66;65;65;65;64;64;64;64;66;65 01:34:46 INFO - PROCESS | 3838 | |10;stanford-crypto-aes;82;80;79;81;84;82;80;80;110;80 01:34:46 INFO - PROCESS | 3838 | |11;stanford-crypto-ccm;135;133;122;121;122;127;121;127;155;125 01:34:46 INFO - PROCESS | 3838 | |12;stanford-crypto-pbkdf2;158;163;160;169;160;156;157;157;158;158 01:34:46 INFO - PROCESS | 3838 | |13;stanford-crypto-sha256-iterative;68;70;65;64;63;65;65;64;62;64 01:34:46 INFO - PROCESS | 3838 | __end_tp_report 01:34:46 INFO - PROCESS | 3838 | __start_cc_report 01:34:46 INFO - PROCESS | 3838 | _x_x_mozilla_cycle_collect,871 01:34:46 INFO - PROCESS | 3838 | __end_cc_report 01:34:46 INFO - PROCESS | 3838 | __startTimestamp1465461286650__endTimestamp 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | ------- Summary: start ------- 01:34:46 INFO - PROCESS | 3838 | Number of tests: 14 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.08 (1.9%) stddev-sans-first:2.09 01:34:46 INFO - PROCESS | 3838 | Values: 113.0 106.0 112.0 110.0 112.0 110.0 113.0 112.0 112.0 111.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.50 stddev:22.51 (14.4%) stddev-sans-first:23.86 01:34:46 INFO - PROCESS | 3838 | Values: 152.0 127.0 154.0 179.0 128.0 159.0 159.0 128.0 190.0 129.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#2] audio-dft Cycles:10 Average:164.50 Median:162.50 stddev:7.31 (4.5%) stddev-sans-first:7.64 01:34:46 INFO - PROCESS | 3838 | Values: 161.0 163.0 163.0 165.0 162.0 185.0 162.0 161.0 162.0 161.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.00 stddev:37.34 (49.8%) stddev-sans-first:38.98 01:34:46 INFO - PROCESS | 3838 | Values: 74.0 74.0 74.0 159.0 78.0 76.0 75.0 75.0 168.0 75.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:85.00 stddev:32.49 (38.2%) stddev-sans-first:33.61 01:34:46 INFO - PROCESS | 3838 | Values: 85.0 85.0 157.0 85.0 88.0 85.0 153.0 85.0 84.0 147.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:34:46 INFO - PROCESS | 3838 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 01:34:46 INFO - PROCESS | 3838 | Values: 146.0 147.0 147.0 146.0 149.0 146.0 148.0 146.0 146.0 149.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 01:34:46 INFO - PROCESS | 3838 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.58 01:34:46 INFO - PROCESS | 3838 | Values: 55.0 54.0 54.0 54.0 56.0 59.0 55.0 56.0 55.0 55.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 01:34:46 INFO - PROCESS | 3838 | Values: 66.0 65.0 65.0 65.0 64.0 64.0 64.0 64.0 66.0 65.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:80.50 stddev:9.32 (11.6%) stddev-sans-first:9.86 01:34:46 INFO - PROCESS | 3838 | Values: 82.0 80.0 79.0 81.0 84.0 82.0 80.0 80.0 110.0 80.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.00 stddev:10.42 (8.2%) stddev-sans-first:10.81 01:34:46 INFO - PROCESS | 3838 | Values: 135.0 133.0 122.0 121.0 122.0 127.0 121.0 127.0 155.0 125.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:159.00 stddev:3.86 (2.4%) stddev-sans-first:4.06 01:34:46 INFO - PROCESS | 3838 | Values: 158.0 163.0 160.0 169.0 160.0 156.0 157.0 157.0 158.0 158.0 01:34:46 INFO - PROCESS | 3838 | 01:34:46 INFO - PROCESS | 3838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.36 (3.6%) stddev-sans-first:2.24 01:34:46 INFO - PROCESS | 3838 | Values: 68.0 70.0 65.0 64.0 63.0 65.0 65.0 64.0 62.0 64.0 01:34:46 INFO - PROCESS | 3838 | -------- Summary: end -------- 01:34:46 INFO - PROCESS | 3838 | 01:34:47 INFO - TEST-INFO | 3838: exit 0 01:34:47 INFO - TEST-OK | kraken | took 61927ms 01:34:47 INFO - SUITE-END | took 1175s 01:34:47 INFO - Completed test suite (00:19:35) 01:34:47 INFO - javascript benchmark 01:34:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7137.106480342473, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.5214341777023, 3138.7802853800213, 3161.383530211608, 3172.0642410488904, 3198.0246024962394, 5415.485528874756, 5454.4545545445435, 5469.34367875855, 5524.66851988881, 5559.471850174237, 5318.335208098988, 5348.197770334452, 5433.592480563963, 5477.123660214366, 5481.862953426166, 4930.926036109452, 4982.701037937717, 5049.24261360797, 5087.9745601272125, 5137.229415587654, 4956.876078098058, 5105.770240339194, 5129.820456284031, 5140.640155189139, 5143.022825663131, 4871.415430148387, 4951.108800415924, 4954.925676114861, 4983.302337672729, 4992.051510213066, 4966.478519755446, 4969.204927211665, 4976.178930476467, 4979.875503112451, 5070.594352451832, 4943.728094954776, 4944.53026962438, 4961.603071754251, 4973.104841128596, 5018.89962200754, 5260.789568417297, 5342.652727572696, 5348.384935732402, 5442.292501974757, 5478.753456094445, 5801.071828507418, 5809.970950145264, 5815.621984570989, 5819.7672093116225, 5836.2996440427, 5731.856703582402, 5855.648661080349, 5858.297004359504, 5873.412658734135, 5882.97058514709, 5469.781208751645, 5484.424135465759, 5536.640118392332, 5593.972030139905, 5611.466910643441, 6043.8186854394435, 6072.21061262042, 6074.453299203093, 6079.908801367983, 6087.239095113111, 5628.6622802631155, 5778.104393818965, 5849.64902105875, 5849.853753656193, 5874.530037596982, 5857.0, 5953.553483488756, 5972.85067873298, 5975.014122669798, 6026.9095963560585, 5634.32388113429, 5813.970930145322, 5911.527077833763, 5912.142739302777, 5915.3788852170765, 5666.801661941812, 5811.186433899257, 5915.585908986416, 5957.553183511254, 5973.133895585116, 4477.462704475483, 4510.864674059783, 4514.909701805946, 4540.6821522493765, 4552.180607490617, 3989.6608788252743, 3995.0, 4007.6793856491413, 4023.295923213426, 4026.0, 5520.834374968757, 5577.05190117681, 5593.720313984284, 5634.577406694432, 5635.718214089279, 5887.852803679856, 5888.205092312483, 5890.087036509348, 5906.232189815382, 5924.052151655715, 5550.139728342114, 5605.971970140205, 5608.130739735348, 5615.18579805934, 5618.213450116987, 4937.333459982857, 5032.798688052437, 5108.821191258288, 5116.437191908887, 5119.10415677255, 6098.72555734993, 6132.478739307119, 6134.8159555213415, 6157.168782214344, 6168.167297414881, 5706.771729130788, 5946.791862284886, 5961.493273071837, 5968.194293770285, 5969.552283578836, 5968.880622387441, 6043.486303664062, 6066.423689749467, 6090.177825993612, 6109.144719739329, 5803.680797556006, 5808.883822323445, 5814.592978491465, 5818.854528636818, 5827.24245848037, 5733.913991290217, 5870.970645146917, 5881.911771323348, 5882.000059989898, 5918.644881306963, 5602.047651899105, 5775.566832487664, 5868.413158684098, 5893.675847828411, 5929.792457263975, 5710.400407957105, 5733.283339582552, 5770.769169233184, 5856.180134781219, 5857.912131318119, 5497.257870187634, 5743.4543718346695, 5760.510356619734, 5762.2221000164445, 5764.740586673526, 5740.052891272893, 5808.5353171747, 5829.6793676346515, 5868.882622347614, 5870.618409803349, 5681.147827825859, 5703.828885133453, 5713.942860571341, 5722.599418040697, 5735.9139612905], "value": 5426.284414290094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.1817192383347, 595.2291782142125, 612.1032687113378, 613.5674349583543, 615.1111643674892, 41228.38157427641, 42338.15323693524, 42766.358504622454, 46008.30987535189, 46581.53418465814, 44551.55448445515, 45187.774061129734, 45188.548114518846, 45259.0, 45459.09081818361, 8902.643894244238, 9027.0, 9056.411333263317, 9063.728088157366, 9071.818563628723, 8810.955945220265, 8905.599248033821, 8908.73273801787, 8914.777130571756, 8930.240929520998, 8917.152870477326, 8950.507722075283, 8953.23897468716, 8997.820043599124, 9006.954965225164, 8829.426087304304, 8841.911580884238, 8844.11558844117, 8844.646214151426, 8844.73465796027, 8857.070007649232, 8940.776480587972, 8944.910550894472, 8952.820943581091, 8961.507117108556, 42170.0, 42553.0, 42605.78697106495, 42652.146957061, 42758.0, 3651.3427583035045, 3690.8892733218045, 3772.1512659651635, 4148.0, 4167.6457501112445, 31784.841075794706, 32193.0, 32645.6735432645, 32819.17952051194, 33023.6697633023, 4399.36209249657, 4423.690341676084, 4441.71128876622, 4524.366588677588, 4582.816687332503, 240375.0, 240816.55100694014, 241074.0, 241410.0, 242037.0, 33831.830840845636, 34792.47811282833, 55497.445025550034, 55809.44190558124, 55894.720526397105, 35942.28115437729, 35990.46014309787, 36070.458943115875, 36089.63910360915, 36236.09409764724, 15309.770353444706, 15402.537923862303, 15403.614909627126, 15411.075335479907, 15473.922630386776, 12694.555690550786, 12816.295103769196, 12816.55142070023, 12818.55135070268, 12874.871251287368, 8098.35213182944, 8113.472624279403, 8177.79555511117, 8241.546714930617, 8256.504609723435, 3170.286685495745, 3183.9363212735616, 3240.8703651854134, 3251.788633738847, 3265.4448743713624, 993.6671215143008, 1002.5087707023506, 1029.8506716526063, 1054.6835949215206, 1127.9436028198722, 31406.0, 31680.683193168235, 31775.0, 32344.83827580847, 32735.83632081824, 1056.1392465140887, 1094.6661268313242, 1100.1968562948932, 1130.0394664535079, 1135.199684222621, 16069.196540172945, 16220.107894065939, 16422.507324780276, 16677.24952377146, 16677.833221667872, 598096.0, 602261.0, 605025.0, 606397.0, 607492.0, 54863.17705234425, 55694.443055568925, 55883.0, 55930.720346398004, 56218.71890640521, 1254.8691015915167, 1313.1989486413281, 1326.8805807477374, 1357.8574249703836, 1358.3683587131834, 30462.695373045986, 30873.691263087083, 31277.530837037008, 31381.372372552876, 31520.211994700316, 49972.0, 50207.49792502028, 50791.23813142732, 50867.74566127146, 50966.74516627393, 500130.0, 505982.0, 509754.0, 510904.0, 511721.0, 26893.462130756885, 27564.0, 27711.861440692668, 27854.58218126689, 27876.721232788223, 44931.55068449405, 45232.32151517796, 45695.314570282135, 46248.537514624426, 46373.504256542874, 39334.80332598319, 39642.80178599089, 39695.2060958785, 40458.0, 41132.58867411288, 37952.430713538764, 38896.61103389043, 39044.804775975936, 39351.40972885352, 39397.80301098476, 39108.608913910495, 39337.213255735296, 39935.80032099937, 40769.1846163081, 40816.1836763269, 35779.642203577634, 35832.67087639295, 35857.282854342244, 36711.63288367082, 37231.25537489181, 28108.85945570259, 28159.15522534327, 28166.2958426041, 28255.0, 28308.292292692848], "value": 18685.534627592984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9877504287349, 352.45369677000656, 361.8353649089664, 367.5240563470306, 369.57683452446946, 17761.64476710465, 18956.620867582657, 19028.36635170682, 19814.108365123568, 19966.70049949252, 17878.10609469528, 18296.0, 18460.076996150172, 18773.718394224063, 18809.24763009478, 5293.179557168635, 5459.290292262001, 5463.453654634544, 5487.451254874501, 5498.862528436781, 5371.81198658047, 5373.140297552392, 5490.917636235459, 5511.5315198208, 5538.307711536058, 5366.9463305367035, 5418.593605479585, 5424.674519528821, 5426.21319908613, 5454.7272636368225, 5204.34945631796, 5432.2123292122615, 5451.972740136313, 5468.179773034077, 5484.698341591211, 4798.904021919542, 4803.3995750531185, 4808.302796094582, 4827.613790896755, 4827.85516434504, 21033.368998929902, 21872.23447179357, 22039.228626997978, 22054.779452205432, 22681.88659056694, 2299.655051742252, 2330.196082351586, 2589.3138318345655, 2930.1209637108996, 3025.8184508929535, 13845.30773461333, 14285.928570357186, 14334.283285835667, 14497.782533262009, 14508.129512229194, 1864.580469394389, 1867.598466329732, 1888.3673969220329, 1904.8952307623076, 1941.107090738262, 74085.6295718518, 75124.62437687832, 76199.0, 76223.61888190579, 76256.23743762603, 9309.581068851918, 9447.858282125637, 9488.857667134998, 9664.95167524172, 9673.70978870635, 12415.813762793565, 12582.37088145589, 12622.179558328862, 12670.746585068247, 12698.873011269769, 7679.923200768033, 7819.0, 7831.06027276719, 7848.686052557834, 7951.801204969806, 7722.227777222233, 7741.303282704584, 7839.843203135905, 7905.525668459796, 7998.040235171817, 5990.161377407167, 6117.755289788448, 6251.468625166821, 6320.968395158086, 6350.904736428957, 1664.2095004872588, 1686.9709477218887, 1698.7451882217765, 1705.2411676803704, 1732.3503686117706, 949.3591825517748, 973.1728031173587, 1034.9948250258851, 1065.63235683689, 1088.9183311251688, 17445.91277043632, 18716.251349946124, 19605.50986225356, 19647.803521964885, 19672.213111475667, 999.835027220515, 1027.732789474727, 1027.8047171037479, 1042.5829668132808, 1051.5057922776282, 10752.19358548112, 11207.831882521768, 11343.205975581795, 11362.0, 11436.714082148013, 487456.0, 488730.0, 493503.0, 502438.0, 503567.0, 56863.71568142133, 74727.62636186785, 76598.0, 79555.20444795594, 83232.0, 900.3742399032609, 1012.6810054832852, 1022.6778564752079, 1023.3399457350116, 1024.626011505795, 17569.121543922498, 17745.378911738026, 17764.555886102433, 17839.821601783817, 18025.2789888403, 39250.80374598109, 39362.80318598389, 39655.40516892307, 39704.2059158821, 41067.178656426106, 50534.0, 51651.48348516467, 51861.22208166805, 51936.0, 52822.47177528175, 7419.0, 7587.0, 7670.7315243966195, 7675.2324767522805, 7891.605419729105, 12610.747785044432, 13221.801672974721, 13225.206487610774, 13233.536826211037, 13285.335733213107, 11190.83213751778, 11355.772884542428, 11567.074634029426, 11622.535098595961, 11701.88298117008, 11331.490082946122, 11465.885341146482, 11472.139589530985, 11659.417029148679, 11860.110491712983, 11608.606967163656, 11630.418479076181, 11706.76586468283, 11949.22330048544, 11980.760384792082, 7716.382689384724, 7760.0, 7762.262585054411, 7774.611269436618, 7890.921090789018, 11498.367589782642, 11548.769024619292, 11580.478878450658, 11704.063674906158, 11768.52925882955], "value": 8981.94195714296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.9635759106025, 1477.2687519677759, 1558.4233833481605, 1682.8906121102127, 1716.776819013528, 7462.440316976222, 8239.382046346525, 8335.208155225258, 8848.026717061126, 8856.11438856115, 8437.493750374966, 8470.407071504982, 8567.443116197459, 8587.78530536737, 8591.957040214791, 2235.4634887626935, 2250.1674380479244, 2262.400463877074, 2268.5349503351854, 2274.363178310076, 2195.5060111474872, 2216.6896634471104, 2220.955580888381, 2227.676986836908, 2235.16181431963, 2214.3467677035233, 2225.310153852303, 2233.6091184042807, 2242.686023956647, 2253.7746225377414, 2121.352987338861, 2135.391413447168, 2144.024468866662, 2146.6350720377573, 2149.011454730826, 2159.1471368809234, 2164.9891750541306, 2171.6308227601344, 2172.239716099353, 2173.076442511926, 8684.175003374668, 8735.0, 8754.562271886443, 8760.299176065962, 8772.736817895473, 4948.87627809304, 4998.000399920031, 5043.1426657467955, 5050.494950504957, 5057.721825299607, 3223.3069889973535, 3326.101952472843, 3450.8447119879665, 3451.5858097028517, 3482.791032538056, 1088.7659153282002, 1091.8089334366455, 1095.9835602465969, 1096.8793432722393, 1115.6374178391975, 12014.459349329214, 12024.0981926355, 12120.878791212062, 12139.939300303531, 12142.514299428012, 4271.337942618899, 4283.271843786564, 4343.457067866517, 4410.16206920684, 4425.623821975104, 10125.594976201017, 10167.593296268215, 10178.338408003456, 10203.693889183336, 10206.744831379276, 4979.103761322996, 4980.178270585386, 4997.375328083989, 5127.154019586801, 5136.5890728741615, 4003.7597744135446, 4569.634429245652, 4732.976335118371, 4736.905261894743, 4757.476677565465, 3790.0, 3809.542854857435, 3826.253880493333, 3916.1971795781797, 3920.5491368492417, 1142.737170450801, 1182.3733421286731, 1186.2348785033778, 1187.7565099154654, 1198.161287099034, 907.9137481939205, 982.29274922056, 1008.8738907636546, 1013.7313611892854, 1025.3027941000043, 5833.241678581757, 5992.400759923973, 6006.12911127884, 6028.849278768066, 6055.091736239511, 379.87084391307087, 386.44159189970225, 396.33613697057314, 398.25128757934897, 403.4654083339587, 4216.945763559111, 4340.453382519196, 4358.607725304738, 4379.824807007684, 4406.625436837905, 10307.381557106597, 10504.264701470824, 10644.042036216622, 10663.466826658636, 10685.732856678645, 10287.588496460057, 10447.477626118816, 10457.581696732046, 10488.790224195473, 10583.576656933636, 7784.610769461504, 7815.515052140189, 7871.763847084597, 7892.0, 7899.170587088388, 5767.653940763567, 5783.450572195635, 5793.246877906014, 5818.214541036906, 5866.882662346815, 9666.130048295687, 9800.558974846006, 9854.507274636382, 9868.111869931741, 9885.308028437941, 9660.275479339218, 9804.36271642341, 9940.751481213027, 10000.199984001409, 10012.899871001197, 6639.7012134455035, 7314.232005639544, 7644.0827100748265, 7645.120811106794, 7698.730544430918, 8400.831983360176, 8498.830023399621, 8526.91473085286, 8564.400491965502, 8593.871091933752, 7605.35354494852, 7881.369490440637, 7888.053433587776, 7935.444518883623, 8004.119546849725, 7620.542767433972, 7637.427192960661, 7662.157162712208, 7665.6933722650465, 7696.345810605937, 6699.464042876461, 6740.224874139537, 6796.830079248059, 6821.181458224846, 6831.863362732618, 5133.614978876524, 5188.896222075613, 5209.166533354645, 5278.076336640996, 5300.70846103468, 5133.512316329943, 5319.973400133129, 5336.893262134658, 5347.7593508293, 5360.437154098763], "value": 4430.277686201044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.05886458006216, 308.327845297252, 310.1455490124706, 312.8482685897338, 314.1048013162486, 5598.832035038945, 5614.775408983635, 5679.176519404684, 5689.6017278790505, 5694.231278777369, 5540.750666220019, 5548.361938377087, 5578.804741834037, 5586.888262234753, 5633.295838020247, 4008.0, 4174.1651669666035, 4290.5709429057, 4316.611504964552, 4354.281543545311, 4309.762963037032, 4328.415663885383, 4331.5884990925815, 4333.978330108361, 4339.284018137019, 4294.9570504295025, 4303.268444364466, 4318.287482565373, 4324.6107850293465, 4329.588689074533, 4023.135025969416, 4229.936550951738, 4266.549373213123, 4269.295566231568, 4326.264535029052, 3668.394714872043, 3691.8892433227047, 3695.1870588470492, 3698.0569954661387, 3698.981505092457, 5481.506664400184, 5488.862778430571, 5492.368377636543, 5499.395066542677, 5507.642003269774, 4685.320628508847, 4890.706557606555, 4909.2881532177635, 4909.8772530686665, 4917.434495033045, 5852.858692554953, 5873.6211834207215, 5878.971180043475, 5893.852653683649, 5898.696729831266, 4102.569230230843, 4106.281400754886, 4119.588041195856, 4128.876133715993, 4142.91714165718, 5949.839781242659, 6053.334133245339, 6105.877882442371, 6122.571420000646, 6159.0, 4092.1611069730634, 4097.590240975938, 4116.361963895601, 4123.649489793341, 4128.215639028635, 4143.544210136883, 4168.499780026416, 4188.68584856137, 4192.958070419257, 4197.181549597799, 4673.434399476146, 4880.608501834146, 4891.290762839369, 4896.583790377857, 4908.165611845995, 5810.215620891126, 5814.215080964101, 5917.408259174048, 5965.433283838029, 5972.940270597325, 1431.6184881589315, 1436.2531483628454, 1449.6013596260902, 1449.8763458319886, 1450.5285782120852, 862.8964524257129, 888.3159966825638, 914.7255823253131, 924.8497243907941, 934.1265916368218, 5529.645236916981, 5623.268975033219, 5623.971880140573, 5633.859153521113, 5664.97167514168, 6000.409891378788, 6000.669963151981, 6010.278766547955, 6022.789202377896, 6044.516438684895, 5392.110301800159, 5646.181303710939, 5657.830265092054, 5658.773649053992, 5662.207290979266, 3167.55654208411, 3210.7431405487505, 3219.645838957713, 3231.7054891027165, 3264.6735326467165, 5885.941140588625, 6185.505159587312, 6215.098810672517, 6242.500599952084, 6269.7492100316385, 6138.754449821957, 6142.201513803267, 6164.0, 6184.81445556634, 6210.813675589739, 6137.324894261627, 6174.845628859314, 6216.595921265194, 6302.527310451735, 6303.149074874925, 5957.910631340446, 6040.493195323891, 6054.33402325735, 6096.817095487142, 6125.938740612715, 6011.27864656244, 6017.562887030759, 6036.939630603638, 6047.576669633084, 6060.000099983454, 6092.177556029879, 6227.564070515021, 6234.625922444668, 6262.624242545462, 6281.183446151971, 4092.7544347339253, 4126.546079931265, 4129.793510324532, 4167.791610419527, 4171.374293855946, 6109.51123910095, 6111.511079113571, 6146.477549408351, 6175.783847565313, 6177.980633195652, 5684.124239001037, 5914.2311499504785, 6005.399460054135, 6012.969935150296, 6036.69816509164, 5898.882022359615, 5940.435658612425, 5950.19672344228, 5980.372060933713, 5988.850278742892, 5350.652207606493, 5808.883822323614, 5861.472467477947, 5865.296164460292, 5877.766448749448, 5895.260898035004, 5923.104606525871, 5930.851728706817, 5946.28644562638, 5948.821535353946, 5586.804461843816, 5809.448102430262, 5822.214001109796, 5849.385814489588, 5862.267216597926], "value": 4423.691936322365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.1465948191913, 762.9389648828094, 796.7251298302091, 817.595290331286, 854.2098558833078, 14141.858581414182, 15696.0, 16059.0, 16100.03399796013, 16147.83852161478, 14443.855561444383, 14628.34172462239, 14726.26368681567, 14742.0, 14824.407023719039, 601.3955974245898, 703.9436845052384, 704.8097013806282, 720.8233982674226, 721.1778572427437, 709.6097146569366, 711.0578483509371, 711.7615598774416, 714.7998560403096, 721.6572128239097, 753.8605358008758, 756.0889128600052, 756.3457609168057, 756.3570964680006, 757.526545908807, 745.2361329637112, 748.2255865179513, 749.4229443328634, 749.741339237962, 753.0699586011272, 547.9589030822705, 548.9835304940818, 550.5485501888453, 551.1017042221154, 551.1017042221193, 15301.61745956349, 15377.461788837449, 15389.538313850491, 15394.692106157814, 15430.228488575527, 14137.858621413758, 14685.706285874223, 14977.251137443192, 15027.624309392244, 15027.699446011018, 11742.941285293518, 12095.334756588383, 12135.393230338535, 12327.568535101318, 12491.875081249162, 3814.9427758583643, 3843.846246150151, 3889.8833035008997, 3906.58980807014, 3963.4451176835264, 74378.25621743768, 77256.61371693105, 77292.61353693252, 78545.0, 79300.20699792985, 10836.40399778004, 11187.94406027981, 11530.702213189586, 11806.291622502677, 11858.644240672622, 21062.2628208012, 21187.576248474943, 21207.893960530408, 21406.892965535073, 21886.233981810878, 8825.514596697243, 8921.776955576162, 8930.419522731132, 9000.549972501349, 9190.172884440433, 4742.1227072991605, 4801.663883528119, 4821.783019764119, 4863.635227357891, 4922.827701030446, 3473.2879759649213, 3647.708183345326, 3662.926741465156, 3663.0, 3663.670269675689, 603.2429301226932, 623.8783437229697, 630.338144947803, 639.5203597302024, 664.4750646988824, 606.7936901453527, 610.6702380714453, 655.4428735574724, 659.0049025970723, 693.1612748574181, 9624.0, 9754.122129008423, 9917.92509853476, 9943.403395796275, 9980.0, 614.3549273263056, 661.5258733976289, 690.8169335126196, 730.3244498838553, 732.8900664900308, 4654.162250794821, 4668.159731248408, 4728.1252968201, 4730.52694730531, 4795.832145874878, 95352.0, 98342.0, 100500.49749751204, 107858.0, 110882.0, 62270.688646556475, 79326.60336698279, 93323.53338233402, 95446.52276738572, 97432.51283743678, 76781.23218767741, 77045.61477192579, 83455.58272208722, 86748.5662571683, 89654.55172724224, 9525.666601668909, 10128.746781330527, 10329.638462653771, 10453.68638940833, 10467.94766026165, 46266.53733462622, 50444.0, 50583.74708126436, 51409.74295128501, 52625.21062184147, 64655.353446464935, 64995.0, 73152.63423682848, 74013.4355567756, 74501.25498744943, 12626.635290363694, 12726.363681816058, 12783.23300601967, 12950.158239714388, 13121.803172952223, 14435.855641443452, 14448.927755361156, 14503.637409064857, 14848.925755371587, 14874.330655120762, 13340.866591333963, 13894.0, 14218.146911184947, 15025.398984040516, 15029.549113526611, 13228.933855330662, 13257.734845303234, 13373.799393008918, 13404.061715679809, 13669.111507751964, 10700.411477368509, 12744.299063551594, 13375.197488150741, 13596.11625244356, 14398.640033998814, 11533.0, 11949.761004779682, 11962.282263064244, 11978.161528692908, 12109.69725756863, 11805.645830625095, 11849.763004740029, 11886.0, 11930.821037684615, 12117.151799374311], "value": 7404.530640061506, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 110.0, 112.0, 110.0, 113.0, 112.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 154.0, 179.0, 128.0, 159.0, 159.0, 128.0, 190.0, 129.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 165.0, 162.0, 185.0, 162.0, 161.0, 162.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 159.0, 78.0, 76.0, 75.0, 75.0, 168.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 157.0, 85.0, 88.0, 85.0, 153.0, 85.0, 84.0, 147.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 149.0, 146.0, 148.0, 146.0, 146.0, 149.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 56.0, 59.0, 55.0, 56.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 66.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 79.0, 81.0, 84.0, 82.0, 80.0, 80.0, 110.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 122.0, 121.0, 122.0, 127.0, 121.0, 127.0, 155.0, 125.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 160.0, 169.0, 160.0, 156.0, 157.0, 157.0, 158.0, 158.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 65.0, 64.0, 63.0, 65.0, 65.0, 64.0, 62.0, 64.0], "value": 65.0, "unit": "score"}]}]} 01:34:47 INFO - Return code: 0 01:34:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:34:47 ERROR - # TBPL SUCCESS # 01:34:47 INFO - Running post-action listener: _resource_record_post_action 01:34:47 INFO - ##### 01:34:47 INFO - ##### Finished run-tests step (success) 01:34:47 INFO - ##### 01:34:47 INFO - Running post-run listener: _resource_record_post_run 01:34:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7950336; Write bytes: 450756608; Read time: 1100; Write time: 406404 01:34:48 INFO - TinderboxPrint: CPU usage
13.4% 01:34:48 INFO - TinderboxPrint: I/O read bytes / time
7,950,336 / 1,100 01:34:48 INFO - TinderboxPrint: I/O write bytes / time
450,756,608 / 406,404 01:34:48 INFO - TinderboxPrint: CPU idle
8,247.7 (86.6%) 01:34:48 INFO - TinderboxPrint: CPU user
1,216.7 (12.8%) 01:34:48 INFO - TinderboxPrint: Swap in / out
0 / 0 01:34:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20598784; Read time: 0; Write time: 14084 01:34:48 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6057984; Write bytes: 430157824; Read time: 908; Write time: 392320 01:34:48 INFO - Running post-run listener: _upload_blobber_files 01:34:48 INFO - Blob upload gear active. 01:34:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:34:48 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 01:34:48 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'] 01:34:48 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 01:34:48 INFO - (blobuploader) - INFO - Open directory for files ... 01:34:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:34:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:49 INFO - (blobuploader) - INFO - Done attempting. 01:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:54 INFO - (blobuploader) - INFO - Done attempting. 01:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:54 INFO - (blobuploader) - INFO - Done attempting. 01:34:54 INFO - (blobuploader) - INFO - Iteration through files over. 01:34:54 INFO - Return code: 0 01:34:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:34:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:34:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92286912ac6bf674cf7ce608b826350a14883a2003055bbeae1347bac71b49a8cdf89f1fe33671dc701ca0acea4ad45925256bc379798d9a7a9d8d10f8053a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87e8f1569df9690ef50c55b143630a61b5573462f6f85baa5d453da6087dea5e479dd445b905748f33b7f20982e9672fdbeeafe0dc7b5b3aca3f938f783740df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1fb7d5628c8c100f0ee0454f10650b30e160799ae3daaa5e20377208eaaee88c7f5719736e13cd7e231301998a132a1fdc74b0b85696f1847ed59f729beb452"} 01:34:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:34:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:34:54 INFO - Contents: 01:34:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92286912ac6bf674cf7ce608b826350a14883a2003055bbeae1347bac71b49a8cdf89f1fe33671dc701ca0acea4ad45925256bc379798d9a7a9d8d10f8053a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87e8f1569df9690ef50c55b143630a61b5573462f6f85baa5d453da6087dea5e479dd445b905748f33b7f20982e9672fdbeeafe0dc7b5b3aca3f938f783740df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1fb7d5628c8c100f0ee0454f10650b30e160799ae3daaa5e20377208eaaee88c7f5719736e13cd7e231301998a132a1fdc74b0b85696f1847ed59f729beb452"} 01:34:54 INFO - Running post-run listener: copy_logs_to_upload_dir 01:34:54 INFO - Copying logs to upload dir... 01:34:54 INFO - mkdir: /builds/slave/test/build/upload/logs 01:34:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.212615 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-09 01:34:55.010791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 01:34:55.014553) ========= 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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 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/92286912ac6bf674cf7ce608b826350a14883a2003055bbeae1347bac71b49a8cdf89f1fe33671dc701ca0acea4ad45925256bc379798d9a7a9d8d10f8053a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87e8f1569df9690ef50c55b143630a61b5573462f6f85baa5d453da6087dea5e479dd445b905748f33b7f20982e9672fdbeeafe0dc7b5b3aca3f938f783740df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1fb7d5628c8c100f0ee0454f10650b30e160799ae3daaa5e20377208eaaee88c7f5719736e13cd7e231301998a132a1fdc74b0b85696f1847ed59f729beb452"} build_url:https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/JDZlHw6sSK2xiMWO0hD5mQ/artifacts/public/build/firefox-50.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/92286912ac6bf674cf7ce608b826350a14883a2003055bbeae1347bac71b49a8cdf89f1fe33671dc701ca0acea4ad45925256bc379798d9a7a9d8d10f8053a52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/87e8f1569df9690ef50c55b143630a61b5573462f6f85baa5d453da6087dea5e479dd445b905748f33b7f20982e9672fdbeeafe0dc7b5b3aca3f938f783740df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1fb7d5628c8c100f0ee0454f10650b30e160799ae3daaa5e20377208eaaee88c7f5719736e13cd7e231301998a132a1fdc74b0b85696f1847ed59f729beb452"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 01:34:55.041401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:34:55.041725) ========= 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=d2a8c569965ab8367867b893000001a1-1465459535.928089-1563761912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 01:34:55.124010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 01:34:55.124340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 01:34:55.124617) ========= ========= Total master_lag: 0.25 =========