builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1463785748.16 results: success (0) buildid: 20160520144634 builduid: 6e49318d517349afa9d1e15f4a4fbfff revision: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.160817) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.161282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.161574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.178684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.179022) ========= 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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 16:09:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-05-20 16:09:08 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150093 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.366201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.366542) ========= 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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.416390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.416764) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 --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 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 --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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 16:09:08,466 truncating revision to first 12 chars 2016-05-20 16:09:08,466 Setting DEBUG logging. 2016-05-20 16:09:08,466 attempt 1/10 2016-05-20 16:09:08,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30b83fcb0009?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 16:09:08,730 unpacking tar archive at: mozilla-central-30b83fcb0009/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.956349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.956691) ========= script_repo_revision: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.957076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.957342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 16:09:08.967394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-20 16:09:08.967784) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:09:09 INFO - MultiFileLogger online at 20160520 16:09:09 in /builds/slave/test 16:09:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:09:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:09 INFO - {'append_to_log': False, 16:09:09 INFO - 'base_work_dir': '/builds/slave/test', 16:09:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:09:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:09 INFO - 'branch': 'Firefox-Non-PGO', 16:09:09 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:09 INFO - 'config_files': ('talos/linux_config.py',), 16:09:09 INFO - 'default_actions': ('clobber', 16:09:09 INFO - 'read-buildbot-config', 16:09:09 INFO - 'download-and-extract', 16:09:09 INFO - 'populate-webroot', 16:09:09 INFO - 'create-virtualenv', 16:09:09 INFO - 'install', 16:09:09 INFO - 'run-tests'), 16:09:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:09 INFO - 'download_minidump_stackwalk': True, 16:09:09 INFO - 'download_symbols': 'ondemand', 16:09:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:09 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:09 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:09 INFO - 'installer_path': 'installer.exe', 16:09:09 INFO - 'log_level': 'info', 16:09:09 INFO - 'log_name': 'talos', 16:09:09 INFO - 'log_to_console': True, 16:09:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:09:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:09:09 INFO - 'opt_config_files': (), 16:09:09 INFO - 'pip_index': False, 16:09:09 INFO - 'sps_profile': False, 16:09:09 INFO - 'sps_profile_interval': 0, 16:09:09 INFO - 'suite': 'dromaeojs-e10s', 16:09:09 INFO - 'system_bits': '32', 16:09:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:09 INFO - 'title': 'talos-linux64-ix-010', 16:09:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:09 INFO - 'use_talos_json': True, 16:09:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:09 INFO - 'work_dir': 'build'} 16:09:09 INFO - ##### 16:09:09 INFO - ##### Running clobber step. 16:09:09 INFO - ##### 16:09:09 INFO - Running pre-action listener: _resource_record_pre_action 16:09:09 INFO - Running main action method: clobber 16:09:09 INFO - rmtree: /builds/slave/test/build 16:09:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:09 INFO - Running post-action listener: _resource_record_post_action 16:09:09 INFO - ##### 16:09:09 INFO - ##### Finished clobber step (success) 16:09:09 INFO - ##### 16:09:09 INFO - ##### 16:09:09 INFO - ##### Running read-buildbot-config step. 16:09:09 INFO - ##### 16:09:09 INFO - Running pre-action listener: _resource_record_pre_action 16:09:09 INFO - Running main action method: read_buildbot_config 16:09:09 INFO - Using buildbot properties: 16:09:09 INFO - { 16:09:09 INFO - "project": "", 16:09:09 INFO - "product": "firefox", 16:09:09 INFO - "script_repo_revision": "production", 16:09:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:09:09 INFO - "repository": "", 16:09:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:09:09 INFO - "buildid": "20160520144634", 16:09:09 INFO - "pgo_build": "False", 16:09:09 INFO - "basedir": "/builds/slave/test", 16:09:09 INFO - "buildnumber": 326, 16:09:09 INFO - "slavename": "talos-linux64-ix-010", 16:09:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:09:09 INFO - "platform": "ubuntu64_hw", 16:09:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:09:09 INFO - "branch": "mozilla-central", 16:09:09 INFO - "repo_path": "mozilla-central", 16:09:09 INFO - "revision": "30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7", 16:09:09 INFO - "stage_platform": "linux64", 16:09:09 INFO - "builduid": "6e49318d517349afa9d1e15f4a4fbfff", 16:09:09 INFO - "slavebuilddir": "test" 16:09:09 INFO - } 16:09:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:09:09 INFO - Running post-action listener: _resource_record_post_action 16:09:09 INFO - ##### 16:09:09 INFO - ##### Finished read-buildbot-config step (success) 16:09:09 INFO - ##### 16:09:09 INFO - ##### 16:09:09 INFO - ##### Running download-and-extract step. 16:09:09 INFO - ##### 16:09:09 INFO - Running pre-action listener: _resource_record_pre_action 16:09:09 INFO - Running main action method: download_and_extract 16:09:09 INFO - mkdir: /builds/slave/test/build/tests 16:09:09 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')]} 16:09:09 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:09:10 INFO - Downloaded 1361 bytes. 16:09:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:09:10 INFO - Using the following test package requirements: 16:09:10 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:09:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:09:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:09:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'jsshell-linux-x86_64.zip'], 16:09:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:09:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:09:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:09:10 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:09:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:09:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:09:10 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:09:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:10 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:09:12 INFO - Downloaded 22814329 bytes. 16:09:12 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'] 16:09:12 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 16:09:13 INFO - Return code: 0 16:09:13 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 16:09:13 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')]} 16:09:13 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:09:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:09:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:09:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:10:15 INFO - Downloaded 22814329 bytes. 16:10:15 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'] 16:10:15 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 16:10:17 INFO - Return code: 0 16:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:17 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:10:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:10:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:10:22 INFO - Downloaded 10840359 bytes. 16:10:22 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'] 16:10:22 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 16:10:23 INFO - Return code: 0 16:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:23 INFO - https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TOGfu4wDSoSY2CKVGw7nTA/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 16:10:27 INFO - Downloaded 54816006 bytes. 16:10:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:27 INFO - mkdir: /builds/slave/test/properties 16:10:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:27 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:27 INFO - Contents: 16:10:27 INFO - build_url:https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:28 INFO - Running post-action listener: _resource_record_post_action 16:10:28 INFO - Running post-action listener: set_extra_try_arguments 16:10:28 INFO - ##### 16:10:28 INFO - ##### Finished download-and-extract step (success) 16:10:28 INFO - ##### 16:10:28 INFO - ##### 16:10:28 INFO - ##### Running populate-webroot step. 16:10:28 INFO - ##### 16:10:28 INFO - Running pre-action listener: _resource_record_pre_action 16:10:28 INFO - Running main action method: populate_webroot 16:10:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:28 INFO - '--tppagecycles', 16:10:28 INFO - '7'], 16:10:28 INFO - 'tests': ['tsvgm']}}, 16:10:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['damp', 'tps']}, 16:10:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'tests': ['damp', 'tps']}, 16:10:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['dromaeo_dom']}, 16:10:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['a11yr', 16:10:28 INFO - 'ts_paint', 16:10:28 INFO - 'tpaint', 16:10:28 INFO - 'sessionrestore', 16:10:28 INFO - 'sessionrestore_no_auto_restore', 16:10:28 INFO - 'tabpaint']}, 16:10:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['tsvgx', 16:10:28 INFO - 'tsvgr_opacity', 16:10:28 INFO - 'tart', 16:10:28 INFO - 'tscrollx', 16:10:28 INFO - 'cart']}, 16:10:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:28 INFO - 'tsvgr_opacity', 16:10:28 INFO - 'tart', 16:10:28 INFO - 'tscrollx', 16:10:28 INFO - 'cart']}, 16:10:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'talos_options': ['--disable-e10s'], 16:10:28 INFO - 'tests': ['tp5o']}, 16:10:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'tests': ['tp5o']}, 16:10:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'talos_options': ['--disable-e10s', 16:10:28 INFO - '--xperf_path', 16:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:28 INFO - 'tests': ['tp5n']}, 16:10:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:28 INFO - 'talos_options': ['--xperf_path', 16:10:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:28 INFO - 'tests': ['tp5n']}}, 16:10:28 INFO - 'talos.zip': {'path': '', 16:10:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:28 INFO - Running post-action listener: _resource_record_post_action 16:10:28 INFO - ##### 16:10:28 INFO - ##### Finished populate-webroot step (success) 16:10:28 INFO - ##### 16:10:28 INFO - ##### 16:10:28 INFO - ##### Running create-virtualenv step. 16:10:28 INFO - ##### 16:10:28 INFO - Running pre-action listener: _resource_record_pre_action 16:10:28 INFO - Running main action method: create_virtualenv 16:10:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:28 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 16:10:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:28 INFO - Using real prefix '/usr' 16:10:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:31 INFO - Installing pip.................done. 16:10:31 INFO - Return code: 0 16:10:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10:31 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')]} 16:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:31 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')]} 16:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:31 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:31 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 16:10:31 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 16:10:31 INFO - Using env: {'DISPLAY': ':0', 16:10:31 INFO - 'HOME': '/home/cltbld', 16:10:31 INFO - 'LANG': 'en_US.UTF-8', 16:10:31 INFO - 'LANGUAGE': 'en_US:en', 16:10:31 INFO - 'LOGNAME': 'cltbld', 16:10:31 INFO - 'MAIL': '/var/mail/cltbld', 16:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:31 INFO - 'MOZ_NO_REMOTE': '1', 16:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:31 INFO - 'NO_EM_RESTART': '1', 16:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:31 INFO - 'PWD': '/builds/slave/test', 16:10:31 INFO - 'SHELL': '/bin/bash', 16:10:31 INFO - 'SHLVL': '1', 16:10:31 INFO - 'TERM': 'linux', 16:10:31 INFO - 'TMOUT': '86400', 16:10:31 INFO - 'USER': 'cltbld', 16:10:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:31 INFO - '_': '/tools/buildbot/bin/python'} 16:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:31 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 16:10:31 INFO - Cleaning up... 16:10:31 INFO - Return code: 0 16:10:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10:31 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')]} 16:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:31 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')]} 16:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:31 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:31 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 16:10:31 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 16:10:31 INFO - Using env: {'DISPLAY': ':0', 16:10:31 INFO - 'HOME': '/home/cltbld', 16:10:31 INFO - 'LANG': 'en_US.UTF-8', 16:10:31 INFO - 'LANGUAGE': 'en_US:en', 16:10:31 INFO - 'LOGNAME': 'cltbld', 16:10:31 INFO - 'MAIL': '/var/mail/cltbld', 16:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:31 INFO - 'MOZ_NO_REMOTE': '1', 16:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:31 INFO - 'NO_EM_RESTART': '1', 16:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:31 INFO - 'PWD': '/builds/slave/test', 16:10:31 INFO - 'SHELL': '/bin/bash', 16:10:31 INFO - 'SHLVL': '1', 16:10:31 INFO - 'TERM': 'linux', 16:10:31 INFO - 'TMOUT': '86400', 16:10:31 INFO - 'USER': 'cltbld', 16:10:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:31 INFO - '_': '/tools/buildbot/bin/python'} 16:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:31 INFO - Downloading/unpacking psutil>=3.1.1 16:10:31 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 16:10:31 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 16:10:31 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 16:10:31 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 16:10:31 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 16:10:31 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 16:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:33 INFO - Installing collected packages: psutil 16:10:33 INFO - Running setup.py install for psutil 16:10:34 INFO - building 'psutil._psutil_linux' extension 16:10:34 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 16:10:35 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 16:10:35 INFO - building 'psutil._psutil_posix' extension 16:10:35 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 16:10:35 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 16:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:35 INFO - Successfully installed psutil 16:10:35 INFO - Cleaning up... 16:10:35 INFO - Return code: 0 16:10:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:10: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 mozsystemmonitor==0.3 16:10:35 INFO - Using env: {'DISPLAY': ':0', 16:10:35 INFO - 'HOME': '/home/cltbld', 16:10:35 INFO - 'LANG': 'en_US.UTF-8', 16:10:35 INFO - 'LANGUAGE': 'en_US:en', 16:10:35 INFO - 'LOGNAME': 'cltbld', 16:10:35 INFO - 'MAIL': '/var/mail/cltbld', 16:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:35 INFO - 'MOZ_NO_REMOTE': '1', 16:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:35 INFO - 'NO_EM_RESTART': '1', 16:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:35 INFO - 'PWD': '/builds/slave/test', 16:10:35 INFO - 'SHELL': '/bin/bash', 16:10:35 INFO - 'SHLVL': '1', 16:10:35 INFO - 'TERM': 'linux', 16:10:35 INFO - 'TMOUT': '86400', 16:10:35 INFO - 'USER': 'cltbld', 16:10:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:35 INFO - '_': '/tools/buildbot/bin/python'} 16:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:37 INFO - Installing collected packages: mozsystemmonitor 16:10:37 INFO - Running setup.py install for mozsystemmonitor 16:10:37 INFO - Successfully installed mozsystemmonitor 16:10:37 INFO - Cleaning up... 16:10:37 INFO - Return code: 0 16:10:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:10:37 INFO - Using env: {'DISPLAY': ':0', 16:10:37 INFO - 'HOME': '/home/cltbld', 16:10:37 INFO - 'LANG': 'en_US.UTF-8', 16:10:37 INFO - 'LANGUAGE': 'en_US:en', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MAIL': '/var/mail/cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SHLVL': '1', 16:10:37 INFO - 'TERM': 'linux', 16:10:37 INFO - 'TMOUT': '86400', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - '_': '/tools/buildbot/bin/python'} 16:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:40 INFO - Downloading docopt-0.6.1.tar.gz 16:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:40 INFO - Running setup.py install for blobuploader 16:10:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:40 INFO - Running setup.py install for requests 16:10:41 INFO - Running setup.py install for docopt 16:10:41 INFO - Successfully installed blobuploader requests docopt 16:10:41 INFO - Cleaning up... 16:10:41 INFO - Return code: 0 16:10:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:41 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:41 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 16:10:41 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 16:10:41 INFO - Using env: {'DISPLAY': ':0', 16:10:41 INFO - 'HOME': '/home/cltbld', 16:10:41 INFO - 'LANG': 'en_US.UTF-8', 16:10:41 INFO - 'LANGUAGE': 'en_US:en', 16:10:41 INFO - 'LOGNAME': 'cltbld', 16:10:41 INFO - 'MAIL': '/var/mail/cltbld', 16:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:41 INFO - 'MOZ_NO_REMOTE': '1', 16:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:41 INFO - 'NO_EM_RESTART': '1', 16:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:41 INFO - 'PWD': '/builds/slave/test', 16:10:41 INFO - 'SHELL': '/bin/bash', 16:10:41 INFO - 'SHLVL': '1', 16:10:41 INFO - 'TERM': 'linux', 16:10:41 INFO - 'TMOUT': '86400', 16:10:41 INFO - 'USER': 'cltbld', 16:10:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:41 INFO - '_': '/tools/buildbot/bin/python'} 16:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:41 INFO - Running setup.py (path:/tmp/pip-IhqzbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:41 INFO - Running setup.py (path:/tmp/pip-DqTstG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:41 INFO - Running setup.py (path:/tmp/pip-059pr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:41 INFO - Running setup.py (path:/tmp/pip-d9QbHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:41 INFO - Running setup.py (path:/tmp/pip-3SIcHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:41 INFO - Running setup.py (path:/tmp/pip-EpD7Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:41 INFO - Running setup.py (path:/tmp/pip-9cVITe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:42 INFO - Running setup.py (path:/tmp/pip-ft1ToQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:42 INFO - Running setup.py (path:/tmp/pip-odR4sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:42 INFO - Running setup.py (path:/tmp/pip-_rju5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:42 INFO - Running setup.py (path:/tmp/pip-85Ul0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:42 INFO - Running setup.py (path:/tmp/pip-MarYR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:42 INFO - Running setup.py (path:/tmp/pip-hraG67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:42 INFO - Running setup.py (path:/tmp/pip-ZmmOvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:42 INFO - Running setup.py (path:/tmp/pip-Zejp7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:42 INFO - Running setup.py (path:/tmp/pip-p312jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:42 INFO - Running setup.py (path:/tmp/pip-fSrWOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:42 INFO - Running setup.py install for manifestparser 16:10:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:42 INFO - Running setup.py install for mozcrash 16:10:42 INFO - Running setup.py install for mozdebug 16:10:43 INFO - Running setup.py install for mozdevice 16:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for mozfile 16:10:43 INFO - Running setup.py install for mozhttpd 16:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for mozinfo 16:10:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for mozInstall 16:10:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for mozleak 16:10:43 INFO - Running setup.py install for mozlog 16:10:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for moznetwork 16:10:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:43 INFO - Running setup.py install for mozprocess 16:10:43 INFO - Running setup.py install for mozprofile 16:10:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:44 INFO - Running setup.py install for mozrunner 16:10:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:44 INFO - Running setup.py install for mozscreenshot 16:10:44 INFO - Running setup.py install for moztest 16:10:44 INFO - Running setup.py install for mozversion 16:10:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:44 INFO - Cleaning up... 16:10:44 INFO - Return code: 0 16:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:44 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:44 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 16:10:44 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 16:10:44 INFO - Using env: {'DISPLAY': ':0', 16:10:44 INFO - 'HOME': '/home/cltbld', 16:10:44 INFO - 'LANG': 'en_US.UTF-8', 16:10:44 INFO - 'LANGUAGE': 'en_US:en', 16:10:44 INFO - 'LOGNAME': 'cltbld', 16:10:44 INFO - 'MAIL': '/var/mail/cltbld', 16:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:44 INFO - 'MOZ_NO_REMOTE': '1', 16:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:44 INFO - 'NO_EM_RESTART': '1', 16:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:44 INFO - 'PWD': '/builds/slave/test', 16:10:44 INFO - 'SHELL': '/bin/bash', 16:10:44 INFO - 'SHLVL': '1', 16:10:44 INFO - 'TERM': 'linux', 16:10:44 INFO - 'TMOUT': '86400', 16:10:44 INFO - 'USER': 'cltbld', 16:10:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:44 INFO - '_': '/tools/buildbot/bin/python'} 16:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:44 INFO - Running setup.py (path:/tmp/pip-Xd4WaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:44 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)) 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:44 INFO - Running setup.py (path:/tmp/pip-6szVpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:44 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)) 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:44 INFO - Running setup.py (path:/tmp/pip-KyslIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:44 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)) 16:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:44 INFO - Running setup.py (path:/tmp/pip-jAcTYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:45 INFO - Running setup.py (path:/tmp/pip-v0MiXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:45 INFO - Running setup.py (path:/tmp/pip-NFsdth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:45 INFO - Running setup.py (path:/tmp/pip-n2See4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:45 INFO - Running setup.py (path:/tmp/pip-0QAGvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:45 INFO - Running setup.py (path:/tmp/pip-9n_Ywq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:45 INFO - Running setup.py (path:/tmp/pip-IoDsDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:45 INFO - Running setup.py (path:/tmp/pip-DUPaMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:45 INFO - Running setup.py (path:/tmp/pip-_IW4rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:45 INFO - Running setup.py (path:/tmp/pip-0ZButg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:45 INFO - Running setup.py (path:/tmp/pip-fH_44w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:45 INFO - Running setup.py (path:/tmp/pip-5c0aRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:45 INFO - Running setup.py (path:/tmp/pip-ocGCv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:45 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)) 16:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:45 INFO - Running setup.py (path:/tmp/pip-QQ8c78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:45 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)) 16:10:45 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)) 16:10:45 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)) 16:10:45 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)) 16:10:45 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)) 16:10:45 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)) 16:10:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:47 INFO - Downloading blessings-1.6.tar.gz 16:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:47 INFO - Installing collected packages: blessings 16:10:47 INFO - Running setup.py install for blessings 16:10:48 INFO - Successfully installed blessings 16:10:48 INFO - Cleaning up... 16:10:48 INFO - Return code: 0 16:10:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:48 INFO - Reading from file tmpfile_stdout 16:10:48 INFO - Current package versions: 16:10:48 INFO - argparse == 1.2.1 16:10:48 INFO - blessings == 1.6 16:10:48 INFO - blobuploader == 1.2.4 16:10:48 INFO - docopt == 0.6.1 16:10:48 INFO - manifestparser == 1.1 16:10:48 INFO - mozInstall == 1.12 16:10:48 INFO - mozcrash == 0.17 16:10:48 INFO - mozdebug == 0.1 16:10:48 INFO - mozdevice == 0.48 16:10:48 INFO - mozfile == 1.2 16:10:48 INFO - mozhttpd == 0.7 16:10:48 INFO - mozinfo == 0.9 16:10:48 INFO - mozleak == 0.1 16:10:48 INFO - mozlog == 3.2 16:10:48 INFO - moznetwork == 0.27 16:10:48 INFO - mozprocess == 0.22 16:10:48 INFO - mozprofile == 0.28 16:10:48 INFO - mozrunner == 6.11 16:10:48 INFO - mozscreenshot == 0.1 16:10:48 INFO - mozsystemmonitor == 0.3 16:10:48 INFO - moztest == 0.7 16:10:48 INFO - mozversion == 1.4 16:10:48 INFO - psutil == 3.1.1 16:10:48 INFO - requests == 1.2.3 16:10:48 INFO - wsgiref == 0.1.2 16:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:48 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')]} 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 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')]} 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:48 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 16:10:48 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 16:10:48 INFO - Using env: {'DISPLAY': ':0', 16:10:48 INFO - 'HOME': '/home/cltbld', 16:10:48 INFO - 'LANG': 'en_US.UTF-8', 16:10:48 INFO - 'LANGUAGE': 'en_US:en', 16:10:48 INFO - 'LOGNAME': 'cltbld', 16:10:48 INFO - 'MAIL': '/var/mail/cltbld', 16:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:48 INFO - 'MOZ_NO_REMOTE': '1', 16:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:48 INFO - 'NO_EM_RESTART': '1', 16:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:48 INFO - 'PWD': '/builds/slave/test', 16:10:48 INFO - 'SHELL': '/bin/bash', 16:10:48 INFO - 'SHLVL': '1', 16:10:48 INFO - 'TERM': 'linux', 16:10:48 INFO - 'TMOUT': '86400', 16:10:48 INFO - 'USER': 'cltbld', 16:10:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:48 INFO - '_': '/tools/buildbot/bin/python'} 16:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 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)) 16:10:48 INFO - Cleaning up... 16:10:48 INFO - Return code: 0 16:10:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:48 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')]} 16:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 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')]} 16:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:48 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 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10:48 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 16:10:48 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 16:10:48 INFO - Using env: {'DISPLAY': ':0', 16:10:48 INFO - 'HOME': '/home/cltbld', 16:10:48 INFO - 'LANG': 'en_US.UTF-8', 16:10:48 INFO - 'LANGUAGE': 'en_US:en', 16:10:48 INFO - 'LOGNAME': 'cltbld', 16:10:48 INFO - 'MAIL': '/var/mail/cltbld', 16:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:48 INFO - 'MOZ_NO_REMOTE': '1', 16:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:48 INFO - 'NO_EM_RESTART': '1', 16:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:48 INFO - 'PWD': '/builds/slave/test', 16:10:48 INFO - 'SHELL': '/bin/bash', 16:10:48 INFO - 'SHLVL': '1', 16:10:48 INFO - 'TERM': 'linux', 16:10:48 INFO - 'TMOUT': '86400', 16:10:48 INFO - 'USER': 'cltbld', 16:10:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:48 INFO - '_': '/tools/buildbot/bin/python'} 16:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:48 INFO - Downloading/unpacking jsonschema 16:10:48 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 16:10:48 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 16:10:48 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 16:10:48 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 16:10:48 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 16:10:48 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 16:10:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:50 INFO - Downloading/unpacking functools32 (from jsonschema) 16:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:50 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:50 INFO - warning: no files found matching '*.txt' 16:10:50 INFO - no previously-included directories found matching 'build' 16:10:50 INFO - no previously-included directories found matching 'dist' 16:10:50 INFO - no previously-included directories found matching '.git*' 16:10:50 INFO - Installing collected packages: jsonschema, functools32 16:10:50 INFO - Running setup.py install for functools32 16:10:51 INFO - warning: no files found matching '*.txt' 16:10:51 INFO - no previously-included directories found matching 'build' 16:10:51 INFO - no previously-included directories found matching 'dist' 16:10:51 INFO - no previously-included directories found matching '.git*' 16:10:51 INFO - Successfully installed jsonschema functools32 16:10:51 INFO - Cleaning up... 16:10:51 INFO - Return code: 0 16:10:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee70dd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ce770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, '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': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', '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 16:10: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', 'flake8'] in /builds/slave/test/build 16:10: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 flake8 16:10:51 INFO - Using env: {'DISPLAY': ':0', 16:10:51 INFO - 'HOME': '/home/cltbld', 16:10:51 INFO - 'LANG': 'en_US.UTF-8', 16:10:51 INFO - 'LANGUAGE': 'en_US:en', 16:10:51 INFO - 'LOGNAME': 'cltbld', 16:10:51 INFO - 'MAIL': '/var/mail/cltbld', 16:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:51 INFO - 'MOZ_NO_REMOTE': '1', 16:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:51 INFO - 'NO_EM_RESTART': '1', 16:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:51 INFO - 'PWD': '/builds/slave/test', 16:10:51 INFO - 'SHELL': '/bin/bash', 16:10:51 INFO - 'SHLVL': '1', 16:10:51 INFO - 'TERM': 'linux', 16:10:51 INFO - 'TMOUT': '86400', 16:10:51 INFO - 'USER': 'cltbld', 16:10:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:51 INFO - '_': '/tools/buildbot/bin/python'} 16:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:51 INFO - Downloading/unpacking flake8 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:10:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:10:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:53 INFO - no previously-included directories found matching 'docs/_build' 16:10:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:10:54 INFO - Running setup.py install for pep8 16:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:54 INFO - no previously-included directories found matching 'docs/_build' 16:10:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:10:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:10:54 INFO - Cleaning up... 16:10:54 INFO - Return code: 0 16:10:54 INFO - Running post-action listener: _resource_record_post_action 16:10:54 INFO - Running post-action listener: _start_resource_monitoring 16:10:54 INFO - Starting resource monitoring. 16:10:54 INFO - ##### 16:10:54 INFO - ##### Finished create-virtualenv step (success) 16:10:54 INFO - ##### 16:10:54 INFO - ##### 16:10:54 INFO - ##### Running install step. 16:10:54 INFO - ##### 16:10:54 INFO - Running pre-action listener: _resource_record_pre_action 16:10:54 INFO - Running main action method: install 16:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:54 INFO - Reading from file tmpfile_stdout 16:10:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:54 INFO - Reading from file tmpfile_stdout 16:10:54 INFO - Output received: 16:10:54 INFO - Usage: mozinstall [options] installer 16:10:54 INFO - Options: 16:10:54 INFO - -h, --help show this help message and exit 16:10:54 INFO - -d DEST, --destination=DEST 16:10:54 INFO - Directory to install application into. [default: 16:10:54 INFO - "/builds/slave/test"] 16:10:54 INFO - --app=APP Application being installed. [default: firefox] 16:10:54 INFO - mkdir: /builds/slave/test/build/application 16:10:54 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'] 16:10:54 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 16:11:10 INFO - Reading from file tmpfile_stdout 16:11:10 INFO - Output received: 16:11:10 INFO - /builds/slave/test/build/application/firefox/firefox 16:11:10 INFO - Running post-action listener: _resource_record_post_action 16:11:10 INFO - ##### 16:11:10 INFO - ##### Finished install step (success) 16:11:10 INFO - ##### 16:11:10 INFO - ##### 16:11:10 INFO - ##### Running run-tests step. 16:11:10 INFO - ##### 16:11:10 INFO - Running pre-action listener: _resource_record_pre_action 16:11:10 INFO - Running main action method: run_tests 16:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:11:10 INFO - Python 2.7.3 16:11:10 INFO - Return code: 0 16:11:10 INFO - grabbing minidump binary from tooltool 16:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255d9c0>, '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 0x255e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:11:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:11:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:11:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:11:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:11:10 INFO - Return code: 0 16:11:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:11:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:11:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:11:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:11:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:11:11 INFO - Return code: 0 16:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:11:11 INFO - Using env: {'DISPLAY': ':0', 16:11:11 INFO - 'HOME': '/home/cltbld', 16:11:11 INFO - 'LANG': 'en_US.UTF-8', 16:11:11 INFO - 'LANGUAGE': 'en_US:en', 16:11:11 INFO - 'LOGNAME': 'cltbld', 16:11:11 INFO - 'MAIL': '/var/mail/cltbld', 16:11:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:11:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:11 INFO - 'MOZ_NO_REMOTE': '1', 16:11:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:11:11 INFO - 'NO_EM_RESTART': '1', 16:11:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:11 INFO - 'PWD': '/builds/slave/test', 16:11:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:11:11 INFO - 'SHELL': '/bin/bash', 16:11:11 INFO - 'SHLVL': '1', 16:11:11 INFO - 'TERM': 'linux', 16:11:11 INFO - 'TMOUT': '86400', 16:11:11 INFO - 'USER': 'cltbld', 16:11:11 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331', 16:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:11 INFO - '_': '/tools/buildbot/bin/python'} 16:11:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:11:11 INFO - mozversion application_buildid: 20160520144634 16:11:11 INFO - mozversion application_changeset: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 16:11:11 INFO - mozversion application_display_name: Nightly 16:11:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:11:11 INFO - mozversion application_name: Firefox 16:11:11 INFO - mozversion application_remotingname: firefox 16:11:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:11:11 INFO - mozversion application_vendor: Mozilla 16:11:11 INFO - mozversion application_version: 49.0a1 16:11:11 INFO - mozversion platform_buildid: 20160520144634 16:11:11 INFO - mozversion platform_changeset: 30b83fcb0009b524cf3982a8aeb2bc0fc6d2d5b7 16:11:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:11:11 INFO - mozversion platform_version: 49.0a1 16:11:11 INFO - using testdate: 1463785871 16:11:11 INFO - actual date: 1463785871 16:11:11 INFO - starting webserver on 'localhost:39896' 16:11:11 INFO - SUITE-START | Running 2 tests 16:11:11 INFO - TEST-START | dromaeo_css 16:11:11 INFO - operating with platform_type : linux_ 16:11:11 INFO - Initialising browser for dromaeo_css test... 16:11:11 INFO - TEST-INFO | started process 3290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52TQ0b/profile http://localhost:39896/getInfo.html) 16:11:16 INFO - PROCESS | 3290 | 16:11:16 INFO - PROCESS | 3290 | (process:3359): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:11:17 INFO - PROCESS | 3290 | __metrics Screen width/height:1600/1200 16:11:17 INFO - PROCESS | 3290 | colorDepth:24 16:11:17 INFO - PROCESS | 3290 | Browser inner width/height: 1024/697 16:11:17 INFO - PROCESS | 3290 | __metrics 16:11:18 ERROR - PROCESS | 3290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:11:19 INFO - TEST-INFO | 3290: exit 0 16:11:19 INFO - Browser initialized. 16:11:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:19 INFO - TEST-INFO | started process 3410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52TQ0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:21 INFO - PROCESS | 3410 | 16:11:21 INFO - PROCESS | 3410 | (process:3469): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:11:31 INFO - PROCESS | 3410 | RSS: Main: 165875712 16:11:31 INFO - PROCESS | 3410 | 16:12:21 INFO - PROCESS | 3410 | 1463785941182 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:14:32 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39896/tests/dromaeo/cssquery-ext.html) 16:14:33 INFO - PROCESS | 3410 | RSS: Main: 167813120 16:14:33 INFO - PROCESS | 3410 | 16:17:35 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-ext.html (next: http://localhost:39896/tests/dromaeo/cssquery-jquery.html) 16:17:36 INFO - PROCESS | 3410 | RSS: Main: 166858752 16:17:36 INFO - PROCESS | 3410 | 16:20:38 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39896/tests/dromaeo/cssquery-mootools.html) 16:20:38 INFO - PROCESS | 3410 | RSS: Main: 168247296 16:20:38 INFO - PROCESS | 3410 | 16:23:40 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39896/tests/dromaeo/cssquery-prototype.html) 16:23:41 INFO - PROCESS | 3410 | RSS: Main: 165875712 16:23:41 INFO - PROCESS | 3410 | 16:26:44 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39896/tests/dromaeo/cssquery-yui.html) 16:26:44 INFO - PROCESS | 3410 | RSS: Main: 167088128 16:26:44 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | Cycle 1(1): loaded http://localhost:39896/tests/dromaeo/cssquery-yui.html (next: http://localhost:39896/tests/dromaeo/cssquery-dojo.html) 16:29:47 INFO - PROCESS | 3410 | RSS: Main: 168812544 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | __start_tp_report 16:29:47 INFO - PROCESS | 3410 | _x_x_mozilla_page_load 16:29:47 INFO - PROCESS | 3410 | _x_x_mozilla_page_load_details 16:29:47 INFO - PROCESS | 3410 | |i|pagename|runs| 16:29:47 INFO - PROCESS | 3410 | |0;dojo.html;2677.6920654124774;2722.550779121445;2726.4683386739594;2734.261749327682;2759.9999999999986;4714.127886341025;4745.193317136086;4763.166445871976;4841.007593443344;4843.612510999121;4676.883077923045;4765.809367625291;4787.35370724952;4788.664793464459;4811.951880481203;4490.41624588803;4529.728216307032;4583.9312410313705;4584.541545845405;4627.814887404516;452.5324164480278;4384.517703052662;4389.100234451929;4489.595936365727;4513.887152821189;4431.667624928144;4432.778361081933;4457.77711114443;4463.4866990296205;4501.774911254441;4380.2115619188535;4467.5755803198645;4485.192665320241;4491.595756381941;4500.707454015511;4404.493483249404;4427.158839820424;4456.821727130911;4492.3710680504755;4497.370368148462;4703.764811759398;4715.41057367829;4760.690555113941;4771.6665505677265;4799.712017278975;4911.238757992517;5108.872278193037;5160.948390516084;5170.844874653766;5173.767180476888;5203.7398130093725;5218.269442278084;5219.8434046978655;5222.060029194743;5252.65857719247;4848.466668666444;4854.611631069506;4866.245731911559;4872.0499502597;4923.335349727812;5100.948990510047;5256.106461901486;5305.60207984395;5312.681239125664;5348.224507446476;5072.492750724898;5077.543021128116;5084.898302033938;5087.2114822201875;5100.336956195671;5163.173892177234;5168.664036837594;5168.793248270103;5175.327207463081;5215.061288967946;4932.112219800399;5037.823676171316;5067.5185857343495;5096.05722941257;5165.276861239429;4783.1868582341085;5035.992801439654;5063.772130254148;5065.6200784941275;5117.41149767774;4367.912641747147;4415.381846541487;4424.955750442518;4430.933535996963;4459.888502787457;3732.5147730794824;3832.597577254348;3838.2899163654256;3862.517185351831;3882.107115363482;4445.444319460067;4445.666575006822;4453.643708503312;4464.084862603158;4464.99537604043;5212.582993360522;5224.738763061831;5225.059489291888;5233.267342572043;5247.921281180786;4261.339492378686;4315.201687687788;4390.165868484977;4400.22995975703;4418.248897687401;4570.520095390003;4571.542845715402;4589.54104589545;4615.100055489214;4633.351330813689;4704.341392205162;4765.904681906342;4776.713397196179;4794.304825800239;4812.8796780080775;5126.384833819965;5170.767315470737;5178.559822415137;5183.144781111075;5202.089634313904;4793.496682848251;4832.782524786323;4837.153498137742;4837.250226214942;4876.756162191948;4913.43495498008;5063.063333283354;5069.062223488666;5115.130427827353;5162.6902385856965;5161.948380516297;5184.766685499237;5205.193195054772;5213.009528189632;5241.475852414728;5045.4450010498085;5054.267131265872;5054.974725126351;5057.039162559102;5116.513931176682;4898.2652602109965;4900.485449027943;4951;5019.899602008012;5059.5952323814745;4665.230237010991;4800.903981920412;4816.783244754065;4874.756262186947;4916.557509824133;5040.092783299041;5043.4956504349275;5051.2423136529815;5053.11570475158;5094.2867998479505;4788.928166077581;4881.51184881509;4952.133376659142;4959.925601116059;4965.553100220853 16:29:47 INFO - PROCESS | 3410 | |1;ext.html;563.3324510455111;588.2176704982373;590.7371219807186;597.5548216578646;618.2241287184582;39944;41193.7940310298;41531;41545.584544154546;45286.77356613212;40729.59270407295;41872.37191442131;41903.58096419035;41908.16183676325;41919.37120943188;7702.268284512977;7748.108967468729;7844.529328240295;7850.764477065697;7860.646270917822;7628.50414723044;7749.108852481952;7778.80552986177;7785;7795.493292935969;7808.297253247207;7808.921910780905;7812.453128281023;7820.687172513092;7831.686732530692;7778.6110694465615;7788.727394541163;7801.882971755428;7802.102758182825;7835.255650713173;7745.225477452266;7771.650275737606;7832.099308579529;7842.803929901798;7848.097468791105;39250.60749392498;39557.80221098876;39564.80217598922;39637.40543891844;39655;3026.056060007883;3171.1913462067255;3176.5833017304913;3439.1917899293644;3841.3661745811905;29381.85309073441;29704.40591188186;29792.404151917057;29895.10314690563;30105.548416773767;3482.495038219444;3524.1542029912634;3537.876174333886;3611.4402267648557;3711.3319602471543;251806;253234;253449.99999999817;254092;254569;29208.561871571943;54387;54711.45288547143;54956.450435495135;55073.724631376586;34674.826625867216;34823;34834.47748283778;34841;34955.30089398198;11171.38557379352;11199.384033878216;11218.102551795837;11238.213325067167;11261.21171517986;9440.763980900396;9466.337356384987;9503.66737164196;9510.048995100573;9511.714648560554;8060.274575288135;8073.798155046171;8081.4747041442115;8121.5533145677555;8127.634256458474;3116.8597413116463;3182.7612929030415;3197.1048106530206;3243.302689921631;3243.41618508666;876.2201640539924;979.6130528441225;996.7637540453075;1015.7968406318765;1018.4042335233971;28641.856790715912;28785.280367990967;28922.421551568852;29180.597858978505;29370.265743356587;965.560669895196;997.6059456514781;1044.3864229765031;1078.8058149533003;1079.1043433949803;15086.924565377103;15356.310805811352;15490.9225453872;15628.140452275235;15717.371305147895;389334;392262;394008;394446;394465;50108.74945625249;50387.24419133716;50414.747926260134;50858.491415086115;51029.23456148161;1165.1377980294521;1185.247367921376;1187.0503597122267;1198.8261702053153;1204.175140029083;27494.312642183304;28316.847384383545;28424.86300547955;28580.85709571439;28651.5702264462;44590.55409445864;44615.776921116485;44698.77650611726;44846.77576612096;44882;309293;310712;312627;313693;313760;25653.87173064123;25916.09293674712;26182.345441363355;26313.73686263113;26427.60358594661;42575.148497029266;42946.35580466358;43078.569214307456;43078.78460607677;43385.3492197611;36155.45766813447;36873.262534749694;37448.438273425374;37523.43714844225;37698.43452348272;36500.269994599425;37202.8139859299;37258;37719;37731.62268377281;35588;36448.63551364453;36455.635443646286;36483.635163648025;36541.81729091337;31592.684073159893;33879.32241355209;34043.82978085094;34066.489002665476;34218.14454638654;25323.87338063298;25781.484370312864;25798.61302080433;25941.351466213495;26096 16:29:47 INFO - PROCESS | 3410 | |2;jquery.html;342.9982850085749;347.2464751489268;354.59398988158557;355.90390594539474;362.7461668830589;16477;16625;17485.388011419604;17516.211770470345;17591.82408175918;16026;16595.336186552555;17355.219015144317;17356.739648905277;17363.913180434112;4985.800567977277;5110.437851836295;5167.095758242312;5167.509086636783;5171.3535808024;3704.9629503704887;5099.770510327045;5681.091025435931;5985.730642121115;6031.788887388942;6016.548758843104;6055.0311950088;6075;6093.756249750005;6101.908471372933;6335.3981371769605;6618.867622647568;6719.361660642256;6729.1924969003785;6733.4276586490205;6541.6075035498025;6960.547564408297;6991.7902462926195;7004.299570043006;7033.859322813515;22001;22537;22885.31344059664;23800.40498987522;23805.761942380526;1969.931052413173;2029.8173164415125;2069.265410779182;2148.892555372225;2236.2396785092983;14025.579232623038;14266.286685665778;14296.642583935485;14759.852401475955;15046.849531504655;1936.66108431024;1942.5823447958758;1986.523234423728;2005.5788284460282;2015.8689685170564;61255.999999999556;78598.6070069646;79049.60475197587;79594;80212;14455.398737356303;15637.68724625501;16521.91739041321;16706.49880503587;16794.748078778826;29338.266543336587;29443.558346624817;29632.407351853275;29792.553111703342;29806.55290170649;7573.431992600577;7780.84438311242;7782.533048017137;7803.375729941591;7882.763517094496;6122.479589234965;6225.688715564203;6303.810885673437;6309.716062777186;6319.936800631935;8350.79123021917;8415.747527574182;8646.654133834576;8738.737837864874;8744.300455963508;1553.5106441471125;1620.7244768389403;1627.6826018926195;1655.793025871766;3209.9197520062185;396.472691320543;401.8231977929702;409.7787194914713;853.1340689200466;858.926991205742;10788;10984.176186785864;11120;11158.944205278922;11200.439978001068;415.38730372700024;421.57842157842157;428.52647824154485;431.49515067370623;432.6517153691246;5738;5911.497522710618;5944.108383742387;5969.343372229051;6091.299500557404;397415;401424;405772;406350;417433;52340.214896776575;58722;85344.57327713321;87137.56431217803;87805.56097219473;417.77440182301825;424.6920982287817;426.413681188366;427.03064044618543;427.11373899158747;10071.446070465901;10074.899251007397;10160.491975401053;10398.376097434179;10419.895801042196;35661.64338356687;36779.44830827486;37207.25585488329;37315;37582;52752.208716870045;53029;53688.73155634353;53808.19287710766;53903.73048134891;7829.45193836426;7910.802229944297;7912.881306780518;8025.23760242776;8033.6786528538205;8846.646134154562;10819.416820835326;12078.879211207775;12265.632031039084;12393.008559315052;4666.626669866335;10059.849102263326;10198.898011019795;10311.432871192157;10395.688129356131;10152.137068349273;10269.281150319406;10485.37087774736;10681.412522311348;10747.301425407324;10134.138598219233;10439.164866810788;10680;10778.676639700821;10979.670609881716;7342.339189472973;7682.692692292246;7803.765887023398;7932.0878099017045;7939.0870049945;7939.325157361689;8898.911010889808;10096;10164.491775411348;10210.984694434203 16:29:47 INFO - PROCESS | 3410 | |3;mootools.html;1404.8876089912806;1448.398914450503;1559.5399357189629;1724.5429961060313;1740.5822602575386;6714.328567143283;7397.075365579302;7547.132079810824;7998.400119991002;8000.679972801088;7460.0674915635545;7685.884711729329;7694.345980591656;7725.92274077259;7755.069391672993;2204.8787316697535;2260.0394832196253;2261.739899911515;2262.6266666000092;2263.7283525976823;2197.8681279123225;2229.843910926236;2241.8879056047213;2245.7754224577493;2247.539254452833;2165.28545579959;2172.022589834573;2183.366823621148;2216.7783221677782;2251.448395143192;2121.9999999999845;2132.1897678882083;2138.347803919804;2144.6032483990434;2151.4513798981316;1931.719900614403;1949.093671442786;1950.5221220800852;2117.4282943605294;2119.088791819517;7650.617469126521;7678.308952194274;7686.154523002465;7720.613969301568;7745.380369570477;4329.025969156946;4394.099209662044;4403.6256918162;4413.514513403523;4436.622887054604;2576.974230257711;2611.7518835710575;2812.7187281271913;2823.4917714811327;2837.4325134973087;821.3593397150232;858.4334339336008;863.2921004776086;868.6525389844113;881.5019513974584;10685.519151638195;10704.46477676121;10711.946440267826;10744.247902646817;10775.245732798707;4178.1643671265865;4318.589733975267;4331.5884990925815;4332.393464914914;4355.477342718831;9091.772705682411;9100.499472528942;9108.362414631045;9116.954415227881;9126.315526335551;4516.096780643885;4518.8418405356315;4531.954680453219;4543.477500087466;4548.113117942035;3542.3446662367546;3879.84480620772;3998.540167880673;4042.8989275268355;4067.349224124126;3618.945715814265;3769.0200547857753;3814.0846196913094;3820.656140947328;3834;1187.7017970227637;1204.5302332090491;1219.823125646794;1222.407132540717;1229.9815502767465;791.2008871040176;904.5838914099456;906.51501446727;907.8002839375326;918.6600957645713;5246.557196770842;5306.204069389622;5318.175682769177;5401.02781499326;5449.12813949774;421.74484436915225;423.5277665403053;426.6757264479018;428.96568274537964;435.46002956334553;3484.7306165599384;3530.5763308403157;3540.504329393887;3570.910727231788;3596.82015899204;9565.426074435556;9824.65613703517;9840.950795245977;9847.310688251753;9908;9742.61029558824;9756.365836220622;9777.853332200022;9802.411855288705;9853.40879547215;7377.963110184414;7507.061617297947;7518.173000969889;7525.736599219001;7530.096388433313;5180.222966555047;5267.868303292448;5302.072137376021;5380.0584897641975;5413.512783849473;8980.236679882284;9014.729558113268;9017.368784185306;9271.258299335903;9298.767530811783;9028.954855225682;9161.267098632226;9231.215346695606;9247.167754902091;9331.113544213289;5611.2424822650055;6419.550631455753;6595.01074838778;6684.4318232950745;6728.495362847708;7570.886436703344;7683.9231607683205;7693.153753087044;7720.53676779395;7724.034495688039;6771.6614169292325;6877.415419689382;6948.652567371712;7024.683889225099;7072.292770723092;6786.830329241809;6787.524873259022;6853.143357080365;6898.586084834926;7042.366187043191;6126.23422072241;6152.384761523991;6180.783672571439;6209.410106039919;6256.249250090018;4659.906801864012;4769.523047695203;4841.782119804547;4928.852134435972;4944.035912996931;4753.714777113384;4813.422389313305;4834.758262086952;4904.117258893433;4910.45984941649 16:29:47 INFO - PROCESS | 3410 | |4;prototype.html;283.95456726923686;285.41489945611494;285.59730779600767;289.9333153374724;293.6945576600335;4995.150824359858;5049.873753156173;5052.418971818242;5054.620903432239;5063.316452278941;4972.32873562069;4976.552110310071;4984.526469985355;4988;4992.201247800353;3748.4002559590404;3796.126890815114;3940.251352243079;3946.8026598669953;3955.3078211312904;3946.2304850554156;3952.9209415811665;3959.2477429288488;3981.542122655903;3984.402339649047;3939.606039396052;3968.1865217630316;3984.8443951254103;3994.2410941920944;3999.4800675912093;3803.7067397084847;3915.9216815663526;3930.508686414198;3982.4424580558743;3991.481107456041;3423.8358957954415;3428.8226975870252;3432.467967465047;3435.986384016721;3458;4830.227163653799;4832.106060378841;4844.297576851337;4866.926996095061;4875.219964805614;4374.278244089754;4406.5593440656;4426.7343959362215;4450.933236001462;4462.330650402466;5262.815801446931;5271.288376069258;5273.683578985273;5287;5299.364076310867;3793.715471339633;3798.1264309209037;3800.7575530437175;3808.733388662795;3835.5589107252745;5429.83710488682;5556.16657501374;5574.693391863446;5576.693281869496;5597.80407685729;3885.708571857122;3889.0666240102737;3899.473571067926;3903.941440878389;3910.8631197908508;3982.323005089084;3992.580779018161;3995.1809878975323;3998.260321840469;4001.4998125234347;4448.177087238806;4469.687121901436;4482.125985432809;4486.327050942385;4513.097380523908;5039.823606173766;5246.186841039645;5287.867803304871;5332.626716129834;5339.679619222859;1319.4985905356095;1327.8340207474066;1333.7596035686904;1345.663584103974;1352.2900477249325;828.718235799831;829.2081062585216;846.957652117404;866.8699695045793;872.6247713483136;4506.679060283891;4609.3086037094035;4625.259958406638;4630.513796051433;4635.953640463552;5491.478309560585;5492.588055895823;5511.862203444946;5529.419410961871;5538.196961440569;4421.314696222091;4591.816327346935;4624.5144259852905;4635.443746750411;4644.860654180313;2890.783191260664;2905.9273518162213;2923.9415211695646;2946.9705302947127;2960.985195074011;5062.949370506248;5078.822241221539;5086.4659210783075;5098.260752190986;5113.233015047773;5445.428230035868;5515.172724091338;5570.442955704478;5577.3028371453565;5598.524125449382;5076.289319495348;5085.466026067357;5100.26046223303;5105;5105.2342148678;5424.810131645373;5427.267318912054;5439.129739241703;5455.781768729206;5489.972550137224;5196.350456192976;5284.841454756363;5326.733663316896;5349;5362.605722512097;5053.620978426559;5054.444011158696;5071.721055341992;5079.3904731430985;5084.694918304914;3705.6479634434686;3723.2739615774663;3736.58897521267;3738.3271011217153;3745.9063523412133;5332.68003919766;5434.782608695607;5469.070258056219;5471.261379713687;5498.532624726943;5330.520253177233;5334.799120527808;5336.665833541615;5338.572914166935;5355.384130824849;5248.448912864247;5263.499902527761;5318.962802253678;5332.120200166929;5344.893102138013;4910.705357678551;5187.19598462239;5192.506711862367;5194.558462530727;5201.947980520298;5014.749262536931;5115.18157094863;5200.531952124327;5210.879660872931;5261.71088083422;5130.358705161855;5169.802833795547;5173.22401639757;5204.2974198484235;5255.159174532057 16:29:47 INFO - PROCESS | 3410 | |5;yui.html;726.6584705188561;755.4938191411753;770.4337312075623;773.9883901741479;781.1290411191524;12890.162139460941;13348.933255333723;13359.93320033401;13765.174089554634;13794.793078103836;14470.5658830235;14477.85522144781;14486.710265794678;14503.05730127541;14543.12741235524;637.4422380417135;778.758584838699;793.2900054451262;795.3200013988044;796.3867821777228;790.1269097647104;793.5754371411296;794.1978601612356;795.3319211862034;796.024869534821;831.7712629027036;837.1670188162786;839.559231403515;839.6851180807197;840.5545061117617;828.0849661124431;835.9623816928253;836.1262480707675;836.1805430677939;836.2515548584045;607.3349682098095;609.740860134441;610.3133974278936;610.523791442671;614.7940439952621;13287.933560332232;13370.13094148887;13373.598792036255;13437.798433023512;13447.32763361828;12084.335361555111;12370.876291237153;12688.936555317165;12699.174553653984;13018.218906865619;9852.458114803683;10032.197424206046;10075.34510256831;10319.122874555596;10342.120919721832;3279.540864279003;3332.1836150143126;3349.1961929137074;3351.3632409842053;3359.227377703142;51353.229701554505;51662.48337516614;51728.22407663851;51869;52728.736356317975;9993.250506212064;10062.345947513388;10068.345557538736;10081.344712593658;10123.088921997056;17844.55388615295;17915.37296194627;17986.820131798515;18031.368902088365;18439.631207375776;6460.224773027173;6481.643509606923;6595.142631457879;6599.175103112111;6838.863222735517;3665.248624032067;3702.9444558331647;3760.9435858462143;3779.6787273082095;3822.57951625321;2788.2750484874077;2873.7126287371098;2890.956635650467;2895.102518219359;2906.3606006678497;509.9490050994945;517.0744367582062;519.6336582709181;520.1547485336329;520.5809323494548;442.51323544101876;449.1488629047936;481.2588613535187;489.41026063593284;540.5513423858267;8213.54825484604;8399.874001889977;8406.159384061668;8608.440451370641;8735.912640873637;523.6727045596502;551.7241379310345;591.349515532919;614.1279383275759;618.8545691762432;3709.9814500927323;3795.772253664789;3828.7319887608155;3830.9398273083957;3872.6127387261613;55771.72114139403;56018.439815602134;56326;56698.71650641803;57128;51964.48035519596;52450.47549524532;53114.46885531172;53307;53378;46184.53815461802;46321;46567;46737.29894051592;47038.29442558364;7700.4224683150105;7761.92238077612;7853.136155023057;7858.057033155829;7991.200879911962;31001;31232.68767312298;31273.06180814579;31682.524762129047;31747.84126079355;37985.4302185473;41386.58613413948;41499.58500415078;41832.163356733305;41850.58149418467;8944.105589441004;9247.445153290824;9476;9546.379485333431;9562.521873906417;10537.367757934548;10721.731956701145;10728;10883.23817332779;10925.508352124014;9911.058449447291;9961;9989.450580217866;10035.29752917318;10039.247056470647;10120.190384769054;10291.639792607222;10296.382217067;10403.011713887168;10405.531751071372;9588.66439674608;9700.417974921527;9719.076687714656;9827.262955278526;9849.458279794393;8071.869267138332;8082.313003394777;8157.79605509867;8467.57662116904;8830.95584522099;8793.736187914374;8878.51168185756;8899.73300800977;8951.328650351119;8951.462912225288 16:29:47 INFO - PROCESS | 3410 | __end_tp_report 16:29:47 INFO - PROCESS | 3410 | __start_cc_report 16:29:47 INFO - PROCESS | 3410 | _x_x_mozilla_cycle_collect,357 16:29:47 INFO - PROCESS | 3410 | __end_cc_report 16:29:47 INFO - PROCESS | 3410 | __startTimestamp1463786987415__endTimestamp 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | ------- Summary: start ------- 16:29:47 INFO - PROCESS | 3410 | Number of tests: 6 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#0] dojo.html Cycles:165 Average:4731.94 Median:4841.01 stddev:593.17 (12.3%) stddev-sans-first:572.68 16:29:47 INFO - PROCESS | 3410 | Values: 2677.7 2722.6 2726.5 2734.3 2760.0 4714.1 4745.2 4763.2 4841.0 4843.6 4676.9 4765.8 4787.4 4788.7 4812.0 4490.4 4529.7 4583.9 4584.5 4627.8 452.5 4384.5 4389.1 4489.6 4513.9 4431.7 4432.8 4457.8 4463.5 4501.8 4380.2 4467.6 4485.2 4491.6 4500.7 4404.5 4427.2 4456.8 4492.4 4497.4 4703.8 4715.4 4760.7 4771.7 4799.7 4911.2 5108.9 5160.9 5170.8 5173.8 5203.7 5218.3 5219.8 5222.1 5252.7 4848.5 4854.6 4866.2 4872.0 4923.3 5100.9 5256.1 5305.6 5312.7 5348.2 5072.5 5077.5 5084.9 5087.2 5100.3 5163.2 5168.7 5168.8 5175.3 5215.1 4932.1 5037.8 5067.5 5096.1 5165.3 4783.2 5036.0 5063.8 5065.6 5117.4 4367.9 4415.4 4425.0 4430.9 4459.9 3732.5 3832.6 3838.3 3862.5 3882.1 4445.4 4445.7 4453.6 4464.1 4465.0 5212.6 5224.7 5225.1 5233.3 5247.9 4261.3 4315.2 4390.2 4400.2 4418.2 4570.5 4571.5 4589.5 4615.1 4633.4 4704.3 4765.9 4776.7 4794.3 4812.9 5126.4 5170.8 5178.6 5183.1 5202.1 4793.5 4832.8 4837.2 4837.3 4876.8 4913.4 5063.1 5069.1 5115.1 5162.7 5161.9 5184.8 5205.2 5213.0 5241.5 5045.4 5054.3 5055.0 5057.0 5116.5 4898.3 4900.5 4951.0 5019.9 5059.6 4665.2 4800.9 4816.8 4874.8 4916.6 5040.1 5043.5 5051.2 5053.1 5094.3 4788.9 4881.5 4952.1 4959.9 4965.6 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#1] ext.html Cycles:180 Average:46793.99 Median:37485.94 stddev:85602.37 (228.4%) stddev-sans-first:85772.13 16:29:47 INFO - PROCESS | 3410 | Values: 563.3 588.2 590.7 597.6 618.2 39944.0 41193.8 41531.0 41545.6 45286.8 40729.6 41872.4 41903.6 41908.2 41919.4 7702.3 7748.1 7844.5 7850.8 7860.6 7628.5 7749.1 7778.8 7785.0 7795.5 7808.3 7808.9 7812.5 7820.7 7831.7 7778.6 7788.7 7801.9 7802.1 7835.3 7745.2 7771.7 7832.1 7842.8 7848.1 39250.6 39557.8 39564.8 39637.4 39655.0 3026.1 3171.2 3176.6 3439.2 3841.4 29381.9 29704.4 29792.4 29895.1 30105.5 3482.5 3524.2 3537.9 3611.4 3711.3 251806.0 253234.0 253450.0 254092.0 254569.0 29208.6 54387.0 54711.5 54956.5 55073.7 34674.8 34823.0 34834.5 34841.0 34955.3 11171.4 11199.4 11218.1 11238.2 11261.2 9440.8 9466.3 9503.7 9510.0 9511.7 8060.3 8073.8 8081.5 8121.6 8127.6 3116.9 3182.8 3197.1 3243.3 3243.4 876.2 979.6 996.8 1015.8 1018.4 28641.9 28785.3 28922.4 29180.6 29370.3 965.6 997.6 1044.4 1078.8 1079.1 15086.9 15356.3 15490.9 15628.1 15717.4 389334.0 392262.0 394008.0 394446.0 394465.0 50108.7 50387.2 50414.7 50858.5 51029.2 1165.1 1185.2 1187.1 1198.8 1204.2 27494.3 28316.8 28424.9 28580.9 28651.6 44590.6 44615.8 44698.8 44846.8 44882.0 309293.0 310712.0 312627.0 313693.0 313760.0 25653.9 25916.1 26182.3 26313.7 26427.6 42575.1 42946.4 43078.6 43078.8 43385.3 36155.5 36873.3 37448.4 37523.4 37698.4 36500.3 37202.8 37258.0 37719.0 37731.6 35588.0 36448.6 36455.6 36483.6 36541.8 31592.7 33879.3 34043.8 34066.5 34218.1 25323.9 25781.5 25798.6 25941.4 26096.0 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#2] jquery.html Cycles:180 Average:25485.15 Median:403598.00 stddev:67007.20 (16.6%) stddev-sans-first:67168.58 16:29:47 INFO - PROCESS | 3410 | Values: 343.0 347.2 354.6 355.9 362.7 16477.0 16625.0 17485.4 17516.2 17591.8 16026.0 16595.3 17355.2 17356.7 17363.9 4985.8 5110.4 5167.1 5167.5 5171.4 3705.0 5099.8 5681.1 5985.7 6031.8 6016.5 6055.0 6075.0 6093.8 6101.9 6335.4 6618.9 6719.4 6729.2 6733.4 6541.6 6960.5 6991.8 7004.3 7033.9 22001.0 22537.0 22885.3 23800.4 23805.8 1969.9 2029.8 2069.3 2148.9 2236.2 14025.6 14266.3 14296.6 14759.9 15046.8 1936.7 1942.6 1986.5 2005.6 2015.9 61256.0 78598.6 79049.6 79594.0 80212.0 14455.4 15637.7 16521.9 16706.5 16794.7 29338.3 29443.6 29632.4 29792.6 29806.6 7573.4 7780.8 7782.5 7803.4 7882.8 6122.5 6225.7 6303.8 6309.7 6319.9 8350.8 8415.7 8646.7 8738.7 8744.3 1553.5 1620.7 1627.7 1655.8 3209.9 396.5 401.8 409.8 853.1 858.9 10788.0 10984.2 11120.0 11158.9 11200.4 415.4 421.6 428.5 431.5 432.7 5738.0 5911.5 5944.1 5969.3 6091.3 397415.0 401424.0 405772.0 406350.0 417433.0 52340.2 58722.0 85344.6 87137.6 87805.6 417.8 424.7 426.4 427.0 427.1 10071.4 10074.9 10160.5 10398.4 10419.9 35661.6 36779.4 37207.3 37315.0 37582.0 52752.2 53029.0 53688.7 53808.2 53903.7 7829.5 7910.8 7912.9 8025.2 8033.7 8846.6 10819.4 12078.9 12265.6 12393.0 4666.6 10059.8 10198.9 10311.4 10395.7 10152.1 10269.3 10485.4 10681.4 10747.3 10134.1 10439.2 10680.0 10778.7 10979.7 7342.3 7682.7 7803.8 7932.1 7939.1 7939.3 8898.9 10096.0 10164.5 10211.0 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#3] mootools.html Cycles:180 Average:5152.88 Median:5213.39 stddev:2929.71 (56.2%) stddev-sans-first:2924.39 16:29:47 INFO - PROCESS | 3410 | Values: 1404.9 1448.4 1559.5 1724.5 1740.6 6714.3 7397.1 7547.1 7998.4 8000.7 7460.1 7685.9 7694.3 7725.9 7755.1 2204.9 2260.0 2261.7 2262.6 2263.7 2197.9 2229.8 2241.9 2245.8 2247.5 2165.3 2172.0 2183.4 2216.8 2251.4 2122.0 2132.2 2138.3 2144.6 2151.5 1931.7 1949.1 1950.5 2117.4 2119.1 7650.6 7678.3 7686.2 7720.6 7745.4 4329.0 4394.1 4403.6 4413.5 4436.6 2577.0 2611.8 2812.7 2823.5 2837.4 821.4 858.4 863.3 868.7 881.5 10685.5 10704.5 10711.9 10744.2 10775.2 4178.2 4318.6 4331.6 4332.4 4355.5 9091.8 9100.5 9108.4 9117.0 9126.3 4516.1 4518.8 4532.0 4543.5 4548.1 3542.3 3879.8 3998.5 4042.9 4067.3 3618.9 3769.0 3814.1 3820.7 3834.0 1187.7 1204.5 1219.8 1222.4 1230.0 791.2 904.6 906.5 907.8 918.7 5246.6 5306.2 5318.2 5401.0 5449.1 421.7 423.5 426.7 429.0 435.5 3484.7 3530.6 3540.5 3570.9 3596.8 9565.4 9824.7 9841.0 9847.3 9908.0 9742.6 9756.4 9777.9 9802.4 9853.4 7378.0 7507.1 7518.2 7525.7 7530.1 5180.2 5267.9 5302.1 5380.1 5413.5 8980.2 9014.7 9017.4 9271.3 9298.8 9029.0 9161.3 9231.2 9247.2 9331.1 5611.2 6419.6 6595.0 6684.4 6728.5 7570.9 7683.9 7693.2 7720.5 7724.0 6771.7 6877.4 6948.7 7024.7 7072.3 6786.8 6787.5 6853.1 6898.6 7042.4 6126.2 6152.4 6180.8 6209.4 6256.2 4659.9 4769.5 4841.8 4928.9 4944.0 4753.7 4813.4 4834.8 4904.1 4910.5 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#4] prototype.html Cycles:180 Average:4379.73 Median:4993.68 stddev:1277.05 (25.6%) stddev-sans-first:1243.08 16:29:47 INFO - PROCESS | 3410 | Values: 284.0 285.4 285.6 289.9 293.7 4995.2 5049.9 5052.4 5054.6 5063.3 4972.3 4976.6 4984.5 4988.0 4992.2 3748.4 3796.1 3940.3 3946.8 3955.3 3946.2 3952.9 3959.2 3981.5 3984.4 3939.6 3968.2 3984.8 3994.2 3999.5 3803.7 3915.9 3930.5 3982.4 3991.5 3423.8 3428.8 3432.5 3436.0 3458.0 4830.2 4832.1 4844.3 4866.9 4875.2 4374.3 4406.6 4426.7 4450.9 4462.3 5262.8 5271.3 5273.7 5287.0 5299.4 3793.7 3798.1 3800.8 3808.7 3835.6 5429.8 5556.2 5574.7 5576.7 5597.8 3885.7 3889.1 3899.5 3903.9 3910.9 3982.3 3992.6 3995.2 3998.3 4001.5 4448.2 4469.7 4482.1 4486.3 4513.1 5039.8 5246.2 5287.9 5332.6 5339.7 1319.5 1327.8 1333.8 1345.7 1352.3 828.7 829.2 847.0 866.9 872.6 4506.7 4609.3 4625.3 4630.5 4636.0 5491.5 5492.6 5511.9 5529.4 5538.2 4421.3 4591.8 4624.5 4635.4 4644.9 2890.8 2905.9 2923.9 2947.0 2961.0 5062.9 5078.8 5086.5 5098.3 5113.2 5445.4 5515.2 5570.4 5577.3 5598.5 5076.3 5085.5 5100.3 5105.0 5105.2 5424.8 5427.3 5439.1 5455.8 5490.0 5196.4 5284.8 5326.7 5349.0 5362.6 5053.6 5054.4 5071.7 5079.4 5084.7 3705.6 3723.3 3736.6 3738.3 3745.9 5332.7 5434.8 5469.1 5471.3 5498.5 5330.5 5334.8 5336.7 5338.6 5355.4 5248.4 5263.5 5319.0 5332.1 5344.9 4910.7 5187.2 5192.5 5194.6 5201.9 5014.7 5115.2 5200.5 5210.9 5261.7 5130.4 5169.8 5173.2 5204.3 5255.2 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | [#5] yui.html Cycles:180 Average:13396.67 Median:26242.06 stddev:16005.48 (61.0%) stddev-sans-first:16022.10 16:29:47 INFO - PROCESS | 3410 | Values: 726.7 755.5 770.4 774.0 781.1 12890.2 13348.9 13359.9 13765.2 13794.8 14470.6 14477.9 14486.7 14503.1 14543.1 637.4 778.8 793.3 795.3 796.4 790.1 793.6 794.2 795.3 796.0 831.8 837.2 839.6 839.7 840.6 828.1 836.0 836.1 836.2 836.3 607.3 609.7 610.3 610.5 614.8 13287.9 13370.1 13373.6 13437.8 13447.3 12084.3 12370.9 12688.9 12699.2 13018.2 9852.5 10032.2 10075.3 10319.1 10342.1 3279.5 3332.2 3349.2 3351.4 3359.2 51353.2 51662.5 51728.2 51869.0 52728.7 9993.3 10062.3 10068.3 10081.3 10123.1 17844.6 17915.4 17986.8 18031.4 18439.6 6460.2 6481.6 6595.1 6599.2 6838.9 3665.2 3702.9 3760.9 3779.7 3822.6 2788.3 2873.7 2891.0 2895.1 2906.4 509.9 517.1 519.6 520.2 520.6 442.5 449.1 481.3 489.4 540.6 8213.5 8399.9 8406.2 8608.4 8735.9 523.7 551.7 591.3 614.1 618.9 3710.0 3795.8 3828.7 3830.9 3872.6 55771.7 56018.4 56326.0 56698.7 57128.0 51964.5 52450.5 53114.5 53307.0 53378.0 46184.5 46321.0 46567.0 46737.3 47038.3 7700.4 7761.9 7853.1 7858.1 7991.2 31001.0 31232.7 31273.1 31682.5 31747.8 37985.4 41386.6 41499.6 41832.2 41850.6 8944.1 9247.4 9476.0 9546.4 9562.5 10537.4 10721.7 10728.0 10883.2 10925.5 9911.1 9961.0 9989.5 10035.3 10039.2 10120.2 10291.6 10296.4 10403.0 10405.5 9588.7 9700.4 9719.1 9827.3 9849.5 8071.9 8082.3 8157.8 8467.6 8831.0 8793.7 8878.5 8899.7 8951.3 8951.5 16:29:47 INFO - PROCESS | 3410 | -------- Summary: end -------- 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2C0042,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | 16:29:47 INFO - PROCESS | 3410 | ###!!! [Child][OnMaybeDequeueOne] Error: Channel closing: too late to send/recv, messages will be lost 16:29:47 INFO - PROCESS | 3410 | 16:29:48 INFO - TEST-INFO | 3410: exit 0 16:29:48 INFO - TEST-OK | dromaeo_css | took 1116594ms 16:29:48 INFO - TEST-START | kraken 16:29:48 INFO - operating with platform_type : linux_ 16:29:48 INFO - Initialising browser for kraken test... 16:29:48 INFO - TEST-INFO | started process 3644 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9u3Oti/profile http://localhost:39896/getInfo.html) 16:29:52 INFO - PROCESS | 3644 | 16:29:52 INFO - PROCESS | 3644 | (process:3711): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:29:53 INFO - PROCESS | 3644 | __metrics Screen width/height:1600/1200 16:29:53 INFO - PROCESS | 3644 | colorDepth:24 16:29:53 INFO - PROCESS | 3644 | Browser inner width/height: 1024/697 16:29:53 INFO - PROCESS | 3644 | __metrics 16:29:54 ERROR - PROCESS | 3644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 16:29:54 INFO - TEST-INFO | 3644: exit 0 16:29:54 INFO - Browser initialized. 16:29:54 INFO - Running cycle 1/1 for kraken test... 16:29:55 INFO - TEST-INFO | started process 3762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9u3Oti/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:56 INFO - PROCESS | 3762 | 16:29:56 INFO - PROCESS | 3762 | (process:3822): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:30:06 INFO - PROCESS | 3762 | RSS: Main: 165580800 16:30:06 INFO - PROCESS | 3762 | 16:30:09 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39896/tests/kraken/driver.html?testName=audio-beat-detection) 16:30:10 INFO - PROCESS | 3762 | RSS: Main: 168464384 16:30:10 INFO - PROCESS | 3762 | 16:30:13 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39896/tests/kraken/driver.html?testName=audio-dft) 16:30:14 INFO - PROCESS | 3762 | RSS: Main: 168861696 16:30:14 INFO - PROCESS | 3762 | 16:30:17 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39896/tests/kraken/driver.html?testName=audio-fft) 16:30:17 INFO - PROCESS | 3762 | RSS: Main: 164442112 16:30:17 INFO - PROCESS | 3762 | 16:30:19 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39896/tests/kraken/driver.html?testName=audio-oscillator) 16:30:20 INFO - PROCESS | 3762 | RSS: Main: 164720640 16:30:20 INFO - PROCESS | 3762 | 16:30:22 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:23 INFO - PROCESS | 3762 | RSS: Main: 165048320 16:30:23 INFO - PROCESS | 3762 | 16:30:26 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39896/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:27 INFO - PROCESS | 3762 | RSS: Main: 165052416 16:30:27 INFO - PROCESS | 3762 | 16:30:31 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39896/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:31 INFO - PROCESS | 3762 | RSS: Main: 164139008 16:30:31 INFO - PROCESS | 3762 | 16:30:34 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39896/tests/kraken/driver.html?testName=json-parse-financial) 16:30:35 INFO - PROCESS | 3762 | RSS: Main: 163921920 16:30:35 INFO - PROCESS | 3762 | 16:30:37 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:37 INFO - PROCESS | 3762 | RSS: Main: 164450304 16:30:37 INFO - PROCESS | 3762 | 16:30:39 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:40 INFO - PROCESS | 3762 | RSS: Main: 165453824 16:30:40 INFO - PROCESS | 3762 | 16:30:42 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:43 INFO - PROCESS | 3762 | RSS: Main: 165335040 16:30:43 INFO - PROCESS | 3762 | 16:30:46 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:46 INFO - PROCESS | 3762 | RSS: Main: 165343232 16:30:46 INFO - PROCESS | 3762 | 16:30:49 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:50 INFO - PROCESS | 3762 | RSS: Main: 165122048 16:30:50 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | Cycle 1(1): loaded http://localhost:39896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39896/tests/kraken/driver.html?testName=ai-astar) 16:30:52 INFO - PROCESS | 3762 | RSS: Main: 166735872 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | __start_tp_report 16:30:52 INFO - PROCESS | 3762 | _x_x_mozilla_page_load 16:30:52 INFO - PROCESS | 3762 | _x_x_mozilla_page_load_details 16:30:52 INFO - PROCESS | 3762 | |i|pagename|runs| 16:30:52 INFO - PROCESS | 3762 | |0;ai-astar;116;112;114;116;115;115;114;115;113;116 16:30:52 INFO - PROCESS | 3762 | |1;audio-beat-detection;165;132;151;215;131;163;160;132;195;139 16:30:52 INFO - PROCESS | 3762 | |2;audio-dft;162;163;166;168;164;163;161;163;161;161 16:30:52 INFO - PROCESS | 3762 | |3;audio-fft;76;78;75;165;77;76;80;77;153;77 16:30:52 INFO - PROCESS | 3762 | |4;audio-oscillator;93;94;178;94;94;95;146;95;93;136 16:30:52 INFO - PROCESS | 3762 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;117;117;118 16:30:52 INFO - PROCESS | 3762 | |6;imaging-darkroom;149;148;147;147;147;147;147;147;147;148 16:30:52 INFO - PROCESS | 3762 | |7;imaging-desaturate;96;95;95;95;96;95;95;95;95;95 16:30:52 INFO - PROCESS | 3762 | |8;json-parse-financial;66;65;65;65;66;64;65;66;63;64 16:30:52 INFO - PROCESS | 3762 | |9;json-stringify-tinderbox;65;67;65;65;66;65;65;65;67;66 16:30:52 INFO - PROCESS | 3762 | |10;stanford-crypto-aes;82;87;83;81;83;83;85;84;140;89 16:30:52 INFO - PROCESS | 3762 | |11;stanford-crypto-ccm;131;131;133;137;137;132;146;142;146;135 16:30:52 INFO - PROCESS | 3762 | |12;stanford-crypto-pbkdf2;171;175;173;166;169;173;174;172;172;178 16:30:52 INFO - PROCESS | 3762 | |13;stanford-crypto-sha256-iterative;66;68;67;71;68;71;73;66;67;67 16:30:52 INFO - PROCESS | 3762 | __end_tp_report 16:30:52 INFO - PROCESS | 3762 | __start_cc_report 16:30:52 INFO - PROCESS | 3762 | _x_x_mozilla_cycle_collect,980 16:30:52 INFO - PROCESS | 3762 | __end_cc_report 16:30:52 INFO - PROCESS | 3762 | __startTimestamp1463787052381__endTimestamp 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | ------- Summary: start ------- 16:30:52 INFO - PROCESS | 3762 | Number of tests: 14 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:1.33 16:30:52 INFO - PROCESS | 3762 | Values: 116.0 112.0 114.0 116.0 115.0 115.0 114.0 115.0 113.0 116.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:161.50 stddev:28.26 (17.5%) stddev-sans-first:29.87 16:30:52 INFO - PROCESS | 3762 | Values: 165.0 132.0 151.0 215.0 131.0 163.0 160.0 132.0 195.0 139.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.30 (1.4%) stddev-sans-first:2.40 16:30:52 INFO - PROCESS | 3762 | Values: 162.0 163.0 166.0 168.0 164.0 163.0 161.0 163.0 161.0 161.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#3] audio-fft Cycles:10 Average:93.40 Median:77.00 stddev:34.72 (45.1%) stddev-sans-first:36.25 16:30:52 INFO - PROCESS | 3762 | Values: 76.0 78.0 75.0 165.0 77.0 76.0 80.0 77.0 153.0 77.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:94.00 stddev:30.48 (32.4%) stddev-sans-first:31.56 16:30:52 INFO - PROCESS | 3762 | Values: 93.0 94.0 178.0 94.0 94.0 95.0 146.0 95.0 93.0 136.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:30:52 INFO - PROCESS | 3762 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 16:30:52 INFO - PROCESS | 3762 | Values: 149.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:30:52 INFO - PROCESS | 3762 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 16:30:52 INFO - PROCESS | 3762 | Values: 66.0 65.0 65.0 65.0 66.0 64.0 65.0 66.0 63.0 64.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 16:30:52 INFO - PROCESS | 3762 | Values: 65.0 67.0 65.0 65.0 66.0 65.0 65.0 65.0 67.0 66.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:83.50 stddev:17.83 (21.4%) stddev-sans-first:18.70 16:30:52 INFO - PROCESS | 3762 | Values: 82.0 87.0 83.0 81.0 83.0 83.0 85.0 84.0 140.0 89.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:137.00 stddev:5.81 (4.2%) stddev-sans-first:5.74 16:30:52 INFO - PROCESS | 3762 | Values: 131.0 131.0 133.0 137.0 137.0 132.0 146.0 142.0 146.0 135.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:3.27 (1.9%) stddev-sans-first:3.43 16:30:52 INFO - PROCESS | 3762 | Values: 171.0 175.0 173.0 166.0 169.0 173.0 174.0 172.0 172.0 178.0 16:30:52 INFO - PROCESS | 3762 | 16:30:52 INFO - PROCESS | 3762 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.41 (3.5%) stddev-sans-first:2.40 16:30:52 INFO - PROCESS | 3762 | Values: 66.0 68.0 67.0 71.0 68.0 71.0 73.0 66.0 67.0 67.0 16:30:52 INFO - PROCESS | 3762 | -------- Summary: end -------- 16:30:52 INFO - PROCESS | 3762 | 16:30:54 INFO - TEST-INFO | 3762: exit 0 16:30:54 INFO - TEST-OK | kraken | took 66360ms 16:30:54 INFO - SUITE-END | took 1182s 16:30:54 INFO - Completed test suite (00:19:42) 16:30:54 INFO - javascript benchmark 16:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6288.206001394152, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2677.6920654124774, 2722.550779121445, 2726.4683386739594, 2734.261749327682, 2759.9999999999986, 4714.127886341025, 4745.193317136086, 4763.166445871976, 4841.007593443344, 4843.612510999121, 4676.883077923045, 4765.809367625291, 4787.35370724952, 4788.664793464459, 4811.951880481203, 4490.41624588803, 4529.728216307032, 4583.9312410313705, 4584.541545845405, 4627.814887404516, 452.5324164480278, 4384.517703052662, 4389.100234451929, 4489.595936365727, 4513.887152821189, 4431.667624928144, 4432.778361081933, 4457.77711114443, 4463.4866990296205, 4501.774911254441, 4380.2115619188535, 4467.5755803198645, 4485.192665320241, 4491.595756381941, 4500.707454015511, 4404.493483249404, 4427.158839820424, 4456.821727130911, 4492.3710680504755, 4497.370368148462, 4703.764811759398, 4715.41057367829, 4760.690555113941, 4771.6665505677265, 4799.712017278975, 4911.238757992517, 5108.872278193037, 5160.948390516084, 5170.844874653766, 5173.767180476888, 5203.7398130093725, 5218.269442278084, 5219.8434046978655, 5222.060029194743, 5252.65857719247, 4848.466668666444, 4854.611631069506, 4866.245731911559, 4872.0499502597, 4923.335349727812, 5100.948990510047, 5256.106461901486, 5305.60207984395, 5312.681239125664, 5348.224507446476, 5072.492750724898, 5077.543021128116, 5084.898302033938, 5087.2114822201875, 5100.336956195671, 5163.173892177234, 5168.664036837594, 5168.793248270103, 5175.327207463081, 5215.061288967946, 4932.112219800399, 5037.823676171316, 5067.5185857343495, 5096.05722941257, 5165.276861239429, 4783.1868582341085, 5035.992801439654, 5063.772130254148, 5065.6200784941275, 5117.41149767774, 4367.912641747147, 4415.381846541487, 4424.955750442518, 4430.933535996963, 4459.888502787457, 3732.5147730794824, 3832.597577254348, 3838.2899163654256, 3862.517185351831, 3882.107115363482, 4445.444319460067, 4445.666575006822, 4453.643708503312, 4464.084862603158, 4464.99537604043, 5212.582993360522, 5224.738763061831, 5225.059489291888, 5233.267342572043, 5247.921281180786, 4261.339492378686, 4315.201687687788, 4390.165868484977, 4400.22995975703, 4418.248897687401, 4570.520095390003, 4571.542845715402, 4589.54104589545, 4615.100055489214, 4633.351330813689, 4704.341392205162, 4765.904681906342, 4776.713397196179, 4794.304825800239, 4812.8796780080775, 5126.384833819965, 5170.767315470737, 5178.559822415137, 5183.144781111075, 5202.089634313904, 4793.496682848251, 4832.782524786323, 4837.153498137742, 4837.250226214942, 4876.756162191948, 4913.43495498008, 5063.063333283354, 5069.062223488666, 5115.130427827353, 5162.6902385856965, 5161.948380516297, 5184.766685499237, 5205.193195054772, 5213.009528189632, 5241.475852414728, 5045.4450010498085, 5054.267131265872, 5054.974725126351, 5057.039162559102, 5116.513931176682, 4898.2652602109965, 4900.485449027943, 4951.0, 5019.899602008012, 5059.5952323814745, 4665.230237010991, 4800.903981920412, 4816.783244754065, 4874.756262186947, 4916.557509824133, 5040.092783299041, 5043.4956504349275, 5051.2423136529815, 5053.11570475158, 5094.2867998479505, 4788.928166077581, 4881.51184881509, 4952.133376659142, 4959.925601116059, 4965.553100220853], "value": 4697.37889467898, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3324510455111, 588.2176704982373, 590.7371219807186, 597.5548216578646, 618.2241287184582, 39944.0, 41193.7940310298, 41531.0, 41545.584544154546, 45286.77356613212, 40729.59270407295, 41872.37191442131, 41903.58096419035, 41908.16183676325, 41919.37120943188, 7702.268284512977, 7748.108967468729, 7844.529328240295, 7850.764477065697, 7860.646270917822, 7628.50414723044, 7749.108852481952, 7778.80552986177, 7785.0, 7795.493292935969, 7808.297253247207, 7808.921910780905, 7812.453128281023, 7820.687172513092, 7831.686732530692, 7778.6110694465615, 7788.727394541163, 7801.882971755428, 7802.102758182825, 7835.255650713173, 7745.225477452266, 7771.650275737606, 7832.099308579529, 7842.803929901798, 7848.097468791105, 39250.60749392498, 39557.80221098876, 39564.80217598922, 39637.40543891844, 39655.0, 3026.056060007883, 3171.1913462067255, 3176.5833017304913, 3439.1917899293644, 3841.3661745811905, 29381.85309073441, 29704.40591188186, 29792.404151917057, 29895.10314690563, 30105.548416773767, 3482.495038219444, 3524.1542029912634, 3537.876174333886, 3611.4402267648557, 3711.3319602471543, 251806.0, 253234.0, 253449.99999999817, 254092.0, 254569.0, 29208.561871571943, 54387.0, 54711.45288547143, 54956.450435495135, 55073.724631376586, 34674.826625867216, 34823.0, 34834.47748283778, 34841.0, 34955.30089398198, 11171.38557379352, 11199.384033878216, 11218.102551795837, 11238.213325067167, 11261.21171517986, 9440.763980900396, 9466.337356384987, 9503.66737164196, 9510.048995100573, 9511.714648560554, 8060.274575288135, 8073.798155046171, 8081.4747041442115, 8121.5533145677555, 8127.634256458474, 3116.8597413116463, 3182.7612929030415, 3197.1048106530206, 3243.302689921631, 3243.41618508666, 876.2201640539924, 979.6130528441225, 996.7637540453075, 1015.7968406318765, 1018.4042335233971, 28641.856790715912, 28785.280367990967, 28922.421551568852, 29180.597858978505, 29370.265743356587, 965.560669895196, 997.6059456514781, 1044.3864229765031, 1078.8058149533003, 1079.1043433949803, 15086.924565377103, 15356.310805811352, 15490.9225453872, 15628.140452275235, 15717.371305147895, 389334.0, 392262.0, 394008.0, 394446.0, 394465.0, 50108.74945625249, 50387.24419133716, 50414.747926260134, 50858.491415086115, 51029.23456148161, 1165.1377980294521, 1185.247367921376, 1187.0503597122267, 1198.8261702053153, 1204.175140029083, 27494.312642183304, 28316.847384383545, 28424.86300547955, 28580.85709571439, 28651.5702264462, 44590.55409445864, 44615.776921116485, 44698.77650611726, 44846.77576612096, 44882.0, 309293.0, 310712.0, 312627.0, 313693.0, 313760.0, 25653.87173064123, 25916.09293674712, 26182.345441363355, 26313.73686263113, 26427.60358594661, 42575.148497029266, 42946.35580466358, 43078.569214307456, 43078.78460607677, 43385.3492197611, 36155.45766813447, 36873.262534749694, 37448.438273425374, 37523.43714844225, 37698.43452348272, 36500.269994599425, 37202.8139859299, 37258.0, 37719.0, 37731.62268377281, 35588.0, 36448.63551364453, 36455.635443646286, 36483.635163648025, 36541.81729091337, 31592.684073159893, 33879.32241355209, 34043.82978085094, 34066.489002665476, 34218.14454638654, 25323.87338063298, 25781.484370312864, 25798.61302080433, 25941.351466213495, 26096.0], "value": 16698.92173280874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9982850085749, 347.2464751489268, 354.59398988158557, 355.90390594539474, 362.7461668830589, 16477.0, 16625.0, 17485.388011419604, 17516.211770470345, 17591.82408175918, 16026.0, 16595.336186552555, 17355.219015144317, 17356.739648905277, 17363.913180434112, 4985.800567977277, 5110.437851836295, 5167.095758242312, 5167.509086636783, 5171.3535808024, 3704.9629503704887, 5099.770510327045, 5681.091025435931, 5985.730642121115, 6031.788887388942, 6016.548758843104, 6055.0311950088, 6075.0, 6093.756249750005, 6101.908471372933, 6335.3981371769605, 6618.867622647568, 6719.361660642256, 6729.1924969003785, 6733.4276586490205, 6541.6075035498025, 6960.547564408297, 6991.7902462926195, 7004.299570043006, 7033.859322813515, 22001.0, 22537.0, 22885.31344059664, 23800.40498987522, 23805.761942380526, 1969.931052413173, 2029.8173164415125, 2069.265410779182, 2148.892555372225, 2236.2396785092983, 14025.579232623038, 14266.286685665778, 14296.642583935485, 14759.852401475955, 15046.849531504655, 1936.66108431024, 1942.5823447958758, 1986.523234423728, 2005.5788284460282, 2015.8689685170564, 61255.999999999556, 78598.6070069646, 79049.60475197587, 79594.0, 80212.0, 14455.398737356303, 15637.68724625501, 16521.91739041321, 16706.49880503587, 16794.748078778826, 29338.266543336587, 29443.558346624817, 29632.407351853275, 29792.553111703342, 29806.55290170649, 7573.431992600577, 7780.84438311242, 7782.533048017137, 7803.375729941591, 7882.763517094496, 6122.479589234965, 6225.688715564203, 6303.810885673437, 6309.716062777186, 6319.936800631935, 8350.79123021917, 8415.747527574182, 8646.654133834576, 8738.737837864874, 8744.300455963508, 1553.5106441471125, 1620.7244768389403, 1627.6826018926195, 1655.793025871766, 3209.9197520062185, 396.472691320543, 401.8231977929702, 409.7787194914713, 853.1340689200466, 858.926991205742, 10788.0, 10984.176186785864, 11120.0, 11158.944205278922, 11200.439978001068, 415.38730372700024, 421.57842157842157, 428.52647824154485, 431.49515067370623, 432.6517153691246, 5738.0, 5911.497522710618, 5944.108383742387, 5969.343372229051, 6091.299500557404, 397415.0, 401424.0, 405772.0, 406350.0, 417433.0, 52340.214896776575, 58722.0, 85344.57327713321, 87137.56431217803, 87805.56097219473, 417.77440182301825, 424.6920982287817, 426.413681188366, 427.03064044618543, 427.11373899158747, 10071.446070465901, 10074.899251007397, 10160.491975401053, 10398.376097434179, 10419.895801042196, 35661.64338356687, 36779.44830827486, 37207.25585488329, 37315.0, 37582.0, 52752.208716870045, 53029.0, 53688.73155634353, 53808.19287710766, 53903.73048134891, 7829.45193836426, 7910.802229944297, 7912.881306780518, 8025.23760242776, 8033.6786528538205, 8846.646134154562, 10819.416820835326, 12078.879211207775, 12265.632031039084, 12393.008559315052, 4666.626669866335, 10059.849102263326, 10198.898011019795, 10311.432871192157, 10395.688129356131, 10152.137068349273, 10269.281150319406, 10485.37087774736, 10681.412522311348, 10747.301425407324, 10134.138598219233, 10439.164866810788, 10680.0, 10778.676639700821, 10979.670609881716, 7342.339189472973, 7682.692692292246, 7803.765887023398, 7932.0878099017045, 7939.0870049945, 7939.325157361689, 8898.911010889808, 10096.0, 10164.491775411348, 10210.984694434203], "value": 8221.703791742917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.8876089912806, 1448.398914450503, 1559.5399357189629, 1724.5429961060313, 1740.5822602575386, 6714.328567143283, 7397.075365579302, 7547.132079810824, 7998.400119991002, 8000.679972801088, 7460.0674915635545, 7685.884711729329, 7694.345980591656, 7725.92274077259, 7755.069391672993, 2204.8787316697535, 2260.0394832196253, 2261.739899911515, 2262.6266666000092, 2263.7283525976823, 2197.8681279123225, 2229.843910926236, 2241.8879056047213, 2245.7754224577493, 2247.539254452833, 2165.28545579959, 2172.022589834573, 2183.366823621148, 2216.7783221677782, 2251.448395143192, 2121.9999999999845, 2132.1897678882083, 2138.347803919804, 2144.6032483990434, 2151.4513798981316, 1931.719900614403, 1949.093671442786, 1950.5221220800852, 2117.4282943605294, 2119.088791819517, 7650.617469126521, 7678.308952194274, 7686.154523002465, 7720.613969301568, 7745.380369570477, 4329.025969156946, 4394.099209662044, 4403.6256918162, 4413.514513403523, 4436.622887054604, 2576.974230257711, 2611.7518835710575, 2812.7187281271913, 2823.4917714811327, 2837.4325134973087, 821.3593397150232, 858.4334339336008, 863.2921004776086, 868.6525389844113, 881.5019513974584, 10685.519151638195, 10704.46477676121, 10711.946440267826, 10744.247902646817, 10775.245732798707, 4178.1643671265865, 4318.589733975267, 4331.5884990925815, 4332.393464914914, 4355.477342718831, 9091.772705682411, 9100.499472528942, 9108.362414631045, 9116.954415227881, 9126.315526335551, 4516.096780643885, 4518.8418405356315, 4531.954680453219, 4543.477500087466, 4548.113117942035, 3542.3446662367546, 3879.84480620772, 3998.540167880673, 4042.8989275268355, 4067.349224124126, 3618.945715814265, 3769.0200547857753, 3814.0846196913094, 3820.656140947328, 3834.0, 1187.7017970227637, 1204.5302332090491, 1219.823125646794, 1222.407132540717, 1229.9815502767465, 791.2008871040176, 904.5838914099456, 906.51501446727, 907.8002839375326, 918.6600957645713, 5246.557196770842, 5306.204069389622, 5318.175682769177, 5401.02781499326, 5449.12813949774, 421.74484436915225, 423.5277665403053, 426.6757264479018, 428.96568274537964, 435.46002956334553, 3484.7306165599384, 3530.5763308403157, 3540.504329393887, 3570.910727231788, 3596.82015899204, 9565.426074435556, 9824.65613703517, 9840.950795245977, 9847.310688251753, 9908.0, 9742.61029558824, 9756.365836220622, 9777.853332200022, 9802.411855288705, 9853.40879547215, 7377.963110184414, 7507.061617297947, 7518.173000969889, 7525.736599219001, 7530.096388433313, 5180.222966555047, 5267.868303292448, 5302.072137376021, 5380.0584897641975, 5413.512783849473, 8980.236679882284, 9014.729558113268, 9017.368784185306, 9271.258299335903, 9298.767530811783, 9028.954855225682, 9161.267098632226, 9231.215346695606, 9247.167754902091, 9331.113544213289, 5611.2424822650055, 6419.550631455753, 6595.01074838778, 6684.4318232950745, 6728.495362847708, 7570.886436703344, 7683.9231607683205, 7693.153753087044, 7720.53676779395, 7724.034495688039, 6771.6614169292325, 6877.415419689382, 6948.652567371712, 7024.683889225099, 7072.292770723092, 6786.830329241809, 6787.524873259022, 6853.143357080365, 6898.586084834926, 7042.366187043191, 6126.23422072241, 6152.384761523991, 6180.783672571439, 6209.410106039919, 6256.249250090018, 4659.906801864012, 4769.523047695203, 4841.782119804547, 4928.852134435972, 4944.035912996931, 4753.714777113384, 4813.422389313305, 4834.758262086952, 4904.117258893433, 4910.45984941649], "value": 4073.901363071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.95456726923686, 285.41489945611494, 285.59730779600767, 289.9333153374724, 293.6945576600335, 4995.150824359858, 5049.873753156173, 5052.418971818242, 5054.620903432239, 5063.316452278941, 4972.32873562069, 4976.552110310071, 4984.526469985355, 4988.0, 4992.201247800353, 3748.4002559590404, 3796.126890815114, 3940.251352243079, 3946.8026598669953, 3955.3078211312904, 3946.2304850554156, 3952.9209415811665, 3959.2477429288488, 3981.542122655903, 3984.402339649047, 3939.606039396052, 3968.1865217630316, 3984.8443951254103, 3994.2410941920944, 3999.4800675912093, 3803.7067397084847, 3915.9216815663526, 3930.508686414198, 3982.4424580558743, 3991.481107456041, 3423.8358957954415, 3428.8226975870252, 3432.467967465047, 3435.986384016721, 3458.0, 4830.227163653799, 4832.106060378841, 4844.297576851337, 4866.926996095061, 4875.219964805614, 4374.278244089754, 4406.5593440656, 4426.7343959362215, 4450.933236001462, 4462.330650402466, 5262.815801446931, 5271.288376069258, 5273.683578985273, 5287.0, 5299.364076310867, 3793.715471339633, 3798.1264309209037, 3800.7575530437175, 3808.733388662795, 3835.5589107252745, 5429.83710488682, 5556.16657501374, 5574.693391863446, 5576.693281869496, 5597.80407685729, 3885.708571857122, 3889.0666240102737, 3899.473571067926, 3903.941440878389, 3910.8631197908508, 3982.323005089084, 3992.580779018161, 3995.1809878975323, 3998.260321840469, 4001.4998125234347, 4448.177087238806, 4469.687121901436, 4482.125985432809, 4486.327050942385, 4513.097380523908, 5039.823606173766, 5246.186841039645, 5287.867803304871, 5332.626716129834, 5339.679619222859, 1319.4985905356095, 1327.8340207474066, 1333.7596035686904, 1345.663584103974, 1352.2900477249325, 828.718235799831, 829.2081062585216, 846.957652117404, 866.8699695045793, 872.6247713483136, 4506.679060283891, 4609.3086037094035, 4625.259958406638, 4630.513796051433, 4635.953640463552, 5491.478309560585, 5492.588055895823, 5511.862203444946, 5529.419410961871, 5538.196961440569, 4421.314696222091, 4591.816327346935, 4624.5144259852905, 4635.443746750411, 4644.860654180313, 2890.783191260664, 2905.9273518162213, 2923.9415211695646, 2946.9705302947127, 2960.985195074011, 5062.949370506248, 5078.822241221539, 5086.4659210783075, 5098.260752190986, 5113.233015047773, 5445.428230035868, 5515.172724091338, 5570.442955704478, 5577.3028371453565, 5598.524125449382, 5076.289319495348, 5085.466026067357, 5100.26046223303, 5105.0, 5105.2342148678, 5424.810131645373, 5427.267318912054, 5439.129739241703, 5455.781768729206, 5489.972550137224, 5196.350456192976, 5284.841454756363, 5326.733663316896, 5349.0, 5362.605722512097, 5053.620978426559, 5054.444011158696, 5071.721055341992, 5079.3904731430985, 5084.694918304914, 3705.6479634434686, 3723.2739615774663, 3736.58897521267, 3738.3271011217153, 3745.9063523412133, 5332.68003919766, 5434.782608695607, 5469.070258056219, 5471.261379713687, 5498.532624726943, 5330.520253177233, 5334.799120527808, 5336.665833541615, 5338.572914166935, 5355.384130824849, 5248.448912864247, 5263.499902527761, 5318.962802253678, 5332.120200166929, 5344.893102138013, 4910.705357678551, 5187.19598462239, 5192.506711862367, 5194.558462530727, 5201.947980520298, 5014.749262536931, 5115.18157094863, 5200.531952124327, 5210.879660872931, 5261.71088083422, 5130.358705161855, 5169.802833795547, 5173.22401639757, 5204.2974198484235, 5255.159174532057], "value": 3962.291117075079, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.6584705188561, 755.4938191411753, 770.4337312075623, 773.9883901741479, 781.1290411191524, 12890.162139460941, 13348.933255333723, 13359.93320033401, 13765.174089554634, 13794.793078103836, 14470.5658830235, 14477.85522144781, 14486.710265794678, 14503.05730127541, 14543.12741235524, 637.4422380417135, 778.758584838699, 793.2900054451262, 795.3200013988044, 796.3867821777228, 790.1269097647104, 793.5754371411296, 794.1978601612356, 795.3319211862034, 796.024869534821, 831.7712629027036, 837.1670188162786, 839.559231403515, 839.6851180807197, 840.5545061117617, 828.0849661124431, 835.9623816928253, 836.1262480707675, 836.1805430677939, 836.2515548584045, 607.3349682098095, 609.740860134441, 610.3133974278936, 610.523791442671, 614.7940439952621, 13287.933560332232, 13370.13094148887, 13373.598792036255, 13437.798433023512, 13447.32763361828, 12084.335361555111, 12370.876291237153, 12688.936555317165, 12699.174553653984, 13018.218906865619, 9852.458114803683, 10032.197424206046, 10075.34510256831, 10319.122874555596, 10342.120919721832, 3279.540864279003, 3332.1836150143126, 3349.1961929137074, 3351.3632409842053, 3359.227377703142, 51353.229701554505, 51662.48337516614, 51728.22407663851, 51869.0, 52728.736356317975, 9993.250506212064, 10062.345947513388, 10068.345557538736, 10081.344712593658, 10123.088921997056, 17844.55388615295, 17915.37296194627, 17986.820131798515, 18031.368902088365, 18439.631207375776, 6460.224773027173, 6481.643509606923, 6595.142631457879, 6599.175103112111, 6838.863222735517, 3665.248624032067, 3702.9444558331647, 3760.9435858462143, 3779.6787273082095, 3822.57951625321, 2788.2750484874077, 2873.7126287371098, 2890.956635650467, 2895.102518219359, 2906.3606006678497, 509.9490050994945, 517.0744367582062, 519.6336582709181, 520.1547485336329, 520.5809323494548, 442.51323544101876, 449.1488629047936, 481.2588613535187, 489.41026063593284, 540.5513423858267, 8213.54825484604, 8399.874001889977, 8406.159384061668, 8608.440451370641, 8735.912640873637, 523.6727045596502, 551.7241379310345, 591.349515532919, 614.1279383275759, 618.8545691762432, 3709.9814500927323, 3795.772253664789, 3828.7319887608155, 3830.9398273083957, 3872.6127387261613, 55771.72114139403, 56018.439815602134, 56326.0, 56698.71650641803, 57128.0, 51964.48035519596, 52450.47549524532, 53114.46885531172, 53307.0, 53378.0, 46184.53815461802, 46321.0, 46567.0, 46737.29894051592, 47038.29442558364, 7700.4224683150105, 7761.92238077612, 7853.136155023057, 7858.057033155829, 7991.200879911962, 31001.0, 31232.68767312298, 31273.06180814579, 31682.524762129047, 31747.84126079355, 37985.4302185473, 41386.58613413948, 41499.58500415078, 41832.163356733305, 41850.58149418467, 8944.105589441004, 9247.445153290824, 9476.0, 9546.379485333431, 9562.521873906417, 10537.367757934548, 10721.731956701145, 10728.0, 10883.23817332779, 10925.508352124014, 9911.058449447291, 9961.0, 9989.450580217866, 10035.29752917318, 10039.247056470647, 10120.190384769054, 10291.639792607222, 10296.382217067, 10403.011713887168, 10405.531751071372, 9588.66439674608, 9700.417974921527, 9719.076687714656, 9827.262955278526, 9849.458279794393, 8071.869267138332, 8082.313003394777, 8157.79605509867, 8467.57662116904, 8830.95584522099, 8793.736187914374, 8878.51168185756, 8899.73300800977, 8951.328650351119, 8951.462912225288], "value": 5938.155932982194, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 114.0, 116.0, 115.0, 115.0, 114.0, 115.0, 113.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 151.0, 215.0, 131.0, 163.0, 160.0, 132.0, 195.0, 139.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 168.0, 164.0, 163.0, 161.0, 163.0, 161.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 165.0, 77.0, 76.0, 80.0, 77.0, 153.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 178.0, 94.0, 94.0, 95.0, 146.0, 95.0, 93.0, 136.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 63.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 83.0, 81.0, 83.0, 83.0, 85.0, 84.0, 140.0, 89.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 133.0, 137.0, 137.0, 132.0, 146.0, 142.0, 146.0, 135.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 173.0, 166.0, 169.0, 173.0, 174.0, 172.0, 172.0, 178.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 71.0, 68.0, 71.0, 73.0, 66.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 16:30:54 INFO - Return code: 0 16:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:30:54 ERROR - # TBPL SUCCESS # 16:30:54 INFO - Running post-action listener: _resource_record_post_action 16:30:54 INFO - ##### 16:30:54 INFO - ##### Finished run-tests step (success) 16:30:54 INFO - ##### 16:30:54 INFO - Running post-run listener: _resource_record_post_run 16:30:54 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7847936; Write bytes: 450015232; Read time: 1436; Write time: 347328 16:30:54 INFO - TinderboxPrint: CPU usage
13.3% 16:30:54 INFO - TinderboxPrint: I/O read bytes / time
7,847,936 / 1,436 16:30:54 INFO - TinderboxPrint: I/O write bytes / time
450,015,232 / 347,328 16:30:54 INFO - TinderboxPrint: CPU idle
8,299.2 (86.7%) 16:30:54 INFO - TinderboxPrint: CPU user
1,223.7 (12.8%) 16:30:54 INFO - TinderboxPrint: Swap in / out
0 / 0 16:30:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93728768; Read time: 0; Write time: 83680 16:30:54 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6086656; Write bytes: 356286464; Read time: 1388; Write time: 263648 16:30:55 INFO - Running post-run listener: _upload_blobber_files 16:30:55 INFO - Blob upload gear active. 16:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:30:55 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:30:55 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:00 INFO - (blobuploader) - INFO - Done attempting. 16:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:01 INFO - (blobuploader) - INFO - Done attempting. 16:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:31:02 INFO - (blobuploader) - INFO - Done attempting. 16:31:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:31:02 INFO - Return code: 0 16:31:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:31:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:31:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e395fbe13c5ade2e6bb3bfdc3c656ac82c99d598cc03eaf3e9d409f2f94515068093856ca8eba55663644c5c61fce50b5da49e3a63492da830c67360e4caf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb23eb96d37a04bfab6d33c190deeb1348c0200dc6561eef5340896a59b13bdae705270dfbe4b1936ed6aa16c7aeafd0817f4aec9148c3d66c2b2b83ae15a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ef1bf914869c8aa10e65276a0eea2500ff229f8f4637062c117c5ae3be0e486bb0660675f7bfdab4580a802e64b3d61a3c9ce14e1f70d5ac57981d262205d76"} 16:31:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:31:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:31:02 INFO - Contents: 16:31:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e395fbe13c5ade2e6bb3bfdc3c656ac82c99d598cc03eaf3e9d409f2f94515068093856ca8eba55663644c5c61fce50b5da49e3a63492da830c67360e4caf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb23eb96d37a04bfab6d33c190deeb1348c0200dc6561eef5340896a59b13bdae705270dfbe4b1936ed6aa16c7aeafd0817f4aec9148c3d66c2b2b83ae15a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ef1bf914869c8aa10e65276a0eea2500ff229f8f4637062c117c5ae3be0e486bb0660675f7bfdab4580a802e64b3d61a3c9ce14e1f70d5ac57981d262205d76"} 16:31:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:31:02 INFO - Copying logs to upload dir... 16:31:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:31:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.236171 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-05-20 16:31:02.219946) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:31:02.229085) ========= 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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e395fbe13c5ade2e6bb3bfdc3c656ac82c99d598cc03eaf3e9d409f2f94515068093856ca8eba55663644c5c61fce50b5da49e3a63492da830c67360e4caf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb23eb96d37a04bfab6d33c190deeb1348c0200dc6561eef5340896a59b13bdae705270dfbe4b1936ed6aa16c7aeafd0817f4aec9148c3d66c2b2b83ae15a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ef1bf914869c8aa10e65276a0eea2500ff229f8f4637062c117c5ae3be0e486bb0660675f7bfdab4580a802e64b3d61a3c9ce14e1f70d5ac57981d262205d76"} build_url:https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/TOGfu4wDSoSY2CKVGw7nTA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/342e395fbe13c5ade2e6bb3bfdc3c656ac82c99d598cc03eaf3e9d409f2f94515068093856ca8eba55663644c5c61fce50b5da49e3a63492da830c67360e4caf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7bb23eb96d37a04bfab6d33c190deeb1348c0200dc6561eef5340896a59b13bdae705270dfbe4b1936ed6aa16c7aeafd0817f4aec9148c3d66c2b2b83ae15a79", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ef1bf914869c8aa10e65276a0eea2500ff229f8f4637062c117c5ae3be0e486bb0660675f7bfdab4580a802e64b3d61a3c9ce14e1f70d5ac57981d262205d76"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 16:31:02.262001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:31:02.262338) ========= 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=eca2ab57546de7b41f256b19000001ef-1463785746.897239-306596331 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 16:31:02.343424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:31:02.346792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 16:31:02.347103) ========= ========= Total master_lag: 0.20 =========