builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1463748557.92 results: success (0) buildid: 20160520030251 builduid: 073e2ba98f47465f876c674745227711 revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:17.921181) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:17.921879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:17.922183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:17.987805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:17.988097) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 05:49:18-- 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% 221M=0s 2016-05-20 05:49:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.124635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.124968) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017924 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.196797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.197120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c67dc1f9fab86d4f2cf3224307809c44fe3ce820 --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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 05:49:18,293 truncating revision to first 12 chars 2016-05-20 05:49:18,293 Setting DEBUG logging. 2016-05-20 05:49:18,293 attempt 1/10 2016-05-20 05:49:18,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c67dc1f9fab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 05:49:18,564 unpacking tar archive at: mozilla-central-c67dc1f9fab8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.773739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.774050) ========= script_repo_revision: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.774503) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.774817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 05:49:18.796042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-20 05:49:18.796327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:18 INFO - MultiFileLogger online at 20160520 05:49:18 in /builds/slave/test 05:49:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:18 INFO - {'append_to_log': False, 05:49:18 INFO - 'base_work_dir': '/builds/slave/test', 05:49:18 INFO - 'blob_upload_branch': 'Firefox', 05:49:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:18 INFO - 'branch': 'Firefox', 05:49:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:18 INFO - 'config_files': ('talos/linux_config.py',), 05:49:18 INFO - 'default_actions': ('clobber', 05:49:18 INFO - 'read-buildbot-config', 05:49:18 INFO - 'download-and-extract', 05:49:18 INFO - 'populate-webroot', 05:49:18 INFO - 'create-virtualenv', 05:49:18 INFO - 'install', 05:49:18 INFO - 'run-tests'), 05:49:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:18 INFO - 'download_minidump_stackwalk': True, 05:49:18 INFO - 'download_symbols': 'ondemand', 05:49:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:18 INFO - 'installer_path': 'installer.exe', 05:49:18 INFO - 'log_level': 'info', 05:49:18 INFO - 'log_name': 'talos', 05:49:18 INFO - 'log_to_console': True, 05:49:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:18 INFO - 'opt_config_files': (), 05:49:18 INFO - 'pip_index': False, 05:49:18 INFO - 'sps_profile': False, 05:49:18 INFO - 'sps_profile_interval': 0, 05:49:18 INFO - 'suite': 'dromaeojs', 05:49:18 INFO - 'system_bits': '32', 05:49:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:18 INFO - 'title': 'talos-linux64-ix-036', 05:49:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:18 INFO - 'use_talos_json': True, 05:49:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:18 INFO - 'work_dir': 'build'} 05:49:18 INFO - ##### 05:49:18 INFO - ##### Running clobber step. 05:49:18 INFO - ##### 05:49:18 INFO - Running pre-action listener: _resource_record_pre_action 05:49:18 INFO - Running main action method: clobber 05:49:18 INFO - rmtree: /builds/slave/test/build 05:49:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:19 INFO - Running post-action listener: _resource_record_post_action 05:49:19 INFO - ##### 05:49:19 INFO - ##### Finished clobber step (success) 05:49:19 INFO - ##### 05:49:19 INFO - ##### 05:49:19 INFO - ##### Running read-buildbot-config step. 05:49:19 INFO - ##### 05:49:19 INFO - Running pre-action listener: _resource_record_pre_action 05:49:19 INFO - Running main action method: read_buildbot_config 05:49:19 INFO - Using buildbot properties: 05:49:19 INFO - { 05:49:19 INFO - "project": "", 05:49:19 INFO - "product": "firefox", 05:49:19 INFO - "script_repo_revision": "production", 05:49:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:49:19 INFO - "repository": "", 05:49:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:49:19 INFO - "buildid": "20160520030251", 05:49:19 INFO - "stage_platform": "linux64-pgo", 05:49:19 INFO - "basedir": "/builds/slave/test", 05:49:19 INFO - "nightly_build": "True", 05:49:19 INFO - "buildnumber": 292, 05:49:19 INFO - "slavename": "talos-linux64-ix-036", 05:49:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:49:19 INFO - "platform": "ubuntu64_hw", 05:49:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:19 INFO - "branch": "mozilla-central", 05:49:19 INFO - "repo_path": "mozilla-central", 05:49:19 INFO - "revision": "c67dc1f9fab86d4f2cf3224307809c44fe3ce820", 05:49:19 INFO - "pgo_build": "True", 05:49:19 INFO - "builduid": "073e2ba98f47465f876c674745227711", 05:49:19 INFO - "slavebuilddir": "test" 05:49:19 INFO - } 05:49:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:49:19 INFO - Running post-action listener: _resource_record_post_action 05:49:19 INFO - ##### 05:49:19 INFO - ##### Finished read-buildbot-config step (success) 05:49:19 INFO - ##### 05:49:19 INFO - ##### 05:49:19 INFO - ##### Running download-and-extract step. 05:49:19 INFO - ##### 05:49:19 INFO - Running pre-action listener: _resource_record_pre_action 05:49:19 INFO - Running main action method: download_and_extract 05:49:19 INFO - mkdir: /builds/slave/test/build/tests 05:49: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')]} 05:49:19 INFO - https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:49:22 INFO - Downloaded 1361 bytes. 05:49:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:22 INFO - Using the following test package requirements: 05:49:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'jsshell-linux-x86_64.zip'], 05:49:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49: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')]} 05:49:22 INFO - https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:23 INFO - Downloaded 24387674 bytes. 05:49:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:24 INFO - Return code: 0 05:49:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:24 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')]} 05:49:24 INFO - https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:26 INFO - Downloaded 24387674 bytes. 05:49:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:27 INFO - Return code: 0 05:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:27 INFO - https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:29 INFO - Downloaded 10840359 bytes. 05:49:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:29 INFO - Return code: 0 05:49: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')]} 05:49:29 INFO - https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:32 INFO - Downloaded 58588280 bytes. 05:49:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:32 INFO - mkdir: /builds/slave/test/properties 05:49:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:32 INFO - Contents: 05:49:32 INFO - build_url:https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:33 INFO - Running post-action listener: _resource_record_post_action 05:49:33 INFO - Running post-action listener: set_extra_try_arguments 05:49:33 INFO - ##### 05:49:33 INFO - ##### Finished download-and-extract step (success) 05:49:33 INFO - ##### 05:49:33 INFO - ##### 05:49:33 INFO - ##### Running populate-webroot step. 05:49:33 INFO - ##### 05:49:33 INFO - Running pre-action listener: _resource_record_pre_action 05:49:33 INFO - Running main action method: populate_webroot 05:49:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:33 INFO - '--tppagecycles', 05:49:33 INFO - '7'], 05:49:33 INFO - 'tests': ['tsvgm']}}, 05:49:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['damp', 'tps']}, 05:49:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'tests': ['damp', 'tps']}, 05:49:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['dromaeo_dom']}, 05:49:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['a11yr', 05:49:33 INFO - 'ts_paint', 05:49:33 INFO - 'tpaint', 05:49:33 INFO - 'sessionrestore', 05:49:33 INFO - 'sessionrestore_no_auto_restore', 05:49:33 INFO - 'tabpaint']}, 05:49:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['tsvgx', 05:49:33 INFO - 'tsvgr_opacity', 05:49:33 INFO - 'tart', 05:49:33 INFO - 'tscrollx', 05:49:33 INFO - 'cart']}, 05:49:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:33 INFO - 'tsvgr_opacity', 05:49:33 INFO - 'tart', 05:49:33 INFO - 'tscrollx', 05:49:33 INFO - 'cart']}, 05:49:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'talos_options': ['--disable-e10s'], 05:49:33 INFO - 'tests': ['tp5o']}, 05:49:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'tests': ['tp5o']}, 05:49:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'talos_options': ['--disable-e10s', 05:49:33 INFO - '--xperf_path', 05:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:33 INFO - 'tests': ['tp5n']}, 05:49:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:33 INFO - 'talos_options': ['--xperf_path', 05:49:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:33 INFO - 'tests': ['tp5n']}}, 05:49:33 INFO - 'talos.zip': {'path': '', 05:49:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:33 INFO - Running post-action listener: _resource_record_post_action 05:49:33 INFO - ##### 05:49:33 INFO - ##### Finished populate-webroot step (success) 05:49:33 INFO - ##### 05:49:33 INFO - ##### 05:49:33 INFO - ##### Running create-virtualenv step. 05:49:33 INFO - ##### 05:49:33 INFO - Running pre-action listener: _resource_record_pre_action 05:49:33 INFO - Running main action method: create_virtualenv 05:49:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:33 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 05:49:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:33 INFO - Using real prefix '/usr' 05:49:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:35 INFO - Installing pip.................done. 05:49:35 INFO - Return code: 0 05:49:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:35 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 05:49:35 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 05:49:35 INFO - Using env: {'DISPLAY': ':0', 05:49:35 INFO - 'HOME': '/home/cltbld', 05:49:35 INFO - 'LANG': 'en_US.UTF-8', 05:49:35 INFO - 'LANGUAGE': 'en_US:en', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MAIL': '/var/mail/cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SHLVL': '1', 05:49:35 INFO - 'TERM': 'linux', 05:49:35 INFO - 'TMOUT': '86400', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - '_': '/tools/buildbot/bin/python'} 05:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:35 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 05:49:35 INFO - Cleaning up... 05:49:35 INFO - Return code: 0 05:49:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:35 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:35 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 05:49:35 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 05:49:35 INFO - Using env: {'DISPLAY': ':0', 05:49:35 INFO - 'HOME': '/home/cltbld', 05:49:35 INFO - 'LANG': 'en_US.UTF-8', 05:49:35 INFO - 'LANGUAGE': 'en_US:en', 05:49:35 INFO - 'LOGNAME': 'cltbld', 05:49:35 INFO - 'MAIL': '/var/mail/cltbld', 05:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:35 INFO - 'MOZ_NO_REMOTE': '1', 05:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:35 INFO - 'NO_EM_RESTART': '1', 05:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:35 INFO - 'PWD': '/builds/slave/test', 05:49:35 INFO - 'SHELL': '/bin/bash', 05:49:35 INFO - 'SHLVL': '1', 05:49:35 INFO - 'TERM': 'linux', 05:49:35 INFO - 'TMOUT': '86400', 05:49:35 INFO - 'USER': 'cltbld', 05:49:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:35 INFO - '_': '/tools/buildbot/bin/python'} 05:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:36 INFO - Downloading/unpacking psutil>=3.1.1 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:36 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 05:49:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:38 INFO - Installing collected packages: psutil 05:49:38 INFO - Running setup.py install for psutil 05:49:38 INFO - building 'psutil._psutil_linux' extension 05:49:38 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 05:49:38 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 05:49:38 INFO - building 'psutil._psutil_posix' extension 05:49:38 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 05:49:38 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 05:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:38 INFO - Successfully installed psutil 05:49:38 INFO - Cleaning up... 05:49:38 INFO - Return code: 0 05:49:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:38 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')]} 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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')]} 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:38 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 05:49:38 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 05:49:38 INFO - Using env: {'DISPLAY': ':0', 05:49:38 INFO - 'HOME': '/home/cltbld', 05:49:38 INFO - 'LANG': 'en_US.UTF-8', 05:49:38 INFO - 'LANGUAGE': 'en_US:en', 05:49:38 INFO - 'LOGNAME': 'cltbld', 05:49:38 INFO - 'MAIL': '/var/mail/cltbld', 05:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:38 INFO - 'MOZ_NO_REMOTE': '1', 05:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:38 INFO - 'NO_EM_RESTART': '1', 05:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:38 INFO - 'PWD': '/builds/slave/test', 05:49:38 INFO - 'SHELL': '/bin/bash', 05:49:38 INFO - 'SHLVL': '1', 05:49:38 INFO - 'TERM': 'linux', 05:49:38 INFO - 'TMOUT': '86400', 05:49:38 INFO - 'USER': 'cltbld', 05:49:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:38 INFO - '_': '/tools/buildbot/bin/python'} 05:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:40 INFO - Installing collected packages: mozsystemmonitor 05:49:40 INFO - Running setup.py install for mozsystemmonitor 05:49:40 INFO - Successfully installed mozsystemmonitor 05:49:40 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:41 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')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 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')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:41 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 05:49:41 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 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - Downloading docopt-0.6.1.tar.gz 05:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:43 INFO - Running setup.py install for blobuploader 05:49:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:44 INFO - Running setup.py install for requests 05:49:44 INFO - Running setup.py install for docopt 05:49:44 INFO - Successfully installed blobuploader requests docopt 05:49:44 INFO - Cleaning up... 05:49:44 INFO - Return code: 0 05:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:44 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:44 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 05:49:44 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 05:49:44 INFO - Using env: {'DISPLAY': ':0', 05:49:44 INFO - 'HOME': '/home/cltbld', 05:49:44 INFO - 'LANG': 'en_US.UTF-8', 05:49:44 INFO - 'LANGUAGE': 'en_US:en', 05:49:44 INFO - 'LOGNAME': 'cltbld', 05:49:44 INFO - 'MAIL': '/var/mail/cltbld', 05:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:44 INFO - 'MOZ_NO_REMOTE': '1', 05:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:44 INFO - 'NO_EM_RESTART': '1', 05:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:44 INFO - 'PWD': '/builds/slave/test', 05:49:44 INFO - 'SHELL': '/bin/bash', 05:49:44 INFO - 'SHLVL': '1', 05:49:44 INFO - 'TERM': 'linux', 05:49:44 INFO - 'TMOUT': '86400', 05:49:44 INFO - 'USER': 'cltbld', 05:49:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:44 INFO - '_': '/tools/buildbot/bin/python'} 05:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:44 INFO - Running setup.py (path:/tmp/pip-bDgpA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:44 INFO - Running setup.py (path:/tmp/pip-1fx7Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:44 INFO - Running setup.py (path:/tmp/pip-1qELmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:44 INFO - Running setup.py (path:/tmp/pip-AnR12J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:45 INFO - Running setup.py (path:/tmp/pip-c6aYVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:45 INFO - Running setup.py (path:/tmp/pip-usDFzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:45 INFO - Running setup.py (path:/tmp/pip-J0XNcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:45 INFO - Running setup.py (path:/tmp/pip-LA6f8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:45 INFO - Running setup.py (path:/tmp/pip-Lj9Geb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:45 INFO - Running setup.py (path:/tmp/pip-ht_yyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:45 INFO - Running setup.py (path:/tmp/pip-OHirNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:45 INFO - Running setup.py (path:/tmp/pip-xr2GDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:45 INFO - Running setup.py (path:/tmp/pip-shOdfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:45 INFO - Running setup.py (path:/tmp/pip-KkyGkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:45 INFO - Running setup.py (path:/tmp/pip-k4s0oV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:45 INFO - Running setup.py (path:/tmp/pip-OBzmP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:45 INFO - Running setup.py (path:/tmp/pip-_NHbNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:45 INFO - Running setup.py install for manifestparser 05:49:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for mozcrash 05:49:46 INFO - Running setup.py install for mozdebug 05:49:46 INFO - Running setup.py install for mozdevice 05:49:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for mozfile 05:49:46 INFO - Running setup.py install for mozhttpd 05:49:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for mozinfo 05:49:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for mozInstall 05:49:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for mozleak 05:49:46 INFO - Running setup.py install for mozlog 05:49:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:46 INFO - Running setup.py install for moznetwork 05:49:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Running setup.py install for mozprocess 05:49:47 INFO - Running setup.py install for mozprofile 05:49:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Running setup.py install for mozrunner 05:49:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Running setup.py install for mozscreenshot 05:49:47 INFO - Running setup.py install for moztest 05:49:47 INFO - Running setup.py install for mozversion 05:49:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:47 INFO - Cleaning up... 05:49:47 INFO - Return code: 0 05:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:47 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')]} 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 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')]} 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:47 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 05:49:47 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 05:49:47 INFO - Using env: {'DISPLAY': ':0', 05:49:47 INFO - 'HOME': '/home/cltbld', 05:49:47 INFO - 'LANG': 'en_US.UTF-8', 05:49:47 INFO - 'LANGUAGE': 'en_US:en', 05:49:47 INFO - 'LOGNAME': 'cltbld', 05:49:47 INFO - 'MAIL': '/var/mail/cltbld', 05:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:47 INFO - 'MOZ_NO_REMOTE': '1', 05:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:47 INFO - 'NO_EM_RESTART': '1', 05:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:47 INFO - 'PWD': '/builds/slave/test', 05:49:47 INFO - 'SHELL': '/bin/bash', 05:49:47 INFO - 'SHLVL': '1', 05:49:47 INFO - 'TERM': 'linux', 05:49:47 INFO - 'TMOUT': '86400', 05:49:47 INFO - 'USER': 'cltbld', 05:49:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:47 INFO - '_': '/tools/buildbot/bin/python'} 05:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:47 INFO - Running setup.py (path:/tmp/pip-t4BVm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:47 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)) 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:47 INFO - Running setup.py (path:/tmp/pip-YAzXqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:48 INFO - Running setup.py (path:/tmp/pip-E_Lipr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:48 INFO - Running setup.py (path:/tmp/pip-yIpzDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:48 INFO - Running setup.py (path:/tmp/pip-AilpQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:48 INFO - Running setup.py (path:/tmp/pip-9eCoZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:48 INFO - Running setup.py (path:/tmp/pip-Tof68_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:48 INFO - Running setup.py (path:/tmp/pip-3g7KEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:48 INFO - Running setup.py (path:/tmp/pip-yxAUvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:48 INFO - Running setup.py (path:/tmp/pip-4PVZWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:48 INFO - Running setup.py (path:/tmp/pip-10fZQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:48 INFO - Running setup.py (path:/tmp/pip-wjK8RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:48 INFO - Running setup.py (path:/tmp/pip-Vuosku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:48 INFO - Running setup.py (path:/tmp/pip-bKG4UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:48 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)) 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:48 INFO - Running setup.py (path:/tmp/pip-7Vk3po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:49 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)) 05:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:49 INFO - Running setup.py (path:/tmp/pip-8cXmOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:49 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)) 05:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:49 INFO - Running setup.py (path:/tmp/pip-XtJ4lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:49 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)) 05:49:49 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)) 05:49:49 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)) 05:49:49 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)) 05:49:49 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)) 05:49:49 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)) 05:49:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - Downloading blessings-1.6.tar.gz 05:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:51 INFO - Installing collected packages: blessings 05:49:51 INFO - Running setup.py install for blessings 05:49:51 INFO - Successfully installed blessings 05:49:51 INFO - Cleaning up... 05:49:51 INFO - Return code: 0 05:49:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:51 INFO - Reading from file tmpfile_stdout 05:49:51 INFO - Current package versions: 05:49:51 INFO - argparse == 1.2.1 05:49:51 INFO - blessings == 1.6 05:49:51 INFO - blobuploader == 1.2.4 05:49:51 INFO - docopt == 0.6.1 05:49:51 INFO - manifestparser == 1.1 05:49:51 INFO - mozInstall == 1.12 05:49:51 INFO - mozcrash == 0.17 05:49:51 INFO - mozdebug == 0.1 05:49:51 INFO - mozdevice == 0.48 05:49:51 INFO - mozfile == 1.2 05:49:51 INFO - mozhttpd == 0.7 05:49:51 INFO - mozinfo == 0.9 05:49:51 INFO - mozleak == 0.1 05:49:51 INFO - mozlog == 3.2 05:49:51 INFO - moznetwork == 0.27 05:49:51 INFO - mozprocess == 0.22 05:49:51 INFO - mozprofile == 0.28 05:49:51 INFO - mozrunner == 6.11 05:49:51 INFO - mozscreenshot == 0.1 05:49:51 INFO - mozsystemmonitor == 0.3 05:49:51 INFO - moztest == 0.7 05:49:51 INFO - mozversion == 1.4 05:49:51 INFO - psutil == 3.1.1 05:49:51 INFO - requests == 1.2.3 05:49:51 INFO - wsgiref == 0.1.2 05:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:51 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')]} 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 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')]} 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:51 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 05:49:51 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 05:49:51 INFO - Using env: {'DISPLAY': ':0', 05:49:51 INFO - 'HOME': '/home/cltbld', 05:49:51 INFO - 'LANG': 'en_US.UTF-8', 05:49:51 INFO - 'LANGUAGE': 'en_US:en', 05:49:51 INFO - 'LOGNAME': 'cltbld', 05:49:51 INFO - 'MAIL': '/var/mail/cltbld', 05:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:51 INFO - 'MOZ_NO_REMOTE': '1', 05:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:51 INFO - 'NO_EM_RESTART': '1', 05:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:51 INFO - 'PWD': '/builds/slave/test', 05:49:51 INFO - 'SHELL': '/bin/bash', 05:49:51 INFO - 'SHLVL': '1', 05:49:51 INFO - 'TERM': 'linux', 05:49:51 INFO - 'TMOUT': '86400', 05:49:51 INFO - 'USER': 'cltbld', 05:49:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:51 INFO - '_': '/tools/buildbot/bin/python'} 05:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 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)) 05:49:51 INFO - Cleaning up... 05:49:51 INFO - Return code: 0 05:49:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:51 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')]} 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 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')]} 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:51 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 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:51 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 05:49:51 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 05:49:51 INFO - Using env: {'DISPLAY': ':0', 05:49:51 INFO - 'HOME': '/home/cltbld', 05:49:51 INFO - 'LANG': 'en_US.UTF-8', 05:49:51 INFO - 'LANGUAGE': 'en_US:en', 05:49:51 INFO - 'LOGNAME': 'cltbld', 05:49:51 INFO - 'MAIL': '/var/mail/cltbld', 05:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:51 INFO - 'MOZ_NO_REMOTE': '1', 05:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:51 INFO - 'NO_EM_RESTART': '1', 05:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:51 INFO - 'PWD': '/builds/slave/test', 05:49:51 INFO - 'SHELL': '/bin/bash', 05:49:51 INFO - 'SHLVL': '1', 05:49:51 INFO - 'TERM': 'linux', 05:49:51 INFO - 'TMOUT': '86400', 05:49:51 INFO - 'USER': 'cltbld', 05:49:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:51 INFO - '_': '/tools/buildbot/bin/python'} 05:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:51 INFO - Downloading/unpacking jsonschema 05:49:51 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 05:49:51 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 05:49:51 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 05:49:51 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 05:49:51 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 05:49:51 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 05:49:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:53 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:54 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:54 INFO - warning: no files found matching '*.txt' 05:49:54 INFO - no previously-included directories found matching 'build' 05:49:54 INFO - no previously-included directories found matching 'dist' 05:49:54 INFO - no previously-included directories found matching '.git*' 05:49:54 INFO - Installing collected packages: jsonschema, functools32 05:49:54 INFO - Running setup.py install for functools32 05:49:54 INFO - warning: no files found matching '*.txt' 05:49:54 INFO - no previously-included directories found matching 'build' 05:49:54 INFO - no previously-included directories found matching 'dist' 05:49:54 INFO - no previously-included directories found matching '.git*' 05:49:54 INFO - Successfully installed jsonschema functools32 05:49:54 INFO - Cleaning up... 05:49:54 INFO - Return code: 0 05:49:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2dc3df9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, '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': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', '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 05:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:49:54 INFO - Using env: {'DISPLAY': ':0', 05:49:54 INFO - 'HOME': '/home/cltbld', 05:49:54 INFO - 'LANG': 'en_US.UTF-8', 05:49:54 INFO - 'LANGUAGE': 'en_US:en', 05:49:54 INFO - 'LOGNAME': 'cltbld', 05:49:54 INFO - 'MAIL': '/var/mail/cltbld', 05:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:54 INFO - 'MOZ_NO_REMOTE': '1', 05:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:54 INFO - 'NO_EM_RESTART': '1', 05:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:54 INFO - 'PWD': '/builds/slave/test', 05:49:54 INFO - 'SHELL': '/bin/bash', 05:49:54 INFO - 'SHLVL': '1', 05:49:54 INFO - 'TERM': 'linux', 05:49:54 INFO - 'TMOUT': '86400', 05:49:54 INFO - 'USER': 'cltbld', 05:49:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:54 INFO - '_': '/tools/buildbot/bin/python'} 05:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:54 INFO - Downloading/unpacking flake8 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:57 INFO - no previously-included directories found matching 'docs/_build' 05:49:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:57 INFO - Running setup.py install for pep8 05:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:57 INFO - no previously-included directories found matching 'docs/_build' 05:49:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:57 INFO - Cleaning up... 05:49:57 INFO - Return code: 0 05:49:57 INFO - Running post-action listener: _resource_record_post_action 05:49:57 INFO - Running post-action listener: _start_resource_monitoring 05:49:57 INFO - Starting resource monitoring. 05:49:57 INFO - ##### 05:49:57 INFO - ##### Finished create-virtualenv step (success) 05:49:57 INFO - ##### 05:49:57 INFO - ##### 05:49:57 INFO - ##### Running install step. 05:49:57 INFO - ##### 05:49:57 INFO - Running pre-action listener: _resource_record_pre_action 05:49:57 INFO - Running main action method: install 05:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:57 INFO - Reading from file tmpfile_stdout 05:49:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:57 INFO - Reading from file tmpfile_stdout 05:49:57 INFO - Output received: 05:49:57 INFO - Usage: mozinstall [options] installer 05:49:57 INFO - Options: 05:49:57 INFO - -h, --help show this help message and exit 05:49:57 INFO - -d DEST, --destination=DEST 05:49:57 INFO - Directory to install application into. [default: 05:49:57 INFO - "/builds/slave/test"] 05:49:57 INFO - --app=APP Application being installed. [default: firefox] 05:49:57 INFO - mkdir: /builds/slave/test/build/application 05:49:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:50:14 INFO - Reading from file tmpfile_stdout 05:50:14 INFO - Output received: 05:50:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:50:14 INFO - Running post-action listener: _resource_record_post_action 05:50:14 INFO - ##### 05:50:14 INFO - ##### Finished install step (success) 05:50:14 INFO - ##### 05:50:14 INFO - ##### 05:50:14 INFO - ##### Running run-tests step. 05:50:14 INFO - ##### 05:50:14 INFO - Running pre-action listener: _resource_record_pre_action 05:50:14 INFO - Running main action method: run_tests 05:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:14 INFO - Python 2.7.3 05:50:14 INFO - Return code: 0 05:50:14 INFO - grabbing minidump binary from tooltool 05:50:14 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')]} 05:50:14 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 0x15819c0>, '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 0x15828c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1582d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:14 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 05:50:14 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 05:50:14 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 05:50:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:14 INFO - Return code: 0 05:50:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:50:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:50:15 INFO - Return code: 0 05:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:50:15 INFO - Using env: {'DISPLAY': ':0', 05:50:15 INFO - 'HOME': '/home/cltbld', 05:50:15 INFO - 'LANG': 'en_US.UTF-8', 05:50:15 INFO - 'LANGUAGE': 'en_US:en', 05:50:15 INFO - 'LOGNAME': 'cltbld', 05:50:15 INFO - 'MAIL': '/var/mail/cltbld', 05:50:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:15 INFO - 'MOZ_NO_REMOTE': '1', 05:50:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:15 INFO - 'NO_EM_RESTART': '1', 05:50:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:15 INFO - 'PWD': '/builds/slave/test', 05:50:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:15 INFO - 'SHELL': '/bin/bash', 05:50:15 INFO - 'SHLVL': '1', 05:50:15 INFO - 'TERM': 'linux', 05:50:15 INFO - 'TMOUT': '86400', 05:50:15 INFO - 'USER': 'cltbld', 05:50:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300', 05:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:15 INFO - '_': '/tools/buildbot/bin/python'} 05:50:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:50:15 INFO - mozversion application_buildid: 20160520030251 05:50:15 INFO - mozversion application_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 05:50:15 INFO - mozversion application_display_name: Nightly 05:50:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:15 INFO - mozversion application_name: Firefox 05:50:15 INFO - mozversion application_remotingname: firefox 05:50:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:15 INFO - mozversion application_vendor: Mozilla 05:50:15 INFO - mozversion application_version: 49.0a1 05:50:15 INFO - mozversion platform_buildid: 20160520030251 05:50:15 INFO - mozversion platform_changeset: c67dc1f9fab86d4f2cf3224307809c44fe3ce820 05:50:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:15 INFO - mozversion platform_version: 49.0a1 05:50:15 INFO - using testdate: 1463748615 05:50:15 INFO - actual date: 1463748615 05:50:15 INFO - starting webserver on 'localhost:37959' 05:50:15 INFO - SUITE-START | Running 2 tests 05:50:15 INFO - TEST-START | dromaeo_css 05:50:15 INFO - operating with platform_type : linux_ 05:50:15 INFO - Initialising browser for dromaeo_css test... 05:50:15 INFO - TEST-INFO | started process 15784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp66rTY0/profile http://localhost:37959/getInfo.html) 05:50:19 INFO - PROCESS | 15784 | __metrics Screen width/height:1600/1200 05:50:19 INFO - PROCESS | 15784 | colorDepth:24 05:50:19 INFO - PROCESS | 15784 | Browser inner width/height: 1024/697 05:50:19 INFO - PROCESS | 15784 | __metrics 05:50:20 ERROR - PROCESS | 15784 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:50:21 INFO - TEST-INFO | 15784: exit 0 05:50:21 INFO - Browser initialized. 05:50:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:21 INFO - TEST-INFO | started process 15866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp66rTY0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:33 INFO - PROCESS | 15866 | RSS: Main: 152805376 05:50:33 INFO - PROCESS | 15866 | 05:51:24 INFO - PROCESS | 15866 | 1463748684342 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] 05:53:32 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37959/tests/dromaeo/cssquery-ext.html) 05:53:33 INFO - PROCESS | 15866 | RSS: Main: 250396672 05:53:33 INFO - PROCESS | 15866 | 05:56:35 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-ext.html (next: http://localhost:37959/tests/dromaeo/cssquery-jquery.html) 05:56:36 INFO - PROCESS | 15866 | RSS: Main: 238227456 05:56:36 INFO - PROCESS | 15866 | 05:59:38 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37959/tests/dromaeo/cssquery-mootools.html) 05:59:38 INFO - PROCESS | 15866 | RSS: Main: 234323968 05:59:38 INFO - PROCESS | 15866 | 06:02:40 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37959/tests/dromaeo/cssquery-prototype.html) 06:02:41 INFO - PROCESS | 15866 | RSS: Main: 234848256 06:02:41 INFO - PROCESS | 15866 | 06:05:43 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37959/tests/dromaeo/cssquery-yui.html) 06:05:44 INFO - PROCESS | 15866 | RSS: Main: 215502848 06:05:44 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | Cycle 1(1): loaded http://localhost:37959/tests/dromaeo/cssquery-yui.html (next: http://localhost:37959/tests/dromaeo/cssquery-dojo.html) 06:08:47 INFO - PROCESS | 15866 | RSS: Main: 282116096 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | __start_tp_report 06:08:47 INFO - PROCESS | 15866 | _x_x_mozilla_page_load 06:08:47 INFO - PROCESS | 15866 | _x_x_mozilla_page_load_details 06:08:47 INFO - PROCESS | 15866 | |i|pagename|runs| 06:08:47 INFO - PROCESS | 15866 | |0;dojo.html;3072.30873053563;3074.523448865426;3096.071178646406;3114.7508199344056;3136.827474488902;5207.0366982108335;5267.078261304271;5312.6281160318795;5331.8269980604255;5354.170103633934;5346.599005074616;5398.568114550836;5399.838004859851;5409.594280428964;5429.077056900326;4839.78220980055;4850.684705494149;4971.353724015891;4982.975085124569;5035.521625445577;4720.716756994591;4950.306957026001;4955.157623204064;4994.275830004647;5028.421731500887;4767.5709186173235;4841.515848415148;4910.779014944354;4925.975370123162;4987.850364489072;4889.828855990058;4898.828541001083;4909.705417674951;4911;4965.329680493123;4858.878528036792;4886.267059941002;4907.316733691567;4921.360223171001;4970.130227210224;5120.334356533627;5323.680579165224;5425.565954723613;5427.511523962823;5444.700541470217;5815.331236907768;5851.444112809277;5862.677552734598;5863.70681465925;5868.383819698913;5582.86042848928;5846.853828654275;5856.414358564152;5867.11993201019;5914.260717410324;5343.572514198855;5393.487618676219;5396.4333744957;5477.917831232535;5508.807191748349;6011.368806275365;6019.127226552213;6023.66869822164;6024.036154215304;6024.789132380346;5477.315335583052;5648.265725455664;5765.769369225184;5782.624129431658;5788.18965344852;5738.655680659173;5804.796832110856;5841.853953651193;5843.357230704619;5903.321118071477;5797;5802.274715660543;5814.59297849155;5815.185873977646;5820;5557.3331200256225;5682.659040457585;5743.798967036218;5765.4522820332;5789.218455508537;4412.801423935931;4427.446569178853;4429.889252768707;4461.754603496839;4465.285554311295;3929;3949.447077409165;3957.742746721454;3979.582143874851;3990.0024993751563;5092;5324.707141107277;5356.464353564613;5365.08793505105;5515.586331025189;5706;5729.627574207663;5730.19777231188;5774.769009239667;5789.652620842763;5438.91841622376;5442.455754424605;5443.101888188484;5445.074337362658;5448.618596698193;4864.391951006124;4923.433805112386;4959.256111583291;4973.776180071905;4993.675411098267;5981.5214782817275;5982.7307771149535;5982.790602328984;5985.221921150222;5990.700464976734;5801.593888427769;5812.680302583399;5816.796412125725;5819.418058194146;5820.243368362086;5772.134179873053;5921.4966727826895;5998.040313549811;6003.7898673546215;6047.941610218282;5727.255456790591;5760.798372056958;5771.336296325976;5776.046952252831;5778.306603207642;5648.152777083306;5805.767769289181;5842.298924129132;5861.736221869941;5864.384239654945;5545.889082218414;5598.804041858678;5629.718514074198;5654.85862853432;5658.971705141448;5620.185073164286;5621.100623900156;5634.887302254014;5647.689377084135;5652.293463317085;5318.840434786963;5389.056915039931;5482.040642887399;5488.17677348401;5500.58745594074;5651.802186923438;5733.0253856845275;5741.081426971665;5741.282339707536;5749.310082789924;5529.585281104014;5570.136628822539;5573.219749235192;5577.470140336662;5618.550515958632 06:08:47 INFO - PROCESS | 15866 | |1;ext.html;606.9969650151749;634.1850721822453;644.8065580325903;646.005152065819;653.682963762575;32418.99999999997;35805.820970895176;35911.46132808003;35918.46122308161;35981.820090899506;44557.77721111398;45075.32387014189;45116.3232551512;49368.75315623417;49543;8725;8908.599113039896;8910.287177025855;8910.376273660846;8910.55447227636;8658;8777.692780752675;8800;8801.383903126783;8802.207801297882;8793.076726943642;8846;8854.822903541924;8864.645414183426;8874.245689116433;8759.737207883774;8794.912050879506;8822.382433229677;8825;8829.69096081634;8679.349048821301;8703.695370662059;8748.737537873874;8771.342149338825;8779.29765618749;41798;42219.57780422218;42280.57719422797;42325.57674423278;42342.57657423417;3517.8065206413635;3603.927921441583;3656.579493358271;3785.9432108518117;3946.4776392816093;31973;32489.350212995843;32696.346073078643;32829.83585082059;33107.172320691934;4159.9376009359885;4177.914899087299;4184.814421636422;4206.495220573551;4265.424167737347;330812;331117;331123;331474;333107;51828;52786.47213527892;52811.20783188255;52861.2070818938;52905.73547132317;61206.38793612096;61269;61530;61538;61608.38391616027;13939.581812545639;14039.929800350932;14097.506587269396;14102.647433814032;14105.365258563184;10732.356058636507;10742.355458672504;10750.301230419998;10762.40806755636;10764.677059688222;14054.789178162337;16097.195140243175;16270.674586508203;16327.91836040836;16407.1796410179;5075.289459475676;5928.436798504135;5981.431763982415;6004.849878753066;6082.665453400017;990.4453506036642;1018.6689325969089;1057.957681692739;1077.0091515805477;1117.8993890549727;32171.51742723861;32247.51628725571;32266.193345166557;32377;32535.837320813243;1076.4990896518782;1127.2785417332914;1152.475623591264;1156.70504021474;1161.6224726963771;16699.833001669827;16927.49217523476;17005.149742512825;17010.489685309214;17020.829791701923;430108;433171;434173;435540;437622;56472.15291770627;57446.7127664359;57536;57582.42417575854;57648;1277.0932637827061;1347.905646604748;1377.4696741754296;1386.3207028555935;1401.32736286583;31297.843510783212;33025;33190.17024574308;33481.66518334785;34025.65974340324;48861.51138488569;49288.260676090606;49299;49411.258831118284;49538.50461495339;360198;369794;370386;370677;373102;27536.44927101487;35421.291574168885;40080.3987940187;43533.3469997944;45712.771436142604;45868.77065614651;49527;50072.24891626702;50177;51310.74344628253;40443.595564043986;41211.587884121975;41760.79119604383;42137.789311053246;42915.785421072695;40467.190656186125;40804.59195408008;40986.18027639371;41718;42105;40611.796941015105;41189.382159268236;41212.58787412207;41511.7924410376;41992.79003604963;35808.641913581574;36669;36951.63048369482;37008.814955925045;37662;27737;28353.71646283593;28438;28479.715202848536;28607.141785746462 06:08:47 INFO - PROCESS | 15866 | |2;jquery.html;397.0431260661802;408.23252285702875;409.69682434998094;409.9856505022324;421.95780421957807;13435.529756458525;18065.187066582002;18956.5260868478;19810.801891981075;19817.50456238593;14547.345369458373;16798.916005419986;17998.010109443974;18083.457496275132;18863.717044244313;5706.828795136143;5877.735501902424;5911.674857882815;5916.08300713388;5930.822075337746;5845.620034697752;5851.912221316684;5889.85275368115;5894.292684877799;5902.114682797594;4221.24017676818;6191.659458729768;6486.383793539606;6492.805215843532;6606.636634985074;6534.54258201926;6579.374959378852;6588.736450541996;6599.835004124887;6602.504812139085;5658.151277308437;5765.106408506688;5779.046457334534;5780.71096445176;5796.188533605298;22006.669899951514;22175.66736498954;22507.437314067116;22562.43593910149;22577.88711056434;2313.4447732544068;2405.494846082325;2559.9616005759926;2588.1329754532253;2980.344324248662;13550.390232439564;14268.928655356656;14316.928415357857;14445.349959251858;14838.629034274121;1894.2801735340483;1902.6004539046817;1914.7606549181353;1945.4147710001605;1978.3174804692358;77824.61087694582;78304.60847695782;81340.59329703313;82052;82837.17162828356;10059.44673042975;10180.52382404562;10298.279120461646;10333.586656533655;10448.373097614167;13888.513902013381;14074.648133796736;14109.153450792985;14165.645858853612;14175.731882898686;7201.555488489645;7343.1188257408385;7344.7881099619035;7384.889226661604;7414.14737305206;6955.652217389212;6964.512484126164;7032.648367581601;7046;7104.751333703295;5921.703914804242;6359.682015899187;6547.279799222082;6637.767678131242;6817;1866.2255164107014;1875.7280194372013;1907.3896353166854;1971.3691618681885;1976.1403789351677;950.8858936927475;1073.8746585375504;1091.6431971687093;1106.1427393769732;1125.2685754259796;19254.133563989653;19477.707834382494;20534.69197962032;20548.897255513628;20725.68911466329;997.6209040564539;1001.5503722379229;1039.2777019971047;1044.2324891204958;1111.8499002634703;10897.83653245202;11359.318440893407;11507.424628768527;11551.191416600925;11561.248518846416;461516;463110;483263;487068;488810;76780.61609692028;90510;92112.53943730239;93562.53218733863;95184.52407737917;1036.7252678040325;1049.9107575855985;1068.0707784227773;1098.9175811814146;1111.6164923101517;17572.82427175763;17684.823151768833;17955;17981.820181798015;18288.90855545714;39342.803285983384;39773.20453590854;40323;41230.793846031775;41909.371359429024;55600;57766.7111664439;58150.709246453494;58238.12642810446;59273.70363148156;7761.107472640719;8649.61076751535;8760.38677292609;8908.376413650982;9187.03536128697;7418.703251870081;9686.806263874823;10990.791012988724;12645.747085058063;13087.345632718516;11622.88377116218;11886.821697674715;11997.340146292037;12229.816552751894;12241.877581224073;11719.649164583032;11732.824007639721;11787.469563869476;11998.520059197534;12267.631971040882;8007.719729809429;12222.633321000385;12235.388230588613;12272.754544908874;12418.254904705747;7770.650320735694;8492.363072769691;8711.695090671796;8954.776130596787;8991.55042247898;10388.37669739818;11808.586699465477;11898.286102833858;11943.76112477763;12048.879511205127 06:08:47 INFO - PROCESS | 15866 | |3;mootools.html;1385;1503.744363458212;1537.8692811111057;1646.3661490326222;1831.2857985385701;8539.573021348939;8848.646054157834;8870.955645221773;9143.497107659075;9166.495842728664;8728.694495692653;8888.333374996868;8907.376483646147;8915.95542022289;8917.598708058136;2344.9531009379803;2365.325882123595;2370.8814559272055;2373.347329484397;2374.192774456684;2292.7363353214346;2302.815774738017;2318.281332786833;2327.848689835164;2332.078828862598;2340.5201933603657;2353.5528249632603;2364.527094581082;2381.95236095278;2381.9761802381927;2316.7683231676865;2328.382978510696;2341.1220792202926;2353.3881190890406;2354;2336.5794157051723;2338.7193536775526;2340.2394221877958;2341.4965782356876;2343.5664402085667;8657.480551166951;8978.236849867704;8987.775305617346;9030;9037.141471560191;5264.499872512143;5409.26974858393;5500.917486237709;5513.641613295123;5518.972405137949;3165.6517783043846;3247.8213698246586;3293.8965446575426;3536.45184996326;3542.946855797165;1006.5219020965056;1030.8969103089705;1030.9432981186033;1037.4916291017423;1038.175508180466;12038.638840834788;12391.318477483735;12404.62786116409;12450.564230251897;12452.377381130998;4794.9280760788615;4801.005736459423;4838.225883858566;4844.297576851407;4866.95133048665;10564.947175264075;10577.894221057692;10589.417582032907;10597.682069537927;10611.41637209961;5453.7818487260065;5467.289252397242;5467.808626698046;5469.316335458067;5470.890582188414;4236.322188449833;4461.732296062247;4631.861044168681;4666.020135771458;4784.64115191362;4056.7565946043333;4093.7339072960162;4145.336746120606;4159.563245859202;4227.323628219531;1275.8277632519678;1277.5720133755297;1281.7885048967003;1289.4004288006122;1307.7776777947772;730.6273800361747;905.9229965452879;916.3768637326549;934.345957829522;958.7219706285239;5645.463680950304;5648.49163575272;5766.971165144231;5780.046292361797;5871.500922421642;966.1884017425256;975.770693886936;982.1798798003604;999.480270259461;1012.1801340913884;3627.8548858045383;3876.689864810865;3879.165979314461;3896.8441262349756;3949.348357520977;10844.295120817122;10939.398333091756;11058.557657693602;11135.777284454427;11253.043491303331;10879.945600271947;10950.671479855617;10989.835152472719;11026.062784663394;11057.50241239146;8092.71675491355;8558.315334773204;8569.442986206;8588.656453741905;8591.957040214758;5629.915551266816;5702.116171993348;5768.653880767168;5784.248047753765;5863.120531920246;10318.638847640297;10452.68641940743;10461.110805581611;10491.580336786443;10494.160467162761;9989.550470228713;10142.949285253526;10621.575136994434;10631.043206111488;10662.573497060032;6915.377616014583;7693.346065584488;7781.572013539309;7953.483023603448;8201.26188643025;8677.826443471222;8745.212930836255;8805.647774088964;8828.64685412602;8832.425892316978;7690.769276921701;7703.768886933401;7718.189590092959;7806.0632724073475;8103.716369927024;7507.587082710504;7776.300132987832;7787.415943804124;7793.727219547289;7965.681372745025;6567;6570.441512471302;6617.702203400955;6620;6626.867462650816;4760.238361862085;4812.783424745965;4837;4923.286123512143;4989.301497790239;4787.40157480315;4914.606831453547;4919.139150648693;4934.136526107988;5057.949420505748 06:08:47 INFO - PROCESS | 15866 | |4;prototype.html;330.07743357316303;333.6863348452454;335.8069110261599;341.4127700355388;342.5854715793889;5328.333958255218;5356.91964620531;5375.973120134394;5377.784888604461;5377.865553361168;5229.398619158798;5279.1817268323375;5296.126139187029;5309.389420216677;5315.973420132904;3910.569837317893;3996.920061598766;4151.83392664293;4165.271077561415;4185.497740271172;4105.794710264489;4107.322291821861;4124.42258083867;4135.855245066423;4183.288840897039;3945.171513982067;4101.569335219804;4101.666958238585;4106.548279689232;4118.464599602047;4017.4777278953693;4126.596957034622;4131.669466442678;4137.565555616647;4138.317177665682;3655.323765103438;3657.3965295726175;3668.981655091734;3673.8897833065053;3708.3868517195106;5112.897742045138;5116.258142569307;5139.357580302462;5141.511556402136;5148.768305426227;4425.977870110629;4647.372604698357;4654.045300973599;4655.906881862377;4664.463586687541;5478.260434841285;5483.835484935458;5494.36814766303;5500.614956953015;5516.558675305966;3854.9784307158625;3865.4201869719486;3888.4556162137324;3892.649661530476;3903.746256493319;5518.806841760559;5629.662220266797;5683.744231509592;5700.173474846166;5709.857253568653;3982.4225487304757;3991.5808840071954;4014.8594799181888;4038.273110840077;4060.147369052532;4012.25773231953;4055.47278853753;4097.836086556564;4103.938440923389;4126.793660316972;4575.656825738083;4614.423197100363;4641.814327426932;4672.813087476531;4674.929876051862;5359.249705041298;5422.532747599833;5448.346198456211;5456.154296084113;5464.3442786865835;1376.593904798087;1392.7395706885084;1403.7894315852704;1406.2406300597768;1414.929253537319;904.5748498205833;912.0241341764248;920.5673333533363;920.6685593186447;961.2838435365697;5315.627906046617;5336.46635336471;5355.108241549519;5363.865903352447;5375;5599.320203938883;5601.719914004365;5610.49505544503;5624.831255062355;5625.38120806711;5044.924326135111;5311.362636483646;5324.866878327995;5347.41178470368;5364;2983.4331477019296;2988.581598576201;2998.8500574971163;3004.9549256761165;3019.2602812311125;5733.569982251264;5750.482456578844;5754.424557544296;5757.827265182052;5815.302163740378;5515.310586176728;5701.2018317435595;5791.276090488689;5805.506531944748;5848.3274423441;5924.348321684612;5957.851053723692;5965.4631083203585;5972.343042265347;6002.159697642246;5501.669899806025;5718;5730.627509212055;5739.5695322850115;5788.594798364074;5667.3482549507335;5685.971570142123;5692.48767610917;5701.4298570142655;5709.600327977002;5875.588708790344;5933.910991335047;5940.97029514867;5946.494547963472;5961.225040744675;3806.371948628556;4031.4759081320412;4074.2055299216368;4083.285425050664;4093.549709532009;5669.489745922887;5680.2047713321;5711.600187986801;5720.771169153188;5730.312362516524;5305.389880163831;5472.562195024469;5510;5521.309836270466;5558.583106266965;5520.36515800672;5521.889562208814;5525.917111243254;5527.585431092764;5565.805196818092;5121.743912804271;5291.894162116813;5332.30680011596;5436.782528698966;5451.264079349237;5525.198846167364;5553.72264379187;5558.833235002957;5564.4713752193475;5588.552915766811;5354.678719276856;5363.946360536344;5392.622516423813;5397.433269506802;5422.9186562202385 06:08:47 INFO - PROCESS | 15866 | |5;yui.html;808.5472135604062;854.7606670132365;855.3542075732821;857.2841677199538;884.5311984648139;16085.678286434279;16617.169141542934;16622.418215362464;16639.334426622936;16648.50054498364;15661.530154095366;15683.529494115195;15732;15747.133907635076;15748.76376854348;816.8652172391548;822.2312138150818;823.9794005149889;824;824.0482243009304;678.9287124851894;773.7214602743036;774.8992630957996;775.8099265679888;802.4062193976445;840.6763396092518;842.3892677808601;842.7724514381114;843.8101427178897;845.6279237135641;699.4963626189136;836.38107800228;837.0959363886988;837.4138103327695;838.053000109878;592.4016743089468;592.9110633405023;597.9491743201833;613.6410200032941;613.8373331067271;13586.86413135866;13620.523281685093;13636.181829090287;13650.044496885223;13710.24593647349;11762.647120586396;12283.57007504733;12343.938280308541;12359.62921112368;12653.746925061447;11683.415829208505;11829.94085029578;11842.348670823101;11870.881291187065;12138.15032947694;4350.782460876943;4354.673399495019;4453.844115455976;4464.441944756905;4561.7491037992895;57135;57646.84706305892;58054.129188062216;58083.709581451825;58164.70917645427;10870.510827012804;10896.455177241107;10933.726656833644;11179.776404471864;11211.38337391435;19351.612967740566;19365.225390984484;19384.612307753767;19447.513812154808;19507.12217950167;7737.640510749808;8073.273405393543;8078.838423231502;8208.753737387888;8263.752087437386;4433.490148632884;4613.792379342937;4637.281221410619;4756.762161891892;4827.348307978378;3386.4243078676686;3456.809875456874;3479.234568394949;3600.4959305697225;3601.405768048243;700.5983864405491;705.2101646156235;709.4643544124153;711.8647456983157;715.5349023135004;719.435139508073;723.3815088099705;726.8412813942582;759.3886921028515;760.5626764610371;8770.91229087701;9215.354925155174;9221.723348299562;9321.207697345666;9379.390339627902;652.083822229768;661.6956200147889;679.4394624434763;679.8062552172607;687.9140107486564;4523.5024147343765;4602.976985115053;4626.976865115653;4674.410978506048;4699.436067671902;72802;72918.27081729221;73566;73861.63069184727;74179.62910185415;52022.21966670503;62069.68965155145;62934;62999.37000630027;63617.681911590145;48585.27122093172;54780;55212.17181742277;55744;55885.72057139688;8517.74446766598;8550.204457064086;8664.436811607226;8674.609642565974;8701.40200855141;37114.07214819543;37341;37501;37917;38559.80720096381;44813.77593112014;47715.76142119267;48153.5184648149;48488.22572379549;49118.75440622774;12137.514499419924;12205.389730513261;12337.444814983168;12685.873141268468;13057.21656700601;13328.800067998794;13339.66650833737;13909.234992075533;14102.929485352917;14206.715865682421;11384;11483.540658373571;11574.18980671345;11654;11985.64043078709;11606.129540284344;12227.510899563918;12304.323262220663;12316.876831231932;12446.980180954419;11458.369789661649;11620.302781833117;12003.459844307201;12230.633081007583;12259.141860070065;9960;10081.395116292753;10144.137748291478;11092.778144436905;11107.166962478008;9297.6280948764;9342.906570934203;9609.855852162364;10150.289479736643;10315.948420257851 06:08:47 INFO - PROCESS | 15866 | __end_tp_report 06:08:47 INFO - PROCESS | 15866 | __start_cc_report 06:08:47 INFO - PROCESS | 15866 | _x_x_mozilla_cycle_collect,853 06:08:47 INFO - PROCESS | 15866 | __end_cc_report 06:08:47 INFO - PROCESS | 15866 | __startTimestamp1463749727527__endTimestamp 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | ------- Summary: start ------- 06:08:47 INFO - PROCESS | 15866 | Number of tests: 6 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#0] dojo.html Cycles:165 Average:5364.42 Median:5545.89 stddev:618.46 (11.2%) stddev-sans-first:593.64 06:08:47 INFO - PROCESS | 15866 | Values: 3072.3 3074.5 3096.1 3114.8 3136.8 5207.0 5267.1 5312.6 5331.8 5354.2 5346.6 5398.6 5399.8 5409.6 5429.1 4839.8 4850.7 4971.4 4983.0 5035.5 4720.7 4950.3 4955.2 4994.3 5028.4 4767.6 4841.5 4910.8 4926.0 4987.9 4889.8 4898.8 4909.7 4911.0 4965.3 4858.9 4886.3 4907.3 4921.4 4970.1 5120.3 5323.7 5425.6 5427.5 5444.7 5815.3 5851.4 5862.7 5863.7 5868.4 5582.9 5846.9 5856.4 5867.1 5914.3 5343.6 5393.5 5396.4 5477.9 5508.8 6011.4 6019.1 6023.7 6024.0 6024.8 5477.3 5648.3 5765.8 5782.6 5788.2 5738.7 5804.8 5841.9 5843.4 5903.3 5797.0 5802.3 5814.6 5815.2 5820.0 5557.3 5682.7 5743.8 5765.5 5789.2 4412.8 4427.4 4429.9 4461.8 4465.3 3929.0 3949.4 3957.7 3979.6 3990.0 5092.0 5324.7 5356.5 5365.1 5515.6 5706.0 5729.6 5730.2 5774.8 5789.7 5438.9 5442.5 5443.1 5445.1 5448.6 4864.4 4923.4 4959.3 4973.8 4993.7 5981.5 5982.7 5982.8 5985.2 5990.7 5801.6 5812.7 5816.8 5819.4 5820.2 5772.1 5921.5 5998.0 6003.8 6047.9 5727.3 5760.8 5771.3 5776.0 5778.3 5648.2 5805.8 5842.3 5861.7 5864.4 5545.9 5598.8 5629.7 5654.9 5659.0 5620.2 5621.1 5634.9 5647.7 5652.3 5318.8 5389.1 5482.0 5488.2 5500.6 5651.8 5733.0 5741.1 5741.3 5749.3 5529.6 5570.1 5573.2 5577.5 5618.6 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#1] ext.html Cycles:180 Average:54831.86 Median:22835.87 stddev:100201.87 (438.8%) stddev-sans-first:100400.25 06:08:47 INFO - PROCESS | 15866 | Values: 607.0 634.2 644.8 646.0 653.7 32419.0 35805.8 35911.5 35918.5 35981.8 44557.8 45075.3 45116.3 49368.8 49543.0 8725.0 8908.6 8910.3 8910.4 8910.6 8658.0 8777.7 8800.0 8801.4 8802.2 8793.1 8846.0 8854.8 8864.6 8874.2 8759.7 8794.9 8822.4 8825.0 8829.7 8679.3 8703.7 8748.7 8771.3 8779.3 41798.0 42219.6 42280.6 42325.6 42342.6 3517.8 3603.9 3656.6 3785.9 3946.5 31973.0 32489.4 32696.3 32829.8 33107.2 4159.9 4177.9 4184.8 4206.5 4265.4 330812.0 331117.0 331123.0 331474.0 333107.0 51828.0 52786.5 52811.2 52861.2 52905.7 61206.4 61269.0 61530.0 61538.0 61608.4 13939.6 14039.9 14097.5 14102.6 14105.4 10732.4 10742.4 10750.3 10762.4 10764.7 14054.8 16097.2 16270.7 16327.9 16407.2 5075.3 5928.4 5981.4 6004.8 6082.7 990.4 1018.7 1058.0 1077.0 1117.9 32171.5 32247.5 32266.2 32377.0 32535.8 1076.5 1127.3 1152.5 1156.7 1161.6 16699.8 16927.5 17005.1 17010.5 17020.8 430108.0 433171.0 434173.0 435540.0 437622.0 56472.2 57446.7 57536.0 57582.4 57648.0 1277.1 1347.9 1377.5 1386.3 1401.3 31297.8 33025.0 33190.2 33481.7 34025.7 48861.5 49288.3 49299.0 49411.3 49538.5 360198.0 369794.0 370386.0 370677.0 373102.0 27536.4 35421.3 40080.4 43533.3 45712.8 45868.8 49527.0 50072.2 50177.0 51310.7 40443.6 41211.6 41760.8 42137.8 42915.8 40467.2 40804.6 40986.2 41718.0 42105.0 40611.8 41189.4 41212.6 41511.8 41992.8 35808.6 36669.0 36951.6 37008.8 37662.0 27737.0 28353.7 28438.0 28479.7 28607.1 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#2] jquery.html Cycles:180 Average:28518.96 Median:2359.47 stddev:78633.67 (3332.7%) stddev-sans-first:78825.90 06:08:47 INFO - PROCESS | 15866 | Values: 397.0 408.2 409.7 410.0 422.0 13435.5 18065.2 18956.5 19810.8 19817.5 14547.3 16798.9 17998.0 18083.5 18863.7 5706.8 5877.7 5911.7 5916.1 5930.8 5845.6 5851.9 5889.9 5894.3 5902.1 4221.2 6191.7 6486.4 6492.8 6606.6 6534.5 6579.4 6588.7 6599.8 6602.5 5658.2 5765.1 5779.0 5780.7 5796.2 22006.7 22175.7 22507.4 22562.4 22577.9 2313.4 2405.5 2560.0 2588.1 2980.3 13550.4 14268.9 14316.9 14445.3 14838.6 1894.3 1902.6 1914.8 1945.4 1978.3 77824.6 78304.6 81340.6 82052.0 82837.2 10059.4 10180.5 10298.3 10333.6 10448.4 13888.5 14074.6 14109.2 14165.6 14175.7 7201.6 7343.1 7344.8 7384.9 7414.1 6955.7 6964.5 7032.6 7046.0 7104.8 5921.7 6359.7 6547.3 6637.8 6817.0 1866.2 1875.7 1907.4 1971.4 1976.1 950.9 1073.9 1091.6 1106.1 1125.3 19254.1 19477.7 20534.7 20548.9 20725.7 997.6 1001.6 1039.3 1044.2 1111.8 10897.8 11359.3 11507.4 11551.2 11561.2 461516.0 463110.0 483263.0 487068.0 488810.0 76780.6 90510.0 92112.5 93562.5 95184.5 1036.7 1049.9 1068.1 1098.9 1111.6 17572.8 17684.8 17955.0 17981.8 18288.9 39342.8 39773.2 40323.0 41230.8 41909.4 55600.0 57766.7 58150.7 58238.1 59273.7 7761.1 8649.6 8760.4 8908.4 9187.0 7418.7 9686.8 10990.8 12645.7 13087.3 11622.9 11886.8 11997.3 12229.8 12241.9 11719.6 11732.8 11787.5 11998.5 12267.6 8007.7 12222.6 12235.4 12272.8 12418.3 7770.7 8492.4 8711.7 8954.8 8991.6 10388.4 11808.6 11898.3 11943.8 12048.9 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#3] mootools.html Cycles:180 Average:5835.71 Median:4786.02 stddev:3365.95 (70.3%) stddev-sans-first:3358.78 06:08:47 INFO - PROCESS | 15866 | Values: 1385.0 1503.7 1537.9 1646.4 1831.3 8539.6 8848.6 8871.0 9143.5 9166.5 8728.7 8888.3 8907.4 8916.0 8917.6 2345.0 2365.3 2370.9 2373.3 2374.2 2292.7 2302.8 2318.3 2327.8 2332.1 2340.5 2353.6 2364.5 2382.0 2382.0 2316.8 2328.4 2341.1 2353.4 2354.0 2336.6 2338.7 2340.2 2341.5 2343.6 8657.5 8978.2 8987.8 9030.0 9037.1 5264.5 5409.3 5500.9 5513.6 5519.0 3165.7 3247.8 3293.9 3536.5 3542.9 1006.5 1030.9 1030.9 1037.5 1038.2 12038.6 12391.3 12404.6 12450.6 12452.4 4794.9 4801.0 4838.2 4844.3 4867.0 10564.9 10577.9 10589.4 10597.7 10611.4 5453.8 5467.3 5467.8 5469.3 5470.9 4236.3 4461.7 4631.9 4666.0 4784.6 4056.8 4093.7 4145.3 4159.6 4227.3 1275.8 1277.6 1281.8 1289.4 1307.8 730.6 905.9 916.4 934.3 958.7 5645.5 5648.5 5767.0 5780.0 5871.5 966.2 975.8 982.2 999.5 1012.2 3627.9 3876.7 3879.2 3896.8 3949.3 10844.3 10939.4 11058.6 11135.8 11253.0 10879.9 10950.7 10989.8 11026.1 11057.5 8092.7 8558.3 8569.4 8588.7 8592.0 5629.9 5702.1 5768.7 5784.2 5863.1 10318.6 10452.7 10461.1 10491.6 10494.2 9989.6 10142.9 10621.6 10631.0 10662.6 6915.4 7693.3 7781.6 7953.5 8201.3 8677.8 8745.2 8805.6 8828.6 8832.4 7690.8 7703.8 7718.2 7806.1 8103.7 7507.6 7776.3 7787.4 7793.7 7965.7 6567.0 6570.4 6617.7 6620.0 6626.9 4760.2 4812.8 4837.0 4923.3 4989.3 4787.4 4914.6 4919.1 4934.1 5057.9 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#4] prototype.html Cycles:180 Average:4647.85 Median:5351.05 stddev:1372.21 (25.6%) stddev-sans-first:1337.24 06:08:47 INFO - PROCESS | 15866 | Values: 330.1 333.7 335.8 341.4 342.6 5328.3 5356.9 5376.0 5377.8 5377.9 5229.4 5279.2 5296.1 5309.4 5316.0 3910.6 3996.9 4151.8 4165.3 4185.5 4105.8 4107.3 4124.4 4135.9 4183.3 3945.2 4101.6 4101.7 4106.5 4118.5 4017.5 4126.6 4131.7 4137.6 4138.3 3655.3 3657.4 3669.0 3673.9 3708.4 5112.9 5116.3 5139.4 5141.5 5148.8 4426.0 4647.4 4654.0 4655.9 4664.5 5478.3 5483.8 5494.4 5500.6 5516.6 3855.0 3865.4 3888.5 3892.6 3903.7 5518.8 5629.7 5683.7 5700.2 5709.9 3982.4 3991.6 4014.9 4038.3 4060.1 4012.3 4055.5 4097.8 4103.9 4126.8 4575.7 4614.4 4641.8 4672.8 4674.9 5359.2 5422.5 5448.3 5456.2 5464.3 1376.6 1392.7 1403.8 1406.2 1414.9 904.6 912.0 920.6 920.7 961.3 5315.6 5336.5 5355.1 5363.9 5375.0 5599.3 5601.7 5610.5 5624.8 5625.4 5044.9 5311.4 5324.9 5347.4 5364.0 2983.4 2988.6 2998.9 3005.0 3019.3 5733.6 5750.5 5754.4 5757.8 5815.3 5515.3 5701.2 5791.3 5805.5 5848.3 5924.3 5957.9 5965.5 5972.3 6002.2 5501.7 5718.0 5730.6 5739.6 5788.6 5667.3 5686.0 5692.5 5701.4 5709.6 5875.6 5933.9 5941.0 5946.5 5961.2 3806.4 4031.5 4074.2 4083.3 4093.5 5669.5 5680.2 5711.6 5720.8 5730.3 5305.4 5472.6 5510.0 5521.3 5558.6 5520.4 5521.9 5525.9 5527.6 5565.8 5121.7 5291.9 5332.3 5436.8 5451.3 5525.2 5553.7 5558.8 5564.5 5588.6 5354.7 5363.9 5392.6 5397.4 5422.9 06:08:47 INFO - PROCESS | 15866 | 06:08:47 INFO - PROCESS | 15866 | [#5] yui.html Cycles:180 Average:15665.50 Median:26236.26 stddev:19064.66 (72.7%) stddev-sans-first:19085.50 06:08:47 INFO - PROCESS | 15866 | Values: 808.5 854.8 855.4 857.3 884.5 16085.7 16617.2 16622.4 16639.3 16648.5 15661.5 15683.5 15732.0 15747.1 15748.8 816.9 822.2 824.0 824.0 824.0 678.9 773.7 774.9 775.8 802.4 840.7 842.4 842.8 843.8 845.6 699.5 836.4 837.1 837.4 838.1 592.4 592.9 597.9 613.6 613.8 13586.9 13620.5 13636.2 13650.0 13710.2 11762.6 12283.6 12343.9 12359.6 12653.7 11683.4 11829.9 11842.3 11870.9 12138.2 4350.8 4354.7 4453.8 4464.4 4561.7 57135.0 57646.8 58054.1 58083.7 58164.7 10870.5 10896.5 10933.7 11179.8 11211.4 19351.6 19365.2 19384.6 19447.5 19507.1 7737.6 8073.3 8078.8 8208.8 8263.8 4433.5 4613.8 4637.3 4756.8 4827.3 3386.4 3456.8 3479.2 3600.5 3601.4 700.6 705.2 709.5 711.9 715.5 719.4 723.4 726.8 759.4 760.6 8770.9 9215.4 9221.7 9321.2 9379.4 652.1 661.7 679.4 679.8 687.9 4523.5 4603.0 4627.0 4674.4 4699.4 72802.0 72918.3 73566.0 73861.6 74179.6 52022.2 62069.7 62934.0 62999.4 63617.7 48585.3 54780.0 55212.2 55744.0 55885.7 8517.7 8550.2 8664.4 8674.6 8701.4 37114.1 37341.0 37501.0 37917.0 38559.8 44813.8 47715.8 48153.5 48488.2 49118.8 12137.5 12205.4 12337.4 12685.9 13057.2 13328.8 13339.7 13909.2 14102.9 14206.7 11384.0 11483.5 11574.2 11654.0 11985.6 11606.1 12227.5 12304.3 12316.9 12447.0 11458.4 11620.3 12003.5 12230.6 12259.1 9960.0 10081.4 10144.1 11092.8 11107.2 9297.6 9342.9 9609.9 10150.3 10315.9 06:08:47 INFO - PROCESS | 15866 | -------- Summary: end -------- 06:08:47 INFO - PROCESS | 15866 | 06:08:48 INFO - TEST-INFO | 15866: exit 0 06:08:48 INFO - TEST-OK | dromaeo_css | took 1112680ms 06:08:48 INFO - TEST-START | kraken 06:08:48 INFO - operating with platform_type : linux_ 06:08:48 INFO - Initialising browser for kraken test... 06:08:48 INFO - TEST-INFO | started process 16049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJABbo/profile http://localhost:37959/getInfo.html) 06:08:52 INFO - PROCESS | 16049 | __metrics Screen width/height:1600/1200 06:08:52 INFO - PROCESS | 16049 | colorDepth:24 06:08:52 INFO - PROCESS | 16049 | Browser inner width/height: 1024/697 06:08:52 INFO - PROCESS | 16049 | __metrics 06:08:53 ERROR - PROCESS | 16049 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:08:54 INFO - TEST-INFO | 16049: exit 0 06:08:54 INFO - Browser initialized. 06:08:54 INFO - Running cycle 1/1 for kraken test... 06:08:54 INFO - TEST-INFO | started process 16133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJABbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:05 INFO - PROCESS | 16133 | RSS: Main: 152989696 06:09:05 INFO - PROCESS | 16133 | 06:09:08 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:09 INFO - PROCESS | 16133 | RSS: Main: 209068032 06:09:09 INFO - PROCESS | 16133 | 06:09:12 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-dft) 06:09:12 INFO - PROCESS | 16133 | RSS: Main: 197656576 06:09:12 INFO - PROCESS | 16133 | 06:09:16 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-fft) 06:09:16 INFO - PROCESS | 16133 | RSS: Main: 266076160 06:09:16 INFO - PROCESS | 16133 | 06:09:18 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37959/tests/kraken/driver.html?testName=audio-oscillator) 06:09:19 INFO - PROCESS | 16133 | RSS: Main: 174727168 06:09:19 INFO - PROCESS | 16133 | 06:09:21 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:22 INFO - PROCESS | 16133 | RSS: Main: 179417088 06:09:22 INFO - PROCESS | 16133 | 06:09:25 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:26 INFO - PROCESS | 16133 | RSS: Main: 214642688 06:09:26 INFO - PROCESS | 16133 | 06:09:29 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37959/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:30 INFO - PROCESS | 16133 | RSS: Main: 212996096 06:09:30 INFO - PROCESS | 16133 | 06:09:33 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37959/tests/kraken/driver.html?testName=json-parse-financial) 06:09:33 INFO - PROCESS | 16133 | RSS: Main: 214007808 06:09:33 INFO - PROCESS | 16133 | 06:09:35 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:36 INFO - PROCESS | 16133 | RSS: Main: 203096064 06:09:36 INFO - PROCESS | 16133 | 06:09:37 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:38 INFO - PROCESS | 16133 | RSS: Main: 206389248 06:09:38 INFO - PROCESS | 16133 | 06:09:40 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:41 INFO - PROCESS | 16133 | RSS: Main: 217153536 06:09:41 INFO - PROCESS | 16133 | 06:09:43 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:44 INFO - PROCESS | 16133 | RSS: Main: 224124928 06:09:44 INFO - PROCESS | 16133 | 06:09:47 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:47 INFO - PROCESS | 16133 | RSS: Main: 221032448 06:09:47 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:37959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37959/tests/kraken/driver.html?testName=ai-astar) 06:09:49 INFO - PROCESS | 16133 | RSS: Main: 267567104 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | __start_tp_report 06:09:49 INFO - PROCESS | 16133 | _x_x_mozilla_page_load 06:09:49 INFO - PROCESS | 16133 | _x_x_mozilla_page_load_details 06:09:49 INFO - PROCESS | 16133 | |i|pagename|runs| 06:09:49 INFO - PROCESS | 16133 | |0;ai-astar;111;106;112;113;109;111;110;113;110;112 06:09:49 INFO - PROCESS | 16133 | |1;audio-beat-detection;168;125;156;218;127;150;156;126;186;124 06:09:49 INFO - PROCESS | 16133 | |2;audio-dft;162;161;160;161;161;162;163;161;160;161 06:09:49 INFO - PROCESS | 16133 | |3;audio-fft;74;75;75;147;75;74;77;76;130;75 06:09:49 INFO - PROCESS | 16133 | |4;audio-oscillator;92;92;149;92;96;93;123;92;94;120 06:09:49 INFO - PROCESS | 16133 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 06:09:49 INFO - PROCESS | 16133 | |6;imaging-darkroom;146;146;146;147;146;146;146;147;146;146 06:09:49 INFO - PROCESS | 16133 | |7;imaging-desaturate;95;94;95;95;94;95;95;94;95;94 06:09:49 INFO - PROCESS | 16133 | |8;json-parse-financial;53;60;54;53;53;53;53;105;51;52 06:09:49 INFO - PROCESS | 16133 | |9;json-stringify-tinderbox;66;65;65;66;66;65;66;65;66;66 06:09:49 INFO - PROCESS | 16133 | |10;stanford-crypto-aes;79;78;79;78;80;80;81;79;82;80 06:09:49 INFO - PROCESS | 16133 | |11;stanford-crypto-ccm;120;120;136;117;117;117;116;119;190;131 06:09:49 INFO - PROCESS | 16133 | |12;stanford-crypto-pbkdf2;173;160;166;159;158;159;164;159;160;159 06:09:49 INFO - PROCESS | 16133 | |13;stanford-crypto-sha256-iterative;62;62;63;62;67;61;61;61;62;64 06:09:49 INFO - PROCESS | 16133 | __end_tp_report 06:09:49 INFO - PROCESS | 16133 | __start_cc_report 06:09:49 INFO - PROCESS | 16133 | _x_x_mozilla_cycle_collect,1868 06:09:49 INFO - PROCESS | 16133 | __end_cc_report 06:09:49 INFO - PROCESS | 16133 | __startTimestamp1463749789912__endTimestamp 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | ------- Summary: start ------- 06:09:49 INFO - PROCESS | 16133 | Number of tests: 14 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.11 (1.9%) stddev-sans-first:2.24 06:09:49 INFO - PROCESS | 16133 | Values: 111.0 106.0 112.0 113.0 109.0 111.0 110.0 113.0 110.0 112.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:156.00 stddev:30.90 (19.8%) stddev-sans-first:32.33 06:09:49 INFO - PROCESS | 16133 | Values: 168.0 125.0 156.0 218.0 127.0 150.0 156.0 126.0 186.0 124.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:09:49 INFO - PROCESS | 16133 | Values: 162.0 161.0 160.0 161.0 161.0 162.0 163.0 161.0 160.0 161.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#3] audio-fft Cycles:10 Average:87.80 Median:75.00 stddev:27.03 (36.0%) stddev-sans-first:28.21 06:09:49 INFO - PROCESS | 16133 | Values: 74.0 75.0 75.0 147.0 75.0 74.0 77.0 76.0 130.0 75.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:92.00 stddev:19.73 (21.4%) stddev-sans-first:20.41 06:09:49 INFO - PROCESS | 16133 | Values: 92.0 92.0 149.0 92.0 96.0 93.0 123.0 92.0 94.0 120.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:09:49 INFO - PROCESS | 16133 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:09:49 INFO - PROCESS | 16133 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:09:49 INFO - PROCESS | 16133 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:53.00 stddev:16.45 (31.0%) stddev-sans-first:17.31 06:09:49 INFO - PROCESS | 16133 | Values: 53.0 60.0 54.0 53.0 53.0 53.0 53.0 105.0 51.0 52.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:09:49 INFO - PROCESS | 16133 | Values: 66.0 65.0 65.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:80.00 stddev:1.26 (1.6%) stddev-sans-first:1.32 06:09:49 INFO - PROCESS | 16133 | Values: 79.0 78.0 79.0 78.0 80.0 80.0 81.0 79.0 82.0 80.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:120.00 stddev:22.69 (18.9%) stddev-sans-first:23.86 06:09:49 INFO - PROCESS | 16133 | Values: 120.0 120.0 136.0 117.0 117.0 117.0 116.0 119.0 190.0 131.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:160.00 stddev:4.72 (2.9%) stddev-sans-first:2.70 06:09:49 INFO - PROCESS | 16133 | Values: 173.0 160.0 166.0 159.0 158.0 159.0 164.0 159.0 160.0 159.0 06:09:49 INFO - PROCESS | 16133 | 06:09:49 INFO - PROCESS | 16133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:1.84 (3.0%) stddev-sans-first:1.94 06:09:49 INFO - PROCESS | 16133 | Values: 62.0 62.0 63.0 62.0 67.0 61.0 61.0 61.0 62.0 64.0 06:09:49 INFO - PROCESS | 16133 | -------- Summary: end -------- 06:09:49 INFO - PROCESS | 16133 | 06:09:50 INFO - TEST-INFO | 16133: exit 0 06:09:50 INFO - TEST-OK | kraken | took 62686ms 06:09:50 INFO - SUITE-END | took 1175s 06:09:51 INFO - Completed test suite (00:19:35) 06:09:51 INFO - javascript benchmark 06:09:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.30873053563, 3074.523448865426, 3096.071178646406, 3114.7508199344056, 3136.827474488902, 5207.0366982108335, 5267.078261304271, 5312.6281160318795, 5331.8269980604255, 5354.170103633934, 5346.599005074616, 5398.568114550836, 5399.838004859851, 5409.594280428964, 5429.077056900326, 4839.78220980055, 4850.684705494149, 4971.353724015891, 4982.975085124569, 5035.521625445577, 4720.716756994591, 4950.306957026001, 4955.157623204064, 4994.275830004647, 5028.421731500887, 4767.5709186173235, 4841.515848415148, 4910.779014944354, 4925.975370123162, 4987.850364489072, 4889.828855990058, 4898.828541001083, 4909.705417674951, 4911.0, 4965.329680493123, 4858.878528036792, 4886.267059941002, 4907.316733691567, 4921.360223171001, 4970.130227210224, 5120.334356533627, 5323.680579165224, 5425.565954723613, 5427.511523962823, 5444.700541470217, 5815.331236907768, 5851.444112809277, 5862.677552734598, 5863.70681465925, 5868.383819698913, 5582.86042848928, 5846.853828654275, 5856.414358564152, 5867.11993201019, 5914.260717410324, 5343.572514198855, 5393.487618676219, 5396.4333744957, 5477.917831232535, 5508.807191748349, 6011.368806275365, 6019.127226552213, 6023.66869822164, 6024.036154215304, 6024.789132380346, 5477.315335583052, 5648.265725455664, 5765.769369225184, 5782.624129431658, 5788.18965344852, 5738.655680659173, 5804.796832110856, 5841.853953651193, 5843.357230704619, 5903.321118071477, 5797.0, 5802.274715660543, 5814.59297849155, 5815.185873977646, 5820.0, 5557.3331200256225, 5682.659040457585, 5743.798967036218, 5765.4522820332, 5789.218455508537, 4412.801423935931, 4427.446569178853, 4429.889252768707, 4461.754603496839, 4465.285554311295, 3929.0, 3949.447077409165, 3957.742746721454, 3979.582143874851, 3990.0024993751563, 5092.0, 5324.707141107277, 5356.464353564613, 5365.08793505105, 5515.586331025189, 5706.0, 5729.627574207663, 5730.19777231188, 5774.769009239667, 5789.652620842763, 5438.91841622376, 5442.455754424605, 5443.101888188484, 5445.074337362658, 5448.618596698193, 4864.391951006124, 4923.433805112386, 4959.256111583291, 4973.776180071905, 4993.675411098267, 5981.5214782817275, 5982.7307771149535, 5982.790602328984, 5985.221921150222, 5990.700464976734, 5801.593888427769, 5812.680302583399, 5816.796412125725, 5819.418058194146, 5820.243368362086, 5772.134179873053, 5921.4966727826895, 5998.040313549811, 6003.7898673546215, 6047.941610218282, 5727.255456790591, 5760.798372056958, 5771.336296325976, 5776.046952252831, 5778.306603207642, 5648.152777083306, 5805.767769289181, 5842.298924129132, 5861.736221869941, 5864.384239654945, 5545.889082218414, 5598.804041858678, 5629.718514074198, 5654.85862853432, 5658.971705141448, 5620.185073164286, 5621.100623900156, 5634.887302254014, 5647.689377084135, 5652.293463317085, 5318.840434786963, 5389.056915039931, 5482.040642887399, 5488.17677348401, 5500.58745594074, 5651.802186923438, 5733.0253856845275, 5741.081426971665, 5741.282339707536, 5749.310082789924, 5529.585281104014, 5570.136628822539, 5573.219749235192, 5577.470140336662, 5618.550515958632], "value": 5322.277369639596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.9969650151749, 634.1850721822453, 644.8065580325903, 646.005152065819, 653.682963762575, 32418.99999999997, 35805.820970895176, 35911.46132808003, 35918.46122308161, 35981.820090899506, 44557.77721111398, 45075.32387014189, 45116.3232551512, 49368.75315623417, 49543.0, 8725.0, 8908.599113039896, 8910.287177025855, 8910.376273660846, 8910.55447227636, 8658.0, 8777.692780752675, 8800.0, 8801.383903126783, 8802.207801297882, 8793.076726943642, 8846.0, 8854.822903541924, 8864.645414183426, 8874.245689116433, 8759.737207883774, 8794.912050879506, 8822.382433229677, 8825.0, 8829.69096081634, 8679.349048821301, 8703.695370662059, 8748.737537873874, 8771.342149338825, 8779.29765618749, 41798.0, 42219.57780422218, 42280.57719422797, 42325.57674423278, 42342.57657423417, 3517.8065206413635, 3603.927921441583, 3656.579493358271, 3785.9432108518117, 3946.4776392816093, 31973.0, 32489.350212995843, 32696.346073078643, 32829.83585082059, 33107.172320691934, 4159.9376009359885, 4177.914899087299, 4184.814421636422, 4206.495220573551, 4265.424167737347, 330812.0, 331117.0, 331123.0, 331474.0, 333107.0, 51828.0, 52786.47213527892, 52811.20783188255, 52861.2070818938, 52905.73547132317, 61206.38793612096, 61269.0, 61530.0, 61538.0, 61608.38391616027, 13939.581812545639, 14039.929800350932, 14097.506587269396, 14102.647433814032, 14105.365258563184, 10732.356058636507, 10742.355458672504, 10750.301230419998, 10762.40806755636, 10764.677059688222, 14054.789178162337, 16097.195140243175, 16270.674586508203, 16327.91836040836, 16407.1796410179, 5075.289459475676, 5928.436798504135, 5981.431763982415, 6004.849878753066, 6082.665453400017, 990.4453506036642, 1018.6689325969089, 1057.957681692739, 1077.0091515805477, 1117.8993890549727, 32171.51742723861, 32247.51628725571, 32266.193345166557, 32377.0, 32535.837320813243, 1076.4990896518782, 1127.2785417332914, 1152.475623591264, 1156.70504021474, 1161.6224726963771, 16699.833001669827, 16927.49217523476, 17005.149742512825, 17010.489685309214, 17020.829791701923, 430108.0, 433171.0, 434173.0, 435540.0, 437622.0, 56472.15291770627, 57446.7127664359, 57536.0, 57582.42417575854, 57648.0, 1277.0932637827061, 1347.905646604748, 1377.4696741754296, 1386.3207028555935, 1401.32736286583, 31297.843510783212, 33025.0, 33190.17024574308, 33481.66518334785, 34025.65974340324, 48861.51138488569, 49288.260676090606, 49299.0, 49411.258831118284, 49538.50461495339, 360198.0, 369794.0, 370386.0, 370677.0, 373102.0, 27536.44927101487, 35421.291574168885, 40080.3987940187, 43533.3469997944, 45712.771436142604, 45868.77065614651, 49527.0, 50072.24891626702, 50177.0, 51310.74344628253, 40443.595564043986, 41211.587884121975, 41760.79119604383, 42137.789311053246, 42915.785421072695, 40467.190656186125, 40804.59195408008, 40986.18027639371, 41718.0, 42105.0, 40611.796941015105, 41189.382159268236, 41212.58787412207, 41511.7924410376, 41992.79003604963, 35808.641913581574, 36669.0, 36951.63048369482, 37008.814955925045, 37662.0, 27737.0, 28353.71646283593, 28438.0, 28479.715202848536, 28607.141785746462], "value": 19598.975212547288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.0431260661802, 408.23252285702875, 409.69682434998094, 409.9856505022324, 421.95780421957807, 13435.529756458525, 18065.187066582002, 18956.5260868478, 19810.801891981075, 19817.50456238593, 14547.345369458373, 16798.916005419986, 17998.010109443974, 18083.457496275132, 18863.717044244313, 5706.828795136143, 5877.735501902424, 5911.674857882815, 5916.08300713388, 5930.822075337746, 5845.620034697752, 5851.912221316684, 5889.85275368115, 5894.292684877799, 5902.114682797594, 4221.24017676818, 6191.659458729768, 6486.383793539606, 6492.805215843532, 6606.636634985074, 6534.54258201926, 6579.374959378852, 6588.736450541996, 6599.835004124887, 6602.504812139085, 5658.151277308437, 5765.106408506688, 5779.046457334534, 5780.71096445176, 5796.188533605298, 22006.669899951514, 22175.66736498954, 22507.437314067116, 22562.43593910149, 22577.88711056434, 2313.4447732544068, 2405.494846082325, 2559.9616005759926, 2588.1329754532253, 2980.344324248662, 13550.390232439564, 14268.928655356656, 14316.928415357857, 14445.349959251858, 14838.629034274121, 1894.2801735340483, 1902.6004539046817, 1914.7606549181353, 1945.4147710001605, 1978.3174804692358, 77824.61087694582, 78304.60847695782, 81340.59329703313, 82052.0, 82837.17162828356, 10059.44673042975, 10180.52382404562, 10298.279120461646, 10333.586656533655, 10448.373097614167, 13888.513902013381, 14074.648133796736, 14109.153450792985, 14165.645858853612, 14175.731882898686, 7201.555488489645, 7343.1188257408385, 7344.7881099619035, 7384.889226661604, 7414.14737305206, 6955.652217389212, 6964.512484126164, 7032.648367581601, 7046.0, 7104.751333703295, 5921.703914804242, 6359.682015899187, 6547.279799222082, 6637.767678131242, 6817.0, 1866.2255164107014, 1875.7280194372013, 1907.3896353166854, 1971.3691618681885, 1976.1403789351677, 950.8858936927475, 1073.8746585375504, 1091.6431971687093, 1106.1427393769732, 1125.2685754259796, 19254.133563989653, 19477.707834382494, 20534.69197962032, 20548.897255513628, 20725.68911466329, 997.6209040564539, 1001.5503722379229, 1039.2777019971047, 1044.2324891204958, 1111.8499002634703, 10897.83653245202, 11359.318440893407, 11507.424628768527, 11551.191416600925, 11561.248518846416, 461516.0, 463110.0, 483263.0, 487068.0, 488810.0, 76780.61609692028, 90510.0, 92112.53943730239, 93562.53218733863, 95184.52407737917, 1036.7252678040325, 1049.9107575855985, 1068.0707784227773, 1098.9175811814146, 1111.6164923101517, 17572.82427175763, 17684.823151768833, 17955.0, 17981.820181798015, 18288.90855545714, 39342.803285983384, 39773.20453590854, 40323.0, 41230.793846031775, 41909.371359429024, 55600.0, 57766.7111664439, 58150.709246453494, 58238.12642810446, 59273.70363148156, 7761.107472640719, 8649.61076751535, 8760.38677292609, 8908.376413650982, 9187.03536128697, 7418.703251870081, 9686.806263874823, 10990.791012988724, 12645.747085058063, 13087.345632718516, 11622.88377116218, 11886.821697674715, 11997.340146292037, 12229.816552751894, 12241.877581224073, 11719.649164583032, 11732.824007639721, 11787.469563869476, 11998.520059197534, 12267.631971040882, 8007.719729809429, 12222.633321000385, 12235.388230588613, 12272.754544908874, 12418.254904705747, 7770.650320735694, 8492.363072769691, 8711.695090671796, 8954.776130596787, 8991.55042247898, 10388.37669739818, 11808.586699465477, 11898.286102833858, 11943.76112477763, 12048.879511205127], "value": 9345.05388513157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.0, 1503.744363458212, 1537.8692811111057, 1646.3661490326222, 1831.2857985385701, 8539.573021348939, 8848.646054157834, 8870.955645221773, 9143.497107659075, 9166.495842728664, 8728.694495692653, 8888.333374996868, 8907.376483646147, 8915.95542022289, 8917.598708058136, 2344.9531009379803, 2365.325882123595, 2370.8814559272055, 2373.347329484397, 2374.192774456684, 2292.7363353214346, 2302.815774738017, 2318.281332786833, 2327.848689835164, 2332.078828862598, 2340.5201933603657, 2353.5528249632603, 2364.527094581082, 2381.95236095278, 2381.9761802381927, 2316.7683231676865, 2328.382978510696, 2341.1220792202926, 2353.3881190890406, 2354.0, 2336.5794157051723, 2338.7193536775526, 2340.2394221877958, 2341.4965782356876, 2343.5664402085667, 8657.480551166951, 8978.236849867704, 8987.775305617346, 9030.0, 9037.141471560191, 5264.499872512143, 5409.26974858393, 5500.917486237709, 5513.641613295123, 5518.972405137949, 3165.6517783043846, 3247.8213698246586, 3293.8965446575426, 3536.45184996326, 3542.946855797165, 1006.5219020965056, 1030.8969103089705, 1030.9432981186033, 1037.4916291017423, 1038.175508180466, 12038.638840834788, 12391.318477483735, 12404.62786116409, 12450.564230251897, 12452.377381130998, 4794.9280760788615, 4801.005736459423, 4838.225883858566, 4844.297576851407, 4866.95133048665, 10564.947175264075, 10577.894221057692, 10589.417582032907, 10597.682069537927, 10611.41637209961, 5453.7818487260065, 5467.289252397242, 5467.808626698046, 5469.316335458067, 5470.890582188414, 4236.322188449833, 4461.732296062247, 4631.861044168681, 4666.020135771458, 4784.64115191362, 4056.7565946043333, 4093.7339072960162, 4145.336746120606, 4159.563245859202, 4227.323628219531, 1275.8277632519678, 1277.5720133755297, 1281.7885048967003, 1289.4004288006122, 1307.7776777947772, 730.6273800361747, 905.9229965452879, 916.3768637326549, 934.345957829522, 958.7219706285239, 5645.463680950304, 5648.49163575272, 5766.971165144231, 5780.046292361797, 5871.500922421642, 966.1884017425256, 975.770693886936, 982.1798798003604, 999.480270259461, 1012.1801340913884, 3627.8548858045383, 3876.689864810865, 3879.165979314461, 3896.8441262349756, 3949.348357520977, 10844.295120817122, 10939.398333091756, 11058.557657693602, 11135.777284454427, 11253.043491303331, 10879.945600271947, 10950.671479855617, 10989.835152472719, 11026.062784663394, 11057.50241239146, 8092.71675491355, 8558.315334773204, 8569.442986206, 8588.656453741905, 8591.957040214758, 5629.915551266816, 5702.116171993348, 5768.653880767168, 5784.248047753765, 5863.120531920246, 10318.638847640297, 10452.68641940743, 10461.110805581611, 10491.580336786443, 10494.160467162761, 9989.550470228713, 10142.949285253526, 10621.575136994434, 10631.043206111488, 10662.573497060032, 6915.377616014583, 7693.346065584488, 7781.572013539309, 7953.483023603448, 8201.26188643025, 8677.826443471222, 8745.212930836255, 8805.647774088964, 8828.64685412602, 8832.425892316978, 7690.769276921701, 7703.768886933401, 7718.189590092959, 7806.0632724073475, 8103.716369927024, 7507.587082710504, 7776.300132987832, 7787.415943804124, 7793.727219547289, 7965.681372745025, 6567.0, 6570.441512471302, 6617.702203400955, 6620.0, 6626.867462650816, 4760.238361862085, 4812.783424745965, 4837.0, 4923.286123512143, 4989.301497790239, 4787.40157480315, 4914.606831453547, 4919.139150648693, 4934.136526107988, 5057.949420505748], "value": 4642.752584112385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.07743357316303, 333.6863348452454, 335.8069110261599, 341.4127700355388, 342.5854715793889, 5328.333958255218, 5356.91964620531, 5375.973120134394, 5377.784888604461, 5377.865553361168, 5229.398619158798, 5279.1817268323375, 5296.126139187029, 5309.389420216677, 5315.973420132904, 3910.569837317893, 3996.920061598766, 4151.83392664293, 4165.271077561415, 4185.497740271172, 4105.794710264489, 4107.322291821861, 4124.42258083867, 4135.855245066423, 4183.288840897039, 3945.171513982067, 4101.569335219804, 4101.666958238585, 4106.548279689232, 4118.464599602047, 4017.4777278953693, 4126.596957034622, 4131.669466442678, 4137.565555616647, 4138.317177665682, 3655.323765103438, 3657.3965295726175, 3668.981655091734, 3673.8897833065053, 3708.3868517195106, 5112.897742045138, 5116.258142569307, 5139.357580302462, 5141.511556402136, 5148.768305426227, 4425.977870110629, 4647.372604698357, 4654.045300973599, 4655.906881862377, 4664.463586687541, 5478.260434841285, 5483.835484935458, 5494.36814766303, 5500.614956953015, 5516.558675305966, 3854.9784307158625, 3865.4201869719486, 3888.4556162137324, 3892.649661530476, 3903.746256493319, 5518.806841760559, 5629.662220266797, 5683.744231509592, 5700.173474846166, 5709.857253568653, 3982.4225487304757, 3991.5808840071954, 4014.8594799181888, 4038.273110840077, 4060.147369052532, 4012.25773231953, 4055.47278853753, 4097.836086556564, 4103.938440923389, 4126.793660316972, 4575.656825738083, 4614.423197100363, 4641.814327426932, 4672.813087476531, 4674.929876051862, 5359.249705041298, 5422.532747599833, 5448.346198456211, 5456.154296084113, 5464.3442786865835, 1376.593904798087, 1392.7395706885084, 1403.7894315852704, 1406.2406300597768, 1414.929253537319, 904.5748498205833, 912.0241341764248, 920.5673333533363, 920.6685593186447, 961.2838435365697, 5315.627906046617, 5336.46635336471, 5355.108241549519, 5363.865903352447, 5375.0, 5599.320203938883, 5601.719914004365, 5610.49505544503, 5624.831255062355, 5625.38120806711, 5044.924326135111, 5311.362636483646, 5324.866878327995, 5347.41178470368, 5364.0, 2983.4331477019296, 2988.581598576201, 2998.8500574971163, 3004.9549256761165, 3019.2602812311125, 5733.569982251264, 5750.482456578844, 5754.424557544296, 5757.827265182052, 5815.302163740378, 5515.310586176728, 5701.2018317435595, 5791.276090488689, 5805.506531944748, 5848.3274423441, 5924.348321684612, 5957.851053723692, 5965.4631083203585, 5972.343042265347, 6002.159697642246, 5501.669899806025, 5718.0, 5730.627509212055, 5739.5695322850115, 5788.594798364074, 5667.3482549507335, 5685.971570142123, 5692.48767610917, 5701.4298570142655, 5709.600327977002, 5875.588708790344, 5933.910991335047, 5940.97029514867, 5946.494547963472, 5961.225040744675, 3806.371948628556, 4031.4759081320412, 4074.2055299216368, 4083.285425050664, 4093.549709532009, 5669.489745922887, 5680.2047713321, 5711.600187986801, 5720.771169153188, 5730.312362516524, 5305.389880163831, 5472.562195024469, 5510.0, 5521.309836270466, 5558.583106266965, 5520.36515800672, 5521.889562208814, 5525.917111243254, 5527.585431092764, 5565.805196818092, 5121.743912804271, 5291.894162116813, 5332.30680011596, 5436.782528698966, 5451.264079349237, 5525.198846167364, 5553.72264379187, 5558.833235002957, 5564.4713752193475, 5588.552915766811, 5354.678719276856, 5363.946360536344, 5392.622516423813, 5397.433269506802, 5422.9186562202385], "value": 4211.019410823039, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5472135604062, 854.7606670132365, 855.3542075732821, 857.2841677199538, 884.5311984648139, 16085.678286434279, 16617.169141542934, 16622.418215362464, 16639.334426622936, 16648.50054498364, 15661.530154095366, 15683.529494115195, 15732.0, 15747.133907635076, 15748.76376854348, 816.8652172391548, 822.2312138150818, 823.9794005149889, 824.0, 824.0482243009304, 678.9287124851894, 773.7214602743036, 774.8992630957996, 775.8099265679888, 802.4062193976445, 840.6763396092518, 842.3892677808601, 842.7724514381114, 843.8101427178897, 845.6279237135641, 699.4963626189136, 836.38107800228, 837.0959363886988, 837.4138103327695, 838.053000109878, 592.4016743089468, 592.9110633405023, 597.9491743201833, 613.6410200032941, 613.8373331067271, 13586.86413135866, 13620.523281685093, 13636.181829090287, 13650.044496885223, 13710.24593647349, 11762.647120586396, 12283.57007504733, 12343.938280308541, 12359.62921112368, 12653.746925061447, 11683.415829208505, 11829.94085029578, 11842.348670823101, 11870.881291187065, 12138.15032947694, 4350.782460876943, 4354.673399495019, 4453.844115455976, 4464.441944756905, 4561.7491037992895, 57135.0, 57646.84706305892, 58054.129188062216, 58083.709581451825, 58164.70917645427, 10870.510827012804, 10896.455177241107, 10933.726656833644, 11179.776404471864, 11211.38337391435, 19351.612967740566, 19365.225390984484, 19384.612307753767, 19447.513812154808, 19507.12217950167, 7737.640510749808, 8073.273405393543, 8078.838423231502, 8208.753737387888, 8263.752087437386, 4433.490148632884, 4613.792379342937, 4637.281221410619, 4756.762161891892, 4827.348307978378, 3386.4243078676686, 3456.809875456874, 3479.234568394949, 3600.4959305697225, 3601.405768048243, 700.5983864405491, 705.2101646156235, 709.4643544124153, 711.8647456983157, 715.5349023135004, 719.435139508073, 723.3815088099705, 726.8412813942582, 759.3886921028515, 760.5626764610371, 8770.91229087701, 9215.354925155174, 9221.723348299562, 9321.207697345666, 9379.390339627902, 652.083822229768, 661.6956200147889, 679.4394624434763, 679.8062552172607, 687.9140107486564, 4523.5024147343765, 4602.976985115053, 4626.976865115653, 4674.410978506048, 4699.436067671902, 72802.0, 72918.27081729221, 73566.0, 73861.63069184727, 74179.62910185415, 52022.21966670503, 62069.68965155145, 62934.0, 62999.37000630027, 63617.681911590145, 48585.27122093172, 54780.0, 55212.17181742277, 55744.0, 55885.72057139688, 8517.74446766598, 8550.204457064086, 8664.436811607226, 8674.609642565974, 8701.40200855141, 37114.07214819543, 37341.0, 37501.0, 37917.0, 38559.80720096381, 44813.77593112014, 47715.76142119267, 48153.5184648149, 48488.22572379549, 49118.75440622774, 12137.514499419924, 12205.389730513261, 12337.444814983168, 12685.873141268468, 13057.21656700601, 13328.800067998794, 13339.66650833737, 13909.234992075533, 14102.929485352917, 14206.715865682421, 11384.0, 11483.540658373571, 11574.18980671345, 11654.0, 11985.64043078709, 11606.129540284344, 12227.510899563918, 12304.323262220663, 12316.876831231932, 12446.980180954419, 11458.369789661649, 11620.302781833117, 12003.459844307201, 12230.633081007583, 12259.141860070065, 9960.0, 10081.395116292753, 10144.137748291478, 11092.778144436905, 11107.166962478008, 9297.6280948764, 9342.906570934203, 9609.855852162364, 10150.289479736643, 10315.948420257851], "value": 6871.575685841158, "unit": "score"}], "name": "dromaeo_css", "value": 7126.2771072079795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 113.0, 109.0, 111.0, 110.0, 113.0, 110.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 125.0, 156.0, 218.0, 127.0, 150.0, 156.0, 126.0, 186.0, 124.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 147.0, 75.0, 74.0, 77.0, 76.0, 130.0, 75.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 92.0, 96.0, 93.0, 123.0, 92.0, 94.0, 120.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 54.0, 53.0, 53.0, 53.0, 53.0, 105.0, 51.0, 52.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 78.0, 80.0, 80.0, 81.0, 79.0, 82.0, 80.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 136.0, 117.0, 117.0, 117.0, 116.0, 119.0, 190.0, 131.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 160.0, 166.0, 159.0, 158.0, 159.0, 164.0, 159.0, 160.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 67.0, 61.0, 61.0, 61.0, 62.0, 64.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1531.5999999999997, "alertThreshold": 2.0}]} 06:09:51 INFO - Return code: 0 06:09:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:51 ERROR - # TBPL SUCCESS # 06:09:51 INFO - Running post-action listener: _resource_record_post_action 06:09:51 INFO - ##### 06:09:51 INFO - ##### Finished run-tests step (success) 06:09:51 INFO - ##### 06:09:51 INFO - Running post-run listener: _resource_record_post_run 06:09:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546930688; Read time: 12; Write time: 468820 06:09:51 INFO - TinderboxPrint: CPU usage
13.1% 06:09:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:09:51 INFO - TinderboxPrint: I/O write bytes / time
546,930,688 / 468,820 06:09:51 INFO - TinderboxPrint: CPU idle
8,275.8 (86.9%) 06:09:51 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 06:09:51 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 202891264; Read time: 0; Write time: 255444 06:09:51 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287801344; Read time: 12; Write time: 192812 06:09:51 INFO - Running post-run listener: _upload_blobber_files 06:09:51 INFO - Blob upload gear active. 06:09:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:51 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 06:09:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:52 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:53 INFO - (blobuploader) - INFO - Done attempting. 06:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:53 INFO - (blobuploader) - INFO - Done attempting. 06:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:57 INFO - (blobuploader) - INFO - Done attempting. 06:09:57 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:57 INFO - Return code: 0 06:09:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f78144bf9dabbac4092e9faacb841de83747ff97dc0b5e43544187924ab653d12dceccae84c9f5cea6d345868233cfb21bc7b0d3517932fe225b75042cb65d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a536af8e8276e80131853a06d065450da32fa1e83d7b3eb65187ef41d743aa8428e4238e7d647b954e60219a18037f810a2d229cff3d5057a403683bb5c55631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5c33373c01d939dc6ed75ec11262c718cbc72ed209fabf58e5bc8c0767a578f7d033d61e67c9a27d3c3cba5fb7dd931afba4445bc6f4e458cdc07c2c263ed8"} 06:09:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:57 INFO - Contents: 06:09:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f78144bf9dabbac4092e9faacb841de83747ff97dc0b5e43544187924ab653d12dceccae84c9f5cea6d345868233cfb21bc7b0d3517932fe225b75042cb65d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a536af8e8276e80131853a06d065450da32fa1e83d7b3eb65187ef41d743aa8428e4238e7d647b954e60219a18037f810a2d229cff3d5057a403683bb5c55631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5c33373c01d939dc6ed75ec11262c718cbc72ed209fabf58e5bc8c0767a578f7d033d61e67c9a27d3c3cba5fb7dd931afba4445bc6f4e458cdc07c2c263ed8"} 06:09:57 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:57 INFO - Copying logs to upload dir... 06:09:57 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.561604 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-05-20 06:09:57.392787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 06:09:57.399882) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f78144bf9dabbac4092e9faacb841de83747ff97dc0b5e43544187924ab653d12dceccae84c9f5cea6d345868233cfb21bc7b0d3517932fe225b75042cb65d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a536af8e8276e80131853a06d065450da32fa1e83d7b3eb65187ef41d743aa8428e4238e7d647b954e60219a18037f810a2d229cff3d5057a403683bb5c55631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5c33373c01d939dc6ed75ec11262c718cbc72ed209fabf58e5bc8c0767a578f7d033d61e67c9a27d3c3cba5fb7dd931afba4445bc6f4e458cdc07c2c263ed8"} build_url:https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/SRAKuj2kRPqNw8n8xuAw9Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1f78144bf9dabbac4092e9faacb841de83747ff97dc0b5e43544187924ab653d12dceccae84c9f5cea6d345868233cfb21bc7b0d3517932fe225b75042cb65d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a536af8e8276e80131853a06d065450da32fa1e83d7b3eb65187ef41d743aa8428e4238e7d647b954e60219a18037f810a2d229cff3d5057a403683bb5c55631", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a5c33373c01d939dc6ed75ec11262c718cbc72ed209fabf58e5bc8c0767a578f7d033d61e67c9a27d3c3cba5fb7dd931afba4445bc6f4e458cdc07c2c263ed8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 06:09:57.424450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 06:09:57.426356) ========= 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=14ef55db36f7623abb31b9cf000001d5-1463745172.759446-1771976300 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 06:09:57.507746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 06:09:57.508051) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 06:09:57.508977) ========= ========= Total master_lag: 0.21 =========