builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1469801339.52 results: success (0) buildid: 20160729043004 builduid: ad23094675ac4e2085f9e973d65ea224 revision: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.519799) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.521575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.521946) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.548061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.548355) ========= 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=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 07:08:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-07-29 07:08:59 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111008 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.684863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.685212) ========= 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=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018645 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.743014) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:08:59.743401) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 --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 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 --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=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 07:08:59,930 truncating revision to first 12 chars 2016-07-29 07:08:59,930 Setting DEBUG logging. 2016-07-29 07:08:59,930 attempt 1/10 2016-07-29 07:08:59,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ea3d51ba1bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 07:09:00,357 unpacking tar archive at: mozilla-central-2ea3d51ba1bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:09:00.530987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 07:09:00.531355) ========= script_repo_revision: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 07:09:00.531800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 07:09:00.532133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 07:09:00.543104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-29 07:09:00.543582) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:09:00 INFO - MultiFileLogger online at 20160729 07:09:00 in /builds/slave/test 07:09:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:09:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:09:00 INFO - {'append_to_log': False, 07:09:00 INFO - 'base_work_dir': '/builds/slave/test', 07:09:00 INFO - 'blob_upload_branch': 'Firefox', 07:09:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:09:00 INFO - 'branch': 'Firefox', 07:09:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:09:00 INFO - 'config_files': ('talos/linux_config.py',), 07:09:00 INFO - 'default_actions': ('clobber', 07:09:00 INFO - 'read-buildbot-config', 07:09:00 INFO - 'download-and-extract', 07:09:00 INFO - 'populate-webroot', 07:09:00 INFO - 'create-virtualenv', 07:09:00 INFO - 'install', 07:09:00 INFO - 'run-tests'), 07:09:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:09:00 INFO - 'download_minidump_stackwalk': True, 07:09:00 INFO - 'download_symbols': 'ondemand', 07:09:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:09:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:09:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:09:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:09:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:09:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:09:00 INFO - 'installer_path': 'installer.exe', 07:09:00 INFO - 'log_level': 'info', 07:09:00 INFO - 'log_name': 'talos', 07:09:00 INFO - 'log_to_console': True, 07:09:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:09:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:09:00 INFO - 'opt_config_files': (), 07:09:00 INFO - 'pip_index': False, 07:09:00 INFO - 'sps_profile': False, 07:09:00 INFO - 'sps_profile_interval': 0, 07:09:00 INFO - 'suite': 'dromaeojs-e10s', 07:09:00 INFO - 'system_bits': '32', 07:09:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:09:00 INFO - 'title': 'talos-linux64-ix-063', 07:09:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:09:00 INFO - 'use_talos_json': True, 07:09:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:09:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:09:00 INFO - 'work_dir': 'build'} 07:09:00 INFO - [mozharness: 2016-07-29 14:09:00.822171Z] Running clobber step. 07:09:00 INFO - Running pre-action listener: _resource_record_pre_action 07:09:00 INFO - Running main action method: clobber 07:09:00 INFO - rmtree: /builds/slave/test/build 07:09:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:09:01 INFO - Running post-action listener: _resource_record_post_action 07:09:01 INFO - [mozharness: 2016-07-29 14:09:01.291930Z] Finished clobber step (success) 07:09:01 INFO - [mozharness: 2016-07-29 14:09:01.292030Z] Running read-buildbot-config step. 07:09:01 INFO - Running pre-action listener: _resource_record_pre_action 07:09:01 INFO - Running main action method: read_buildbot_config 07:09:01 INFO - Using buildbot properties: 07:09:01 INFO - { 07:09:01 INFO - "project": "", 07:09:01 INFO - "product": "firefox", 07:09:01 INFO - "script_repo_revision": "production", 07:09:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:09:01 INFO - "repository": "", 07:09:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:09:01 INFO - "buildid": "20160729043004", 07:09:01 INFO - "pgo_build": "True", 07:09:01 INFO - "basedir": "/builds/slave/test", 07:09:01 INFO - "buildnumber": 109, 07:09:01 INFO - "slavename": "talos-linux64-ix-063", 07:09:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:09:01 INFO - "platform": "ubuntu64_hw", 07:09:01 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:09:01 INFO - "branch": "mozilla-central", 07:09:01 INFO - "repo_path": "mozilla-central", 07:09:01 INFO - "revision": "2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2", 07:09:01 INFO - "stage_platform": "linux64-pgo", 07:09:01 INFO - "builduid": "ad23094675ac4e2085f9e973d65ea224", 07:09:01 INFO - "slavebuilddir": "test" 07:09:01 INFO - } 07:09:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:09:01 INFO - Running post-action listener: _resource_record_post_action 07:09:01 INFO - [mozharness: 2016-07-29 14:09:01.294459Z] Finished read-buildbot-config step (success) 07:09:01 INFO - [mozharness: 2016-07-29 14:09:01.294546Z] Running download-and-extract step. 07:09:01 INFO - Running pre-action listener: _resource_record_pre_action 07:09:01 INFO - Running main action method: download_and_extract 07:09:01 INFO - mkdir: /builds/slave/test/build/tests 07:09:01 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')]} 07:09:01 INFO - https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:09:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:09:04 INFO - Downloaded 1361 bytes. 07:09:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:09:04 INFO - Using the following test package requirements: 07:09:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:09:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:09:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'jsshell-linux-x86_64.zip'], 07:09:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:09:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:09:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:09:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:09:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:09:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:09:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:04 INFO - https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:20 INFO - Downloaded 24329939 bytes. 07:09:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:22 INFO - Return code: 0 07:09:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:22 INFO - https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:09:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:09:24 INFO - Downloaded 24329939 bytes. 07:09:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:09:26 INFO - Return code: 0 07:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:26 INFO - https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:09:27 INFO - Downloaded 14413725 bytes. 07:09:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:09:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:09:28 INFO - Return code: 0 07:09:28 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')]} 07:09:28 INFO - https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:09:29 INFO - Downloaded 61035754 bytes. 07:09:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:29 INFO - mkdir: /builds/slave/test/properties 07:09:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:09:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:09:29 INFO - Contents: 07:09:29 INFO - build_url:https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:09:30 INFO - Running post-action listener: _resource_record_post_action 07:09:30 INFO - Running post-action listener: set_extra_try_arguments 07:09:30 INFO - [mozharness: 2016-07-29 14:09:30.556011Z] Finished download-and-extract step (success) 07:09:30 INFO - [mozharness: 2016-07-29 14:09:30.556257Z] Running populate-webroot step. 07:09:30 INFO - Running pre-action listener: _resource_record_pre_action 07:09:30 INFO - Running main action method: populate_webroot 07:09:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:09:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:09:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:09:30 INFO - '--tppagecycles', 07:09:30 INFO - '7'], 07:09:30 INFO - 'tests': ['tsvgm']}}, 07:09:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:09:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:09:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:09:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:09:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:09:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['damp', 'tps']}, 07:09:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'tests': ['damp', 'tps']}, 07:09:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['dromaeo_dom']}, 07:09:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:09:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['basic_compositor_video']}, 07:09:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:09:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'other-e10s': {'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['a11yr', 07:09:30 INFO - 'ts_paint', 07:09:30 INFO - 'tpaint', 07:09:30 INFO - 'sessionrestore', 07:09:30 INFO - 'sessionrestore_no_auto_restore', 07:09:30 INFO - 'tabpaint']}, 07:09:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['tsvgx', 07:09:30 INFO - 'tsvgr_opacity', 07:09:30 INFO - 'tart', 07:09:30 INFO - 'tscrollx', 07:09:30 INFO - 'cart']}, 07:09:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:09:30 INFO - 'tsvgr_opacity', 07:09:30 INFO - 'tart', 07:09:30 INFO - 'tscrollx', 07:09:30 INFO - 'cart']}, 07:09:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'talos_options': ['--disable-e10s'], 07:09:30 INFO - 'tests': ['tp5o']}, 07:09:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'tests': ['tp5o']}, 07:09:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'talos_options': ['--disable-e10s', 07:09:30 INFO - '--xperf_path', 07:09:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:30 INFO - 'tests': ['tp5n']}, 07:09:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:09:30 INFO - 'talos_options': ['--xperf_path', 07:09:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:09:30 INFO - 'tests': ['tp5n']}}, 07:09:30 INFO - 'talos.zip': {'path': '', 07:09:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:09:30 INFO - Running post-action listener: _resource_record_post_action 07:09:30 INFO - [mozharness: 2016-07-29 14:09:30.584551Z] Finished populate-webroot step (success) 07:09:30 INFO - [mozharness: 2016-07-29 14:09:30.584640Z] Running create-virtualenv step. 07:09:30 INFO - Running pre-action listener: _resource_record_pre_action 07:09:30 INFO - Running main action method: create_virtualenv 07:09:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:09:30 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 07:09:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:09:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:09:30 INFO - Using real prefix '/usr' 07:09:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:09:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:09:33 INFO - Installing pip.................done. 07:09:33 INFO - Return code: 0 07:09:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 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 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:33 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 07:09:33 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 07:09:33 INFO - Using env: {'DISPLAY': ':0', 07:09:33 INFO - 'HOME': '/home/cltbld', 07:09:33 INFO - 'LANG': 'en_US.UTF-8', 07:09:33 INFO - 'LANGUAGE': 'en_US:en', 07:09:33 INFO - 'LOGNAME': 'cltbld', 07:09:33 INFO - 'MAIL': '/var/mail/cltbld', 07:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:33 INFO - 'MOZ_NO_REMOTE': '1', 07:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:33 INFO - 'NO_EM_RESTART': '1', 07:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:33 INFO - 'PWD': '/builds/slave/test', 07:09:33 INFO - 'SHELL': '/bin/bash', 07:09:33 INFO - 'SHLVL': '1', 07:09:33 INFO - 'TERM': 'linux', 07:09:33 INFO - 'TMOUT': '86400', 07:09:33 INFO - 'USER': 'cltbld', 07:09:33 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:33 INFO - '_': '/tools/buildbot/bin/python'} 07:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:33 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 07:09:33 INFO - Cleaning up... 07:09:33 INFO - Return code: 0 07:09:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:33 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 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:33 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 07:09:33 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 07:09:33 INFO - Using env: {'DISPLAY': ':0', 07:09:33 INFO - 'HOME': '/home/cltbld', 07:09:33 INFO - 'LANG': 'en_US.UTF-8', 07:09:33 INFO - 'LANGUAGE': 'en_US:en', 07:09:33 INFO - 'LOGNAME': 'cltbld', 07:09:33 INFO - 'MAIL': '/var/mail/cltbld', 07:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:33 INFO - 'MOZ_NO_REMOTE': '1', 07:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:33 INFO - 'NO_EM_RESTART': '1', 07:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:33 INFO - 'PWD': '/builds/slave/test', 07:09:33 INFO - 'SHELL': '/bin/bash', 07:09:33 INFO - 'SHLVL': '1', 07:09:33 INFO - 'TERM': 'linux', 07:09:33 INFO - 'TMOUT': '86400', 07:09:33 INFO - 'USER': 'cltbld', 07:09:33 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:33 INFO - '_': '/tools/buildbot/bin/python'} 07:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:33 INFO - Downloading/unpacking psutil>=3.1.1 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:33 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 07:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:35 INFO - Installing collected packages: psutil 07:09:35 INFO - Running setup.py install for psutil 07:09:35 INFO - building 'psutil._psutil_linux' extension 07:09:35 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 07:09: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 07:09:35 INFO - building 'psutil._psutil_posix' extension 07:09: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 07:09: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 07:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:09:36 INFO - Successfully installed psutil 07:09:36 INFO - Cleaning up... 07:09:36 INFO - Return code: 0 07:09:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:36 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 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:36 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 07:09:36 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 07:09:36 INFO - Using env: {'DISPLAY': ':0', 07:09:36 INFO - 'HOME': '/home/cltbld', 07:09:36 INFO - 'LANG': 'en_US.UTF-8', 07:09:36 INFO - 'LANGUAGE': 'en_US:en', 07:09:36 INFO - 'LOGNAME': 'cltbld', 07:09:36 INFO - 'MAIL': '/var/mail/cltbld', 07:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:36 INFO - 'MOZ_NO_REMOTE': '1', 07:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:36 INFO - 'NO_EM_RESTART': '1', 07:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:36 INFO - 'PWD': '/builds/slave/test', 07:09:36 INFO - 'SHELL': '/bin/bash', 07:09:36 INFO - 'SHLVL': '1', 07:09:36 INFO - 'TERM': 'linux', 07:09:36 INFO - 'TMOUT': '86400', 07:09:36 INFO - 'USER': 'cltbld', 07:09:36 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:36 INFO - '_': '/tools/buildbot/bin/python'} 07:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:09:38 INFO - Installing collected packages: mozsystemmonitor 07:09:38 INFO - Running setup.py install for mozsystemmonitor 07:09:38 INFO - Successfully installed mozsystemmonitor 07:09:38 INFO - Cleaning up... 07:09:38 INFO - Return code: 0 07:09:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:09:38 INFO - Using env: {'DISPLAY': ':0', 07:09:38 INFO - 'HOME': '/home/cltbld', 07:09:38 INFO - 'LANG': 'en_US.UTF-8', 07:09:38 INFO - 'LANGUAGE': 'en_US:en', 07:09:38 INFO - 'LOGNAME': 'cltbld', 07:09:38 INFO - 'MAIL': '/var/mail/cltbld', 07:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:38 INFO - 'MOZ_NO_REMOTE': '1', 07:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:38 INFO - 'NO_EM_RESTART': '1', 07:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:38 INFO - 'PWD': '/builds/slave/test', 07:09:38 INFO - 'SHELL': '/bin/bash', 07:09:38 INFO - 'SHLVL': '1', 07:09:38 INFO - 'TERM': 'linux', 07:09:38 INFO - 'TMOUT': '86400', 07:09:38 INFO - 'USER': 'cltbld', 07:09:38 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:38 INFO - '_': '/tools/buildbot/bin/python'} 07:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:38 INFO - Downloading/unpacking jsonschema==2.5.1 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:09:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09: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 07:09:40 INFO - Downloading functools32-3.2.3-2.tar.gz 07:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:09:40 INFO - warning: no files found matching '*.txt' 07:09:40 INFO - no previously-included directories found matching 'build' 07:09:40 INFO - no previously-included directories found matching 'dist' 07:09:40 INFO - no previously-included directories found matching '.git*' 07:09:40 INFO - Installing collected packages: jsonschema, functools32 07:09:41 INFO - Running setup.py install for functools32 07:09:41 INFO - warning: no files found matching '*.txt' 07:09:41 INFO - no previously-included directories found matching 'build' 07:09:41 INFO - no previously-included directories found matching 'dist' 07:09:41 INFO - no previously-included directories found matching '.git*' 07:09:41 INFO - Successfully installed jsonschema functools32 07:09:41 INFO - Cleaning up... 07:09:41 INFO - Return code: 0 07:09:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:09:41 INFO - Using env: {'DISPLAY': ':0', 07:09:41 INFO - 'HOME': '/home/cltbld', 07:09:41 INFO - 'LANG': 'en_US.UTF-8', 07:09:41 INFO - 'LANGUAGE': 'en_US:en', 07:09:41 INFO - 'LOGNAME': 'cltbld', 07:09:41 INFO - 'MAIL': '/var/mail/cltbld', 07:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:41 INFO - 'MOZ_NO_REMOTE': '1', 07:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:41 INFO - 'NO_EM_RESTART': '1', 07:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:41 INFO - 'PWD': '/builds/slave/test', 07:09:41 INFO - 'SHELL': '/bin/bash', 07:09:41 INFO - 'SHLVL': '1', 07:09:41 INFO - 'TERM': 'linux', 07:09:41 INFO - 'TMOUT': '86400', 07:09:41 INFO - 'USER': 'cltbld', 07:09:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:41 INFO - '_': '/tools/buildbot/bin/python'} 07:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:09:41 INFO - Cleaning up... 07:09:41 INFO - Return code: 0 07:09:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:09:41 INFO - Using env: {'DISPLAY': ':0', 07:09:41 INFO - 'HOME': '/home/cltbld', 07:09:41 INFO - 'LANG': 'en_US.UTF-8', 07:09:41 INFO - 'LANGUAGE': 'en_US:en', 07:09:41 INFO - 'LOGNAME': 'cltbld', 07:09:41 INFO - 'MAIL': '/var/mail/cltbld', 07:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:41 INFO - 'MOZ_NO_REMOTE': '1', 07:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:41 INFO - 'NO_EM_RESTART': '1', 07:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:41 INFO - 'PWD': '/builds/slave/test', 07:09:41 INFO - 'SHELL': '/bin/bash', 07:09:41 INFO - 'SHLVL': '1', 07:09:41 INFO - 'TERM': 'linux', 07:09:41 INFO - 'TMOUT': '86400', 07:09:41 INFO - 'USER': 'cltbld', 07:09:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:41 INFO - '_': '/tools/buildbot/bin/python'} 07:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:41 INFO - Downloading/unpacking blobuploader==1.2.4 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:43 INFO - Downloading blobuploader-1.2.4.tar.gz 07:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:09:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:09:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:44 INFO - Downloading docopt-0.6.1.tar.gz 07:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:09:44 INFO - Installing collected packages: blobuploader, requests, docopt 07:09:44 INFO - Running setup.py install for blobuploader 07:09:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:09:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:09:44 INFO - Running setup.py install for requests 07:09:44 INFO - Running setup.py install for docopt 07:09:44 INFO - Successfully installed blobuploader requests docopt 07:09:44 INFO - Cleaning up... 07:09:44 INFO - Return code: 0 07:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:44 INFO - Using env: {'DISPLAY': ':0', 07:09:44 INFO - 'HOME': '/home/cltbld', 07:09:44 INFO - 'LANG': 'en_US.UTF-8', 07:09:44 INFO - 'LANGUAGE': 'en_US:en', 07:09:44 INFO - 'LOGNAME': 'cltbld', 07:09:44 INFO - 'MAIL': '/var/mail/cltbld', 07:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:44 INFO - 'MOZ_NO_REMOTE': '1', 07:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:44 INFO - 'NO_EM_RESTART': '1', 07:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:44 INFO - 'PWD': '/builds/slave/test', 07:09:44 INFO - 'SHELL': '/bin/bash', 07:09:44 INFO - 'SHLVL': '1', 07:09:44 INFO - 'TERM': 'linux', 07:09:44 INFO - 'TMOUT': '86400', 07:09:44 INFO - 'USER': 'cltbld', 07:09:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:44 INFO - '_': '/tools/buildbot/bin/python'} 07:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:45 INFO - Running setup.py (path:/tmp/pip-XW9o1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:45 INFO - Running setup.py (path:/tmp/pip-3zheXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:45 INFO - Running setup.py (path:/tmp/pip-56aRzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:45 INFO - Running setup.py (path:/tmp/pip-V3r0qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:45 INFO - Running setup.py (path:/tmp/pip-_dcfOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:45 INFO - Running setup.py (path:/tmp/pip-EM4RY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:45 INFO - Running setup.py (path:/tmp/pip-qz7y1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:45 INFO - Running setup.py (path:/tmp/pip-rPYVZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:45 INFO - Running setup.py (path:/tmp/pip-RsEZWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:45 INFO - Running setup.py (path:/tmp/pip-vqXz3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:45 INFO - Running setup.py (path:/tmp/pip-ldBUWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:45 INFO - Running setup.py (path:/tmp/pip-GbK9SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:45 INFO - Running setup.py (path:/tmp/pip-_jfFKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:45 INFO - Running setup.py (path:/tmp/pip-Ga7JmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:46 INFO - Running setup.py (path:/tmp/pip-Wc9_0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:46 INFO - Running setup.py (path:/tmp/pip-V8yuMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:46 INFO - Running setup.py (path:/tmp/pip-_KQHz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:09:46 INFO - Running setup.py install for manifestparser 07:09:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:09:46 INFO - Running setup.py install for mozcrash 07:09:46 INFO - Running setup.py install for mozdebug 07:09:46 INFO - Running setup.py install for mozdevice 07:09:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:09:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:09:46 INFO - Running setup.py install for mozfile 07:09:46 INFO - Running setup.py install for mozhttpd 07:09:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:09:46 INFO - Running setup.py install for mozinfo 07:09:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:09:46 INFO - Running setup.py install for mozInstall 07:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozleak 07:09:47 INFO - Running setup.py install for mozlog 07:09:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for moznetwork 07:09:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozprocess 07:09:47 INFO - Running setup.py install for mozprofile 07:09:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozrunner 07:09:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:09:47 INFO - Running setup.py install for mozscreenshot 07:09:47 INFO - Running setup.py install for moztest 07:09:47 INFO - Running setup.py install for mozversion 07:09:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:09:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:09:48 INFO - Cleaning up... 07:09:48 INFO - Return code: 0 07:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:48 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 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:48 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 07:09:48 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 07:09:48 INFO - Using env: {'DISPLAY': ':0', 07:09:48 INFO - 'HOME': '/home/cltbld', 07:09:48 INFO - 'LANG': 'en_US.UTF-8', 07:09:48 INFO - 'LANGUAGE': 'en_US:en', 07:09:48 INFO - 'LOGNAME': 'cltbld', 07:09:48 INFO - 'MAIL': '/var/mail/cltbld', 07:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:48 INFO - 'MOZ_NO_REMOTE': '1', 07:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:48 INFO - 'NO_EM_RESTART': '1', 07:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:48 INFO - 'PWD': '/builds/slave/test', 07:09:48 INFO - 'SHELL': '/bin/bash', 07:09:48 INFO - 'SHLVL': '1', 07:09:48 INFO - 'TERM': 'linux', 07:09:48 INFO - 'TMOUT': '86400', 07:09:48 INFO - 'USER': 'cltbld', 07:09:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:48 INFO - '_': '/tools/buildbot/bin/python'} 07:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:09:48 INFO - Running setup.py (path:/tmp/pip-kQKruW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:09:48 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)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:09:48 INFO - Running setup.py (path:/tmp/pip-hYWueC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:09:48 INFO - Running setup.py (path:/tmp/pip-Qi2j_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:09:48 INFO - Running setup.py (path:/tmp/pip-u8pdrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:09:48 INFO - Running setup.py (path:/tmp/pip-RPAQLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:09:48 INFO - Running setup.py (path:/tmp/pip-GJRC5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:09:48 INFO - Running setup.py (path:/tmp/pip-RdCTn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:09:48 INFO - Running setup.py (path:/tmp/pip-Va8Z7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:09:48 INFO - Running setup.py (path:/tmp/pip-vf0YVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:09:48 INFO - Running setup.py (path:/tmp/pip-fv_BzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:09:49 INFO - Running setup.py (path:/tmp/pip-zYVgRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:09:49 INFO - Running setup.py (path:/tmp/pip-3or0ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:09:49 INFO - Running setup.py (path:/tmp/pip-6sP2l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:09:49 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:09:49 INFO - Running setup.py (path:/tmp/pip-_ZQ8RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:49 INFO - Running setup.py (path:/tmp/pip-Da1FPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:09:49 INFO - Running setup.py (path:/tmp/pip-I5hv1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:09:49 INFO - Running setup.py (path:/tmp/pip-Au0a9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:09:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:09:51 INFO - Downloading blessings-1.6.tar.gz 07:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:09:51 INFO - Installing collected packages: blessings 07:09:51 INFO - Running setup.py install for blessings 07:09:51 INFO - Successfully installed blessings 07:09:51 INFO - Cleaning up... 07:09:51 INFO - Return code: 0 07:09:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:09:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:51 INFO - Reading from file tmpfile_stdout 07:09:51 INFO - Current package versions: 07:09:51 INFO - argparse == 1.2.1 07:09:51 INFO - blessings == 1.6 07:09:51 INFO - blobuploader == 1.2.4 07:09:51 INFO - docopt == 0.6.1 07:09:51 INFO - functools32 == 3.2.3-2 07:09:51 INFO - jsonschema == 2.5.1 07:09:51 INFO - manifestparser == 1.1 07:09:51 INFO - mozInstall == 1.12 07:09:51 INFO - mozcrash == 0.17 07:09:51 INFO - mozdebug == 0.1 07:09:51 INFO - mozdevice == 0.48 07:09:51 INFO - mozfile == 1.2 07:09:51 INFO - mozhttpd == 0.7 07:09:51 INFO - mozinfo == 0.9 07:09:51 INFO - mozleak == 0.1 07:09:51 INFO - mozlog == 3.3 07:09:51 INFO - moznetwork == 0.27 07:09:51 INFO - mozprocess == 0.23 07:09:51 INFO - mozprofile == 0.28 07:09:51 INFO - mozrunner == 6.12 07:09:51 INFO - mozscreenshot == 0.1 07:09:51 INFO - mozsystemmonitor == 0.3 07:09:51 INFO - moztest == 0.7 07:09:51 INFO - mozversion == 1.4 07:09:51 INFO - psutil == 3.1.1 07:09:51 INFO - requests == 1.2.3 07:09:51 INFO - wsgiref == 0.1.2 07:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:09: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')]} 07:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09: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')]} 07:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:09:51 INFO - Using env: {'DISPLAY': ':0', 07:09:51 INFO - 'HOME': '/home/cltbld', 07:09:51 INFO - 'LANG': 'en_US.UTF-8', 07:09:51 INFO - 'LANGUAGE': 'en_US:en', 07:09:51 INFO - 'LOGNAME': 'cltbld', 07:09:51 INFO - 'MAIL': '/var/mail/cltbld', 07:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:51 INFO - 'MOZ_NO_REMOTE': '1', 07:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:51 INFO - 'NO_EM_RESTART': '1', 07:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:51 INFO - 'PWD': '/builds/slave/test', 07:09:51 INFO - 'SHELL': '/bin/bash', 07:09:51 INFO - 'SHLVL': '1', 07:09:51 INFO - 'TERM': 'linux', 07:09:51 INFO - 'TMOUT': '86400', 07:09:51 INFO - 'USER': 'cltbld', 07:09:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:51 INFO - '_': '/tools/buildbot/bin/python'} 07:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 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)) 07:09:52 INFO - Cleaning up... 07:09:52 INFO - Return code: 0 07:09:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, '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': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', '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 07:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:09:52 INFO - Using env: {'DISPLAY': ':0', 07:09:52 INFO - 'HOME': '/home/cltbld', 07:09:52 INFO - 'LANG': 'en_US.UTF-8', 07:09:52 INFO - 'LANGUAGE': 'en_US:en', 07:09:52 INFO - 'LOGNAME': 'cltbld', 07:09:52 INFO - 'MAIL': '/var/mail/cltbld', 07:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:09:52 INFO - 'MOZ_NO_REMOTE': '1', 07:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:09:52 INFO - 'NO_EM_RESTART': '1', 07:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:09:52 INFO - 'PWD': '/builds/slave/test', 07:09:52 INFO - 'SHELL': '/bin/bash', 07:09:52 INFO - 'SHLVL': '1', 07:09:52 INFO - 'TERM': 'linux', 07:09:52 INFO - 'TMOUT': '86400', 07:09:52 INFO - 'USER': 'cltbld', 07:09:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:09:52 INFO - '_': '/tools/buildbot/bin/python'} 07:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:09:52 INFO - Cleaning up... 07:09:52 INFO - Return code: 0 07:09:52 INFO - Running post-action listener: _resource_record_post_action 07:09:52 INFO - Running post-action listener: _start_resource_monitoring 07:09:52 INFO - Starting resource monitoring. 07:09:52 INFO - [mozharness: 2016-07-29 14:09:52.362169Z] Finished create-virtualenv step (success) 07:09:52 INFO - [mozharness: 2016-07-29 14:09:52.362615Z] Running install step. 07:09:52 INFO - Running pre-action listener: _resource_record_pre_action 07:09:52 INFO - Running main action method: install 07:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:09:52 INFO - Reading from file tmpfile_stdout 07:09:52 INFO - Detecting whether we're running mozinstall >=1.0... 07:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:09:52 INFO - Reading from file tmpfile_stdout 07:09:52 INFO - Output received: 07:09:52 INFO - Usage: mozinstall [options] installer 07:09:52 INFO - Options: 07:09:52 INFO - -h, --help show this help message and exit 07:09:52 INFO - -d DEST, --destination=DEST 07:09:52 INFO - Directory to install application into. [default: 07:09:52 INFO - "/builds/slave/test"] 07:09:52 INFO - --app=APP Application being installed. [default: firefox] 07:09:52 INFO - mkdir: /builds/slave/test/build/application 07:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:10:10 INFO - Reading from file tmpfile_stdout 07:10:13 INFO - Output received: 07:10:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:10:13 INFO - Running post-action listener: _resource_record_post_action 07:10:13 INFO - [mozharness: 2016-07-29 14:10:13.638345Z] Finished install step (success) 07:10:13 INFO - [mozharness: 2016-07-29 14:10:13.638603Z] Running run-tests step. 07:10:13 INFO - Running pre-action listener: _resource_record_pre_action 07:10:13 INFO - Running main action method: run_tests 07:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:10:13 INFO - Python 2.7.3 07:10:13 INFO - Return code: 0 07:10:13 INFO - grabbing minidump binary from tooltool 07:10: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')]} 07:10:13 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 0xfb13b0>, '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 0xfb22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:10:13 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 07:10:13 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 07:10:13 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 07:10:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:10:13 INFO - Return code: 0 07:10:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:10:13 INFO - Using env: {'DISPLAY': ':0', 07:10:13 INFO - 'HOME': '/home/cltbld', 07:10:13 INFO - 'LANG': 'en_US.UTF-8', 07:10:13 INFO - 'LANGUAGE': 'en_US:en', 07:10:13 INFO - 'LOGNAME': 'cltbld', 07:10:13 INFO - 'MAIL': '/var/mail/cltbld', 07:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:13 INFO - 'MOZ_NO_REMOTE': '1', 07:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:13 INFO - 'NO_EM_RESTART': '1', 07:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:10:13 INFO - 'PWD': '/builds/slave/test', 07:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:10:13 INFO - 'SHELL': '/bin/bash', 07:10:13 INFO - 'SHLVL': '1', 07:10:13 INFO - 'TERM': 'linux', 07:10:13 INFO - 'TMOUT': '86400', 07:10:13 INFO - 'USER': 'cltbld', 07:10:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060', 07:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:13 INFO - '_': '/tools/buildbot/bin/python'} 07:10:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:10:13 INFO - mozversion application_buildid: 20160729043004 07:10:13 INFO - mozversion application_changeset: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 07:10:13 INFO - mozversion application_display_name: Nightly 07:10:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:10:13 INFO - mozversion application_name: Firefox 07:10:13 INFO - mozversion application_remotingname: firefox 07:10:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:10:13 INFO - mozversion application_vendor: Mozilla 07:10:13 INFO - mozversion application_version: 50.0a1 07:10:13 INFO - mozversion platform_buildid: 20160729043004 07:10:13 INFO - mozversion platform_changeset: 2ea3d51ba1bb9f5c3b6921c43ea63f70b4fdf5d2 07:10:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:10:13 INFO - mozversion platform_version: 50.0a1 07:10:13 INFO - using testdate: 1469801413 07:10:13 INFO - actual date: 1469801413 07:10:13 INFO - starting webserver on 'localhost:35607' 07:10:13 INFO - SUITE-START | Running 2 tests 07:10:13 INFO - TEST-START | dromaeo_css 07:10:13 INFO - operating with platform_type : linux_ 07:10:13 INFO - Initialising browser for dromaeo_css test... 07:10:13 INFO - TEST-INFO | started process 15509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmDVHaS/profile http://localhost:35607/getInfo.html) 07:10:18 INFO - PROCESS | 15509 | JavaScript error: , line 0: uncaught exception: undefined 07:10:20 INFO - PROCESS | 15509 | __metrics Screen width/height:1600/1200 07:10:20 INFO - PROCESS | 15509 | colorDepth:24 07:10:20 INFO - PROCESS | 15509 | Browser inner width/height: 1024/697 07:10:20 INFO - PROCESS | 15509 | __metrics 07:10:22 ERROR - PROCESS | 15509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:10:23 INFO - TEST-INFO | 15509: exit 0 07:10:23 INFO - Browser initialized. 07:10:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:10:23 INFO - TEST-INFO | started process 15631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmDVHaS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:10:35 INFO - PROCESS | 15631 | RSS: Main: 164806656 07:10:35 INFO - PROCESS | 15631 | 07:11:24 INFO - PROCESS | 15631 | 1469801484720 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] 07:13:33 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35607/tests/dromaeo/cssquery-ext.html) 07:13:34 INFO - PROCESS | 15631 | RSS: Main: 170541056 07:13:34 INFO - PROCESS | 15631 | 07:16:36 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-ext.html (next: http://localhost:35607/tests/dromaeo/cssquery-jquery.html) 07:16:37 INFO - PROCESS | 15631 | RSS: Main: 166383616 07:16:37 INFO - PROCESS | 15631 | 07:19:38 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35607/tests/dromaeo/cssquery-mootools.html) 07:19:39 INFO - PROCESS | 15631 | RSS: Main: 171565056 07:19:39 INFO - PROCESS | 15631 | 07:22:41 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35607/tests/dromaeo/cssquery-prototype.html) 07:22:41 INFO - PROCESS | 15631 | RSS: Main: 164978688 07:22:41 INFO - PROCESS | 15631 | 07:25:44 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35607/tests/dromaeo/cssquery-yui.html) 07:25:45 INFO - PROCESS | 15631 | RSS: Main: 167780352 07:25:45 INFO - PROCESS | 15631 | 07:28:47 INFO - PROCESS | 15631 | Cycle 1(1): loaded http://localhost:35607/tests/dromaeo/cssquery-yui.html (next: http://localhost:35607/tests/dromaeo/cssquery-dojo.html) 07:28:48 INFO - PROCESS | 15631 | RSS: Main: 171450368 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | __start_tp_report 07:28:48 INFO - PROCESS | 15631 | _x_x_mozilla_page_load 07:28:48 INFO - PROCESS | 15631 | _x_x_mozilla_page_load_details 07:28:48 INFO - PROCESS | 15631 | |i|pagename|runs| 07:28:48 INFO - PROCESS | 15631 | |0;dojo.html;3102.751779857612;3103.1621462205203;3131.9530207046882;3136.6392864820546;3138.6076740407448;5233.9793740220675;5366.382865970415;5371.19432085187;5448.700321482317;5483;5426.647267927582;5432.972835135819;5464.207689884975;5486.506214440709;5489.39616642169;4937.530934561211;4998.225275082368;5018.949810501885;5043.773030213649;5119.872003199913;5057.443681195065;5086.821961231358;5090.312807770959;5128.2564028216075;5142.717150556718;4840.128776820188;4885.584725298354;4908.97545512272;4914.262860570907;4941.654084214107;4997.775100120467;4999.8500044998345;5002.074616196015;5062.898742025176;5075.492450754932;4940.604751619861;4959.727215003173;4970.87572810679;5026.648134630577;5046.495350464961;5218.895622087537;5384;5461.617686761928;5508.531774799147;5527.419620939824;5829.09649004405;5836;5849.736761845727;5862.97068514659;5887.705614719247;5845.269341332333;5864.501517370986;5864.824055278348;5865.530757539386;5879.470847623692;5172.431032586413;5323.920141197924;5345.786168553292;5440.319960004999;5451.809186678447;5898.321693005273;5904.911426328608;5941;5987.072003839412;6006.039033754579;5739.885202295931;5742.741576628978;5751.6549007058875;5755.827325180251;5761;5536.972315138399;5747.540196784247;5795;5798.188253644493;5801.274840644919;5467.781288748485;5687.971560142173;5791.536677065825;5815.534757219412;5835.095560188178;5809.331926828384;5810.302763668303;5823.88352232953;5835.912461313083;5843.386444423274;4302.827886884552;4477.059817438374;4487.237169681162;4489.595936365743;4541.318802179633;3911.02224443889;3925.0776067624083;3948.861789837342;3960.20795840833;4007.0583412897945;5410.48600382963;5410.59420543453;5439.809606663748;5463.836084917459;5489.368722596872;5621.156826476062;5840.591158618856;5846.035404158351;5852.882942341129;5858.941410585925;5383.596230282745;5390.326209223847;5423.83728488146;5517.917231241535;5533.501984821385;4656.998745269783;4668.416447944007;4671.532846715301;4673.065386922629;4675.906481870344;5761.942380576224;6072.939270607238;6078.6048906820915;6079.118527813531;6084.178635884187;5711.857203569944;5797.2173756542325;5826.271716035496;5831.79588714393;5859.121131830259;6008.429199226067;6010.128531363015;6030.336662966983;6065.272167339947;6098.176746139392;5491.890162196813;5716.8570785729025;5731.426857314235;5820.621659592113;5822.359540450631;5736.741846616829;5787.623804452697;5844.824655260349;5847.06446968483;5914.792982245601;5666.178404131296;5673.971630141823;5690.231818704422;5701.743421545957;5745.626534275259;5428.104362780097;5660.29246344207;5678;5678.432156784289;5683;5547.778088876561;5640.407757185437;5644.153376993484;5666.9716651416475;5696.088625819849;5699.943000569941;5703.058995265735;5740.971295143498;5765.5675824314185;5792.5655575832825;5363.919541206963;5529.032419326682;5643.407442218508;5648.039833228443;5663.32040155184 07:28:48 INFO - PROCESS | 15631 | |1;ext.html;547.7728581452178;583.6760597868184;593.1725243285616;607.8541150123971;633.091513677872;38795.61204387959;42012.369814452766;42116.157676846444;42148.789256053715;42180;42323.57676423235;42348.15303693924;42695.14609707804;42752;42783.35824962628;8790.604422800989;8832;8835.646574137027;8842.46945183291;8886.377953543255;8833.867491987594;8846.292296616255;8919.598618062171;8944.418612790181;8959.5968181432;8940.19538241558;8958.955205223965;8973.77565560863;8984.775380615472;9002.054784247657;8937.50843703596;8952.373333866632;8966.193042626162;8977.057408972061;9006.144416280444;8776.736697899074;8841.513716745576;8851.159139881702;8864.468131912106;8867.246284065863;40995.38506922399;41373.58626413727;41472;41766.16467670629;41880.58119418828;3548.308079924416;3699.315626609086;3712.480252764615;3830.3871380579253;4424.491183513905;31333;32273.677263227535;32404.675953240403;32545.837270813732;32657.183570410692;4266.957330426687;4421.491528474235;4437.378766972626;4459.464864216315;4565.406497155382;351255;351617;355651;356238;356600;56368.43631563714;56916.43083569111;56974.14538781922;57055.71472142613;57070.42929570734;59158.40841591615;59387.40612593905;59505.70247148736;59534.40465595289;59539.40460595425;15723.135227562594;15841.52475425739;15896.284667190004;15925.601859953595;15928.840711592737;12138.211016283913;12178.086643501772;12183.086268529718;12231.327276999851;12239.69400764988;14656.267186640625;15577.376904923676;15796.36814527429;15851.286692098884;15929.761053584205;6604.877170880962;6676.699548520328;6748.797536073926;6764.647070585903;6964.79105626832;954.9522523873778;1085.3054045410786;1099.2085698297212;1182.9349385783692;1201.8377519034818;33117.834410828276;33512;33606;33724.83137584345;34189;1121.6466812953893;1131.5530365505579;1173.730042090324;1180.392098069495;1205.4394706461537;16626.91686541584;17411.73882391765;17845.910770446066;18096.276148953893;18554.387504737675;541127;544642;549937;551180;553130;58613.60397970169;59473;59538;59623;59722.70138649366;1373.4300265389952;1374.615107769826;1390.6731917999261;1406.1000959386001;1410.4710733474947;31211;33172.33655326832;33266.83366583152;33419.832900836314;33446.665533344356;50181;50690;50752.492475074774;50838.491615083374;50972;412298;412877;413982;414821;415026;27065.1880443587;27185;27411.588826168023;27439.862800685867;27519.44961100807;45316;45731.31403028891;46601.300980484644;46986.29520557263;47260.7636961813;40003.39994900021;40923.1815363697;41054.178916422105;42104.36843447412;42643.57356426396;41155;41462.58537414587;41682.166356673304;42002.57997419986;42127.15745685008;39142.60857391504;39267.80366098151;39731.40402893901;40032.799836001795;40831.38752918768;33789;35581;36207.63792362042;36557.817210914836;36601.45097823588;27880.024199152933;28168.29579260535;28192.295192619527;28297.858510707316;28299.292517687223 07:28:48 INFO - PROCESS | 15631 | |2;jquery.html;354.8828886467466;357.28364628919013;365.30227265922076;368.80269056055016;369.30386221971577;18517.16672749726;18887.811121888775;18916.81083189168;19010;19570.902145489254;18987;19069.332573359934;19129.808701912978;19528.31650892219;19597.118129684164;5358.142697168463;5554.694491802949;5820.796272130477;5871.765129394819;5902.88194236115;5591.161325801142;5751.1373294006025;5795.652260864341;5815.418458154193;5832.708364581775;5717.656940583557;5723.8569035774235;5769.913451298234;5802.245708057946;5803.129530570406;5742.397048309909;5743.942560574383;5793.159991801207;5799.072148456226;5803.477687008169;4988.628127265031;5043.798248070073;5072.619553533463;5074.213496907985;5103.948960510422;23225.76774232253;23235;23282.417939551648;23576.29271121852;23709.288721338387;2379.3932547200525;2486.154707399493;2625.3830349867767;2783.9721602784116;2921.9415611687646;14562.199079050648;14957.7756333654;14981.325840337211;15025.173615451145;15519.767203491956;1937.4381429385462;1945.445548018822;1956.8259044573285;2005.4785755703622;2038.9184432622678;76257.61871190609;78875;79293.60353198196;80720.59639701764;80743.59628201822;9806.313558050868;9812.116909478182;10110.69667909964;10212.795744085077;10437.634682786218;13805.447782088804;13805.930970345285;13816.861831381557;13832;13838.93080534611;7508.812279693051;7734.883976740353;7745.302922736981;7958.164392738795;7962.3630109591095;7407.296306850841;7533.8116547086765;7656.196099409593;7721;7723.459357844897;6198.900549725137;6398.29618741938;6450.193725784277;6457.806265812033;6467.741290348427;1787.4190887961204;1796.0486928756786;1798.9550261243573;1828.9359872404402;1842.6130512592238;982.4203719805206;1002.7292630989592;1027.9486025698686;1035.9015893490107;1064.9520771565299;19972.700409493867;20429.897850510653;20501.89749051275;20669.379918602466;20781.272655456985;1033.379972016784;1043.4782608695652;1056.3397876327294;1065.5950738719237;1107.869972627931;10821.404822734825;11631.6510504685;11663.533458661559;11788.23376480526;11818.34999075042;462300;462384;464272;466368;467357;46946.53053469422;64252.678736606016;79086.74071381969;79585.60207198927;80814.59592701998;1011.716719318592;1017.4149863828476;1022.882368527614;1029.1149611334247;1036.5439206749006;16890.40883569069;17105.657886842444;17990.910045449687;18054.277828886698;18284.817151828312;29903.102906912827;35712.464313034805;42491.36262955996;42644;45150.096998060515;53132;54241.18638220509;55536.444635553125;60504;62260.377396225456;7252.238514955854;8110.675572977251;8318.667253309799;8345.624446900025;8440.620172092147;10247.795044099226;12315.26108433461;12378;12432.440540175532;12686.111972162229;10842.349459032483;10925.726856828644;11177.55289788432;11203.71990700239;11316.094712422822;10658.62694805678;10850.837237441287;10955.945220273848;10973.177011723992;11017.889821101686;10838.694198269288;10896.128309735044;11186.944065279622;11246.493907774333;11424.428778561205;7689.3464055555905;7761.689532418866;7780.727674531364;7850.842983140191;7959.5622240775;8300.2114799094;10434.37393756377;10798.406087665255;10836.13310935139;11058.889411105785 07:28:48 INFO - PROCESS | 15631 | |3;mootools.html;1489.2702575737892;1516.7573188289873;1616.369615849818;1746.5982823950483;1766.0639860873741;7628.771136865889;8931.955340223307;8958.820823583532;9599.856002159964;9606.663766768164;9078.092190780935;9262.444253344804;9324.906750932489;9402.153806157445;9421.52892355383;2350.929472115831;2371;2380.27401642499;2384.618461046233;2408.1330720940537;2324.662923876037;2355.105060077168;2378.357843382286;2394.114177754225;2397.4965257295903;2378.643203519477;2380.238323736405;2398.46034642205;2404.158544509425;2408.638704194367;2344.7069116360453;2346.3430239532872;2354.764523547649;2360.7049118860227;2392.5454163709014;2250.6849041134255;2260.2315212827552;2266.626006708891;2269.580127676385;2278.270953294946;9263.166315031613;9387.295952803499;9389.295802814817;9451.196648284904;9451.527423628791;5111.207762796736;5125.846224613268;5142.228665700138;5237.3453318335205;5343.385510666284;3396.1679388549965;3412.6246112927556;3419.333230020147;3455.671711187433;3465.9653403465895;1111.5387114347536;1117.742919128605;1119.2109562758235;1124.2579897267847;1151.3437340715795;13103.541376051793;13122.409491572902;13128.409221585052;13212.33938303081;13220.405081771343;4416.3596278539435;4494.37078808967;4634.72191668501;4637.211674015425;4664.813407463731;10894.291871028516;10962.56149754001;10991.835122473169;10993.065589424828;11032.44837758109;5360.3299587551555;5395.406505284415;5395.81114660985;5411.64824286428;5423.267858839085;4081.6326530612387;4830.516948305141;4939.456659767423;4952.925706114411;4970.030843985461;3842.9423558646645;3981.8208180631364;4027.154297597479;4047.473828402348;4125.608067233608;1266.2402558464848;1267.2649863079391;1275.2603489975793;1285.1517998121194;1303.4655791125592;926.9165775080276;1003.4280460137652;1011.9696409107738;1028.1466382902174;1053.536443964653;6289.433950944345;6312.5581209314905;6439.710213040425;6487.416132548094;6517.250516190604;438.17841547099187;439.20723094814167;444.04751807373003;444.55766512320446;448.37227880966907;3894.5131858517684;4078.5921407858978;4110.116324990082;4118.258713431551;4118.485189351331;11242.269252498561;11583;11689.88310116888;11713.88286117128;11719.12106592009;11587.826182607268;11602.76794464106;11603;11673.124515661359;11673.76652466946;8490.448120872;8653.17794809492;8653.350998675125;8722.778810966469;8723.302135829119;6208.596441231305;6244.781432650017;6325.841853953688;6326.240851097898;6436.485081193399;10542.314749541256;10749.355038697704;10750.569977200825;10750.946245268724;10819.404932728776;10716;10729.141668666332;10780.245382823126;10820.89179108199;10933.125349971824;6838.350356716104;7819.8436031277915;8019.478733882279;8095.907052547831;8175.509469431853;8875.112488751074;8905.109489051301;8972.461652300883;8977.730668079968;8995.055519170393;7631.38948884099;7654.387648988179;7753.1859154787935;7841.098273698598;7935.928649632226;7601.353884919844;7659;7705.345045671181;7706.884396734165;7840.607969601611;7200.855982880418;7319.670614822239;7319.719049166268;7326.743563975236;7329.853402932018;5559.444055594408;5597.5521958242425;5679.261695979496;5686.545076393962;5804.82585522435;5369.409364969928;5382.246485492113;5455.8363249102595;5469.535089517435;5578.748956296895 07:28:48 INFO - PROCESS | 15631 | |4;prototype.html;306.03141058549693;310.49854485006693;310.5977758802349;317.52371442835744;320.60245295833175;5544.584156188282;5559.416261292557;5581.162825576161;5597.824456864063;5663.745131469083;5429.429909859467;5480.588955828319;5487.6158668893195;5493.176023596463;5518.310211223597;4069.511658600972;4161.812718427663;4238.194742998836;4281.100968796556;4282.614564689177;4265.424167737347;4272.33778764292;4272.46594175728;4276.199089596319;4276.882942943232;4235.0682849773;4264.317709166534;4276.828926842923;4280.764557949312;4334.913301733964;4049.372347286175;4139.77231252281;4233.407322974786;4252.319628859368;4316.892077698051;3714.220013797106;3718.3307004739136;3720.795356255405;3726.981365093184;3727.7447144477474;5324.840254792362;5332.280142180794;5338.813141540067;5362.544183744387;5381.461853814626;4636.629069674452;4780.784864681098;4860.902781944376;4874.122657921573;4881.316615673809;5643.589102724319;5648.526156413817;5649.435056494359;5664.178694089375;5684.374718780972;4077.1641813428473;4094.1811637672586;4096.938545921814;4100.835966561334;4100.91798164035;5890.97054514729;5908.67502287374;5964.314103878066;5976.880462390728;6013.819585412444;4138.379243113557;4147.129102888427;4168.6665066794585;4173.5409104998425;4187.701812438154;4247.918519925276;4248.553901840324;4261.87214383569;4270.274053410928;4276.935845962313;4716.716996980193;4804.183288840905;4821.349117869043;4889.779959901813;4893.21708526634;5682.971585142131;5690.2887139107615;5699;5731.856703582361;5740.512056475163;1434.0105327324113;1450.8911831612672;1453.2007395932194;1456.7086582683505;1466.1862666220136;874.4622057434632;888.1030159538913;890.2566357091771;894.9529051010334;991.2615101749243;5490.862728431821;5496.340439147328;5504.587155963319;5540.529055030368;5545.306836645419;5833.649981001154;5858.941410585925;5880.558958078162;5882.058870580687;5897.997340452133;5342.09698283399;5354.651947623392;5423.945760542423;5446.7276636168035;5497.47773961481;3083;3106.9223269417994;3121.204092956282;3121.609798775153;3141.3560220154814;5782.479576838021;6026.668533230714;6060.545459090586;6078.300995385499;6118.388161183846;6021.819345419644;6086.604370715978;6094.8171554853425;6096.664683442454;6108.633481991094;6161.106639537332;6212.844678882973;6222.564420490522;6223.128761973237;6236.407541283571;5652.7173641318595;5903.704814759159;5942.58401911862;5944.524438045032;6004.309504407049;5879.647221166743;5925.4370834770625;5928.9110663339225;5936.910946335895;5946.316173640087;5895.351511333835;6138.355472675305;6139.079138129317;6207.968960155351;6236.158118653923;4154.376843473382;4158.500979882433;4164.1267525407375;4176.43618111551;4191.182719369694;5919.526437884872;5946.851328716643;5952.255968003999;5955.6724380157775;6049.487628092977;5685.431456854281;5729.398413166724;5786.247787787561;5792.768289268551;5805.187273781758;5743.167240750151;5757;5761.942380576308;5771.249737534094;5787.594868359174;5198.818041368534;5651.689157096399;5674.631148975303;5696.316442026983;5705.515031222392;5775.768969241183;5787.6816775076095;5792.913106303325;5821.912671310019;5867.471927526543;5671.816350704926;5694.715264236855;5710.5146062585145;5731.570132240182;5796.246487956539 07:28:48 INFO - PROCESS | 15631 | |5;yui.html;769.1155171552714;780.5355813291089;821.7288294862695;844.370943646983;845.2513104382068;12589.559365422212;14512.709745805078;14795.630109247275;15477.458288959875;15647.295871685774;15678;15779;16570.591499722508;16595.087270200165;16620.168991550436;818.1940788323511;825.6821123867325;829.5893532701322;830.8338332333527;835.5780330932901;819.3813670678629;823.6293667849462;828.056016141599;829.1584042197175;829.4442723375353;891.1801142948503;891.3047822698273;892.5180402582598;895.3911340288602;896.4845214001942;863.8531449653542;866.441145461174;875.8335916175906;884.6726711116896;887.1882227761623;644.8226737647137;645.7707513832569;646.3762469217181;646.424682032991;649.0167396394467;14384.712305753827;14533.563993080224;14596.12423254608;14604.05073670208;14613.415463381452;15297.464588739453;15359.385624575003;15393.923030384776;15980.4406845761;16039.27823247945;12806.42371093303;12906.225626462348;12940.288284144368;13116.803247951288;13228.206307621478;4043.1711499142607;4061.614146656063;4096.672266218696;4203.26442872496;4232.746035237896;78056.21943780604;78101;78623.6068819658;79420.60289698573;80056;12219.266843989211;12233.877661223274;12293.446794894073;12410.627681169579;12458.190217636005;21088.894555527124;21105.78894211069;21114.261000864895;21126.366209013755;21248.575028499345;8129.593520323961;8424.957875210584;8644.135586441305;8709.259712924346;8794.60424280909;4917.852464426073;5076.0863044652315;5088.236764485283;5202.583793296603;5245.449227831099;3593.4609808528407;3725.18046029873;3728;3747.775133491999;3750.3624383854262;640.2924768131242;651.5048563092084;653.4837478392112;654.2443477783168;654.3489228217953;607.802464199137;699.6361891816227;775.1279810213509;779.2363483785922;788.6332855222349;9391.624335026523;9837.950810245902;10358.067773900235;10498.947505262426;10623.52194151265;618.8421952402109;621.7979156774066;649.136648257816;657.4247533408268;658.8616390557941;4765.737884416321;4982.188625701341;5117.769700363493;5126.15418455958;5133.768980395891;98409.50795245978;101853.49073254586;114524;115280;116667.41666291615;59410.10884836731;75897;91769.0823091774;97294.5135274319;98340;63877;87499;87924.6811297831;88845;90295.54852225828;10108.292419530562;10171.7457063574;10476.319039262424;10526.10651358129;10565.154787617126;52213;52583.73708131435;52916.73541632421;52945.4705452956;53469.19796202982;68974.65512672404;77801;78833.60583197048;79975.80036299577;80095;12478.251304921734;12894.808913232915;13144.60566183016;13419.932900335436;13707.246101464516;13729.244891530661;14102.224377659328;14395.496157634432;14708.55874323772;14810.851891480947;13349.733005339645;14189.574312770634;14256.501022464165;14301;14590.489332873298;13761.31193440304;14438.711225775636;14452.277386130861;15135.394584216949;15232.543023709306;12751.681207969876;12841.614751557468;13839.584812455643;14227.359768810222;14642.633934151732;11517;11766.470508826953;11895.345755983504;12016.158868879094;12164.635060948185;11759.823602645796;12026.398680065786;12149.271043737404;12264.938675306566;12441.44013519412 07:28:48 INFO - PROCESS | 15631 | __end_tp_report 07:28:48 INFO - PROCESS | 15631 | __start_cc_report 07:28:48 INFO - PROCESS | 15631 | _x_x_mozilla_cycle_collect,333 07:28:48 INFO - PROCESS | 15631 | __end_cc_report 07:28:48 INFO - PROCESS | 15631 | __startTimestamp1469802528017__endTimestamp 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | ------- Summary: start ------- 07:28:48 INFO - PROCESS | 15631 | Number of tests: 6 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#0] dojo.html Cycles:165 Average:5391.40 Median:5621.16 stddev:620.82 (11.0%) stddev-sans-first:596.20 07:28:48 INFO - PROCESS | 15631 | Values: 3102.8 3103.2 3132.0 3136.6 3138.6 5234.0 5366.4 5371.2 5448.7 5483.0 5426.6 5433.0 5464.2 5486.5 5489.4 4937.5 4998.2 5018.9 5043.8 5119.9 5057.4 5086.8 5090.3 5128.3 5142.7 4840.1 4885.6 4909.0 4914.3 4941.7 4997.8 4999.9 5002.1 5062.9 5075.5 4940.6 4959.7 4970.9 5026.6 5046.5 5218.9 5384.0 5461.6 5508.5 5527.4 5829.1 5836.0 5849.7 5863.0 5887.7 5845.3 5864.5 5864.8 5865.5 5879.5 5172.4 5323.9 5345.8 5440.3 5451.8 5898.3 5904.9 5941.0 5987.1 6006.0 5739.9 5742.7 5751.7 5755.8 5761.0 5537.0 5747.5 5795.0 5798.2 5801.3 5467.8 5688.0 5791.5 5815.5 5835.1 5809.3 5810.3 5823.9 5835.9 5843.4 4302.8 4477.1 4487.2 4489.6 4541.3 3911.0 3925.1 3948.9 3960.2 4007.1 5410.5 5410.6 5439.8 5463.8 5489.4 5621.2 5840.6 5846.0 5852.9 5858.9 5383.6 5390.3 5423.8 5517.9 5533.5 4657.0 4668.4 4671.5 4673.1 4675.9 5761.9 6072.9 6078.6 6079.1 6084.2 5711.9 5797.2 5826.3 5831.8 5859.1 6008.4 6010.1 6030.3 6065.3 6098.2 5491.9 5716.9 5731.4 5820.6 5822.4 5736.7 5787.6 5844.8 5847.1 5914.8 5666.2 5674.0 5690.2 5701.7 5745.6 5428.1 5660.3 5678.0 5678.4 5683.0 5547.8 5640.4 5644.2 5667.0 5696.1 5699.9 5703.1 5741.0 5765.6 5792.6 5363.9 5529.0 5643.4 5648.0 5663.3 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#1] ext.html Cycles:180 Average:59787.12 Median:414923.50 stddev:118322.31 (28.5%) stddev-sans-first:118570.64 07:28:48 INFO - PROCESS | 15631 | Values: 547.8 583.7 593.2 607.9 633.1 38795.6 42012.4 42116.2 42148.8 42180.0 42323.6 42348.2 42695.1 42752.0 42783.4 8790.6 8832.0 8835.6 8842.5 8886.4 8833.9 8846.3 8919.6 8944.4 8959.6 8940.2 8959.0 8973.8 8984.8 9002.1 8937.5 8952.4 8966.2 8977.1 9006.1 8776.7 8841.5 8851.2 8864.5 8867.2 40995.4 41373.6 41472.0 41766.2 41880.6 3548.3 3699.3 3712.5 3830.4 4424.5 31333.0 32273.7 32404.7 32545.8 32657.2 4267.0 4421.5 4437.4 4459.5 4565.4 351255.0 351617.0 355651.0 356238.0 356600.0 56368.4 56916.4 56974.1 57055.7 57070.4 59158.4 59387.4 59505.7 59534.4 59539.4 15723.1 15841.5 15896.3 15925.6 15928.8 12138.2 12178.1 12183.1 12231.3 12239.7 14656.3 15577.4 15796.4 15851.3 15929.8 6604.9 6676.7 6748.8 6764.6 6964.8 955.0 1085.3 1099.2 1182.9 1201.8 33117.8 33512.0 33606.0 33724.8 34189.0 1121.6 1131.6 1173.7 1180.4 1205.4 16626.9 17411.7 17845.9 18096.3 18554.4 541127.0 544642.0 549937.0 551180.0 553130.0 58613.6 59473.0 59538.0 59623.0 59722.7 1373.4 1374.6 1390.7 1406.1 1410.5 31211.0 33172.3 33266.8 33419.8 33446.7 50181.0 50690.0 50752.5 50838.5 50972.0 412298.0 412877.0 413982.0 414821.0 415026.0 27065.2 27185.0 27411.6 27439.9 27519.4 45316.0 45731.3 46601.3 46986.3 47260.8 40003.4 40923.2 41054.2 42104.4 42643.6 41155.0 41462.6 41682.2 42002.6 42127.2 39142.6 39267.8 39731.4 40032.8 40831.4 33789.0 35581.0 36207.6 36557.8 36601.5 27880.0 28168.3 28192.3 28297.9 28299.3 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#2] jquery.html Cycles:180 Average:27540.04 Median:13044.34 stddev:76304.43 (585.0%) stddev-sans-first:76491.18 07:28:48 INFO - PROCESS | 15631 | Values: 354.9 357.3 365.3 368.8 369.3 18517.2 18887.8 18916.8 19010.0 19570.9 18987.0 19069.3 19129.8 19528.3 19597.1 5358.1 5554.7 5820.8 5871.8 5902.9 5591.2 5751.1 5795.7 5815.4 5832.7 5717.7 5723.9 5769.9 5802.2 5803.1 5742.4 5743.9 5793.2 5799.1 5803.5 4988.6 5043.8 5072.6 5074.2 5103.9 23225.8 23235.0 23282.4 23576.3 23709.3 2379.4 2486.2 2625.4 2784.0 2921.9 14562.2 14957.8 14981.3 15025.2 15519.8 1937.4 1945.4 1956.8 2005.5 2038.9 76257.6 78875.0 79293.6 80720.6 80743.6 9806.3 9812.1 10110.7 10212.8 10437.6 13805.4 13805.9 13816.9 13832.0 13838.9 7508.8 7734.9 7745.3 7958.2 7962.4 7407.3 7533.8 7656.2 7721.0 7723.5 6198.9 6398.3 6450.2 6457.8 6467.7 1787.4 1796.0 1799.0 1828.9 1842.6 982.4 1002.7 1027.9 1035.9 1065.0 19972.7 20429.9 20501.9 20669.4 20781.3 1033.4 1043.5 1056.3 1065.6 1107.9 10821.4 11631.7 11663.5 11788.2 11818.3 462300.0 462384.0 464272.0 466368.0 467357.0 46946.5 64252.7 79086.7 79585.6 80814.6 1011.7 1017.4 1022.9 1029.1 1036.5 16890.4 17105.7 17990.9 18054.3 18284.8 29903.1 35712.5 42491.4 42644.0 45150.1 53132.0 54241.2 55536.4 60504.0 62260.4 7252.2 8110.7 8318.7 8345.6 8440.6 10247.8 12315.3 12378.0 12432.4 12686.1 10842.3 10925.7 11177.6 11203.7 11316.1 10658.6 10850.8 10955.9 10973.2 11017.9 10838.7 10896.1 11186.9 11246.5 11424.4 7689.3 7761.7 7780.7 7850.8 7959.6 8300.2 10434.4 10798.4 10836.1 11058.9 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#3] mootools.html Cycles:180 Average:6031.74 Median:438.69 stddev:3545.26 (808.1%) stddev-sans-first:3538.77 07:28:48 INFO - PROCESS | 15631 | Values: 1489.3 1516.8 1616.4 1746.6 1766.1 7628.8 8932.0 8958.8 9599.9 9606.7 9078.1 9262.4 9324.9 9402.2 9421.5 2350.9 2371.0 2380.3 2384.6 2408.1 2324.7 2355.1 2378.4 2394.1 2397.5 2378.6 2380.2 2398.5 2404.2 2408.6 2344.7 2346.3 2354.8 2360.7 2392.5 2250.7 2260.2 2266.6 2269.6 2278.3 9263.2 9387.3 9389.3 9451.2 9451.5 5111.2 5125.8 5142.2 5237.3 5343.4 3396.2 3412.6 3419.3 3455.7 3466.0 1111.5 1117.7 1119.2 1124.3 1151.3 13103.5 13122.4 13128.4 13212.3 13220.4 4416.4 4494.4 4634.7 4637.2 4664.8 10894.3 10962.6 10991.8 10993.1 11032.4 5360.3 5395.4 5395.8 5411.6 5423.3 4081.6 4830.5 4939.5 4952.9 4970.0 3842.9 3981.8 4027.2 4047.5 4125.6 1266.2 1267.3 1275.3 1285.2 1303.5 926.9 1003.4 1012.0 1028.1 1053.5 6289.4 6312.6 6439.7 6487.4 6517.3 438.2 439.2 444.0 444.6 448.4 3894.5 4078.6 4110.1 4118.3 4118.5 11242.3 11583.0 11689.9 11713.9 11719.1 11587.8 11602.8 11603.0 11673.1 11673.8 8490.4 8653.2 8653.4 8722.8 8723.3 6208.6 6244.8 6325.8 6326.2 6436.5 10542.3 10749.4 10750.6 10750.9 10819.4 10716.0 10729.1 10780.2 10820.9 10933.1 6838.4 7819.8 8019.5 8095.9 8175.5 8875.1 8905.1 8972.5 8977.7 8995.1 7631.4 7654.4 7753.2 7841.1 7935.9 7601.4 7659.0 7705.3 7706.9 7840.6 7200.9 7319.7 7319.7 7326.7 7329.9 5559.4 5597.6 5679.3 5686.5 5804.8 5369.4 5382.2 5455.8 5469.5 5578.7 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#4] prototype.html Cycles:180 Average:4837.99 Median:5544.95 stddev:1444.87 (26.1%) stddev-sans-first:1408.32 07:28:48 INFO - PROCESS | 15631 | Values: 306.0 310.5 310.6 317.5 320.6 5544.6 5559.4 5581.2 5597.8 5663.7 5429.4 5480.6 5487.6 5493.2 5518.3 4069.5 4161.8 4238.2 4281.1 4282.6 4265.4 4272.3 4272.5 4276.2 4276.9 4235.1 4264.3 4276.8 4280.8 4334.9 4049.4 4139.8 4233.4 4252.3 4316.9 3714.2 3718.3 3720.8 3727.0 3727.7 5324.8 5332.3 5338.8 5362.5 5381.5 4636.6 4780.8 4860.9 4874.1 4881.3 5643.6 5648.5 5649.4 5664.2 5684.4 4077.2 4094.2 4096.9 4100.8 4100.9 5891.0 5908.7 5964.3 5976.9 6013.8 4138.4 4147.1 4168.7 4173.5 4187.7 4247.9 4248.6 4261.9 4270.3 4276.9 4716.7 4804.2 4821.3 4889.8 4893.2 5683.0 5690.3 5699.0 5731.9 5740.5 1434.0 1450.9 1453.2 1456.7 1466.2 874.5 888.1 890.3 895.0 991.3 5490.9 5496.3 5504.6 5540.5 5545.3 5833.6 5858.9 5880.6 5882.1 5898.0 5342.1 5354.7 5423.9 5446.7 5497.5 3083.0 3106.9 3121.2 3121.6 3141.4 5782.5 6026.7 6060.5 6078.3 6118.4 6021.8 6086.6 6094.8 6096.7 6108.6 6161.1 6212.8 6222.6 6223.1 6236.4 5652.7 5903.7 5942.6 5944.5 6004.3 5879.6 5925.4 5928.9 5936.9 5946.3 5895.4 6138.4 6139.1 6208.0 6236.2 4154.4 4158.5 4164.1 4176.4 4191.2 5919.5 5946.9 5952.3 5955.7 6049.5 5685.4 5729.4 5786.2 5792.8 5805.2 5743.2 5757.0 5761.9 5771.2 5787.6 5198.8 5651.7 5674.6 5696.3 5705.5 5775.8 5787.7 5792.9 5821.9 5867.5 5671.8 5694.7 5710.5 5731.6 5796.2 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - PROCESS | 15631 | [#5] yui.html Cycles:180 Average:20601.87 Median:4218.01 stddev:28717.70 (680.8%) stddev-sans-first:28759.64 07:28:48 INFO - PROCESS | 15631 | Values: 769.1 780.5 821.7 844.4 845.3 12589.6 14512.7 14795.6 15477.5 15647.3 15678.0 15779.0 16570.6 16595.1 16620.2 818.2 825.7 829.6 830.8 835.6 819.4 823.6 828.1 829.2 829.4 891.2 891.3 892.5 895.4 896.5 863.9 866.4 875.8 884.7 887.2 644.8 645.8 646.4 646.4 649.0 14384.7 14533.6 14596.1 14604.1 14613.4 15297.5 15359.4 15393.9 15980.4 16039.3 12806.4 12906.2 12940.3 13116.8 13228.2 4043.2 4061.6 4096.7 4203.3 4232.7 78056.2 78101.0 78623.6 79420.6 80056.0 12219.3 12233.9 12293.4 12410.6 12458.2 21088.9 21105.8 21114.3 21126.4 21248.6 8129.6 8425.0 8644.1 8709.3 8794.6 4917.9 5076.1 5088.2 5202.6 5245.4 3593.5 3725.2 3728.0 3747.8 3750.4 640.3 651.5 653.5 654.2 654.3 607.8 699.6 775.1 779.2 788.6 9391.6 9838.0 10358.1 10498.9 10623.5 618.8 621.8 649.1 657.4 658.9 4765.7 4982.2 5117.8 5126.2 5133.8 98409.5 101853.5 114524.0 115280.0 116667.4 59410.1 75897.0 91769.1 97294.5 98340.0 63877.0 87499.0 87924.7 88845.0 90295.5 10108.3 10171.7 10476.3 10526.1 10565.2 52213.0 52583.7 52916.7 52945.5 53469.2 68974.7 77801.0 78833.6 79975.8 80095.0 12478.3 12894.8 13144.6 13419.9 13707.2 13729.2 14102.2 14395.5 14708.6 14810.9 13349.7 14189.6 14256.5 14301.0 14590.5 13761.3 14438.7 14452.3 15135.4 15232.5 12751.7 12841.6 13839.6 14227.4 14642.6 11517.0 11766.5 11895.3 12016.2 12164.6 11759.8 12026.4 12149.3 12264.9 12441.4 07:28:48 INFO - PROCESS | 15631 | -------- Summary: end -------- 07:28:48 INFO - PROCESS | 15631 | 07:28:48 INFO - TEST-INFO | 15631: exit 0 07:28:48 INFO - TEST-OK | dromaeo_css | took 1114989ms 07:28:48 INFO - TEST-START | kraken 07:28:48 INFO - operating with platform_type : linux_ 07:28:48 INFO - Initialising browser for kraken test... 07:28:48 INFO - TEST-INFO | started process 15884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN6Ow1/profile http://localhost:35607/getInfo.html) 07:28:53 INFO - PROCESS | 15884 | JavaScript error: , line 0: uncaught exception: undefined 07:28:55 INFO - PROCESS | 15884 | __metrics Screen width/height:1600/1200 07:28:55 INFO - PROCESS | 15884 | colorDepth:24 07:28:55 INFO - PROCESS | 15884 | Browser inner width/height: 1024/697 07:28:55 INFO - PROCESS | 15884 | __metrics 07:28:56 ERROR - PROCESS | 15884 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:28:58 INFO - TEST-INFO | 15884: exit 0 07:28:58 INFO - Browser initialized. 07:28:58 INFO - Running cycle 1/1 for kraken test... 07:28:58 INFO - TEST-INFO | started process 16008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQN6Ow1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:09 INFO - PROCESS | 16008 | RSS: Main: 165224448 07:29:09 INFO - PROCESS | 16008 | 07:29:12 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35607/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:13 INFO - PROCESS | 16008 | RSS: Main: 170582016 07:29:13 INFO - PROCESS | 16008 | 07:29:15 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35607/tests/kraken/driver.html?testName=audio-dft) 07:29:16 INFO - PROCESS | 16008 | RSS: Main: 169881600 07:29:16 INFO - PROCESS | 16008 | 07:29:19 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35607/tests/kraken/driver.html?testName=audio-fft) 07:29:20 INFO - PROCESS | 16008 | RSS: Main: 165720064 07:29:20 INFO - PROCESS | 16008 | 07:29:22 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35607/tests/kraken/driver.html?testName=audio-oscillator) 07:29:22 INFO - PROCESS | 16008 | RSS: Main: 167149568 07:29:22 INFO - PROCESS | 16008 | 07:29:25 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35607/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:29:25 INFO - PROCESS | 16008 | RSS: Main: 167096320 07:29:25 INFO - PROCESS | 16008 | 07:29:28 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35607/tests/kraken/driver.html?testName=imaging-darkroom) 07:29:29 INFO - PROCESS | 16008 | RSS: Main: 168288256 07:29:29 INFO - PROCESS | 16008 | 07:29:32 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35607/tests/kraken/driver.html?testName=imaging-desaturate) 07:29:33 INFO - PROCESS | 16008 | RSS: Main: 167731200 07:29:33 INFO - PROCESS | 16008 | 07:29:36 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35607/tests/kraken/driver.html?testName=json-parse-financial) 07:29:36 INFO - PROCESS | 16008 | RSS: Main: 167903232 07:29:36 INFO - PROCESS | 16008 | 07:29:38 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35607/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:29:39 INFO - PROCESS | 16008 | RSS: Main: 167772160 07:29:39 INFO - PROCESS | 16008 | 07:29:40 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:29:41 INFO - PROCESS | 16008 | RSS: Main: 168169472 07:29:41 INFO - PROCESS | 16008 | 07:29:43 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:29:44 INFO - PROCESS | 16008 | RSS: Main: 168603648 07:29:44 INFO - PROCESS | 16008 | 07:29:46 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:29:47 INFO - PROCESS | 16008 | RSS: Main: 168599552 07:29:47 INFO - PROCESS | 16008 | 07:29:50 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:29:50 INFO - PROCESS | 16008 | RSS: Main: 168808448 07:29:50 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:35607/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35607/tests/kraken/driver.html?testName=ai-astar) 07:29:52 INFO - PROCESS | 16008 | RSS: Main: 169533440 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | __start_tp_report 07:29:52 INFO - PROCESS | 16008 | _x_x_mozilla_page_load 07:29:52 INFO - PROCESS | 16008 | _x_x_mozilla_page_load_details 07:29:52 INFO - PROCESS | 16008 | |i|pagename|runs| 07:29:52 INFO - PROCESS | 16008 | |0;ai-astar;102;113;105;111;111;112;111;111;111;111 07:29:52 INFO - PROCESS | 16008 | |1;audio-beat-detection;154;119;145;177;118;152;143;121;187;121 07:29:52 INFO - PROCESS | 16008 | |2;audio-dft;165;162;161;165;166;173;164;161;162;163 07:29:52 INFO - PROCESS | 16008 | |3;audio-fft;75;75;75;177;77;77;77;76;161;77 07:29:52 INFO - PROCESS | 16008 | |4;audio-oscillator;83;84;154;85;83;85;160;85;84;156 07:29:52 INFO - PROCESS | 16008 | |5;imaging-gaussian-blur;116;118;118;117;117;118;117;118;117;118 07:29:52 INFO - PROCESS | 16008 | |6;imaging-darkroom;149;147;146;146;148;147;147;147;148;148 07:29:52 INFO - PROCESS | 16008 | |7;imaging-desaturate;96;97;96;96;96;97;96;97;96;96 07:29:52 INFO - PROCESS | 16008 | |8;json-parse-financial;56;55;61;55;56;55;58;57;55;57 07:29:52 INFO - PROCESS | 16008 | |9;json-stringify-tinderbox;64;63;63;64;63;63;63;63;64;63 07:29:52 INFO - PROCESS | 16008 | |10;stanford-crypto-aes;80;90;77;78;77;77;77;76;82;76 07:29:52 INFO - PROCESS | 16008 | |11;stanford-crypto-ccm;124;139;133;124;126;129;129;130;166;122 07:29:52 INFO - PROCESS | 16008 | |12;stanford-crypto-pbkdf2;161;158;162;156;158;161;158;156;156;155 07:29:52 INFO - PROCESS | 16008 | |13;stanford-crypto-sha256-iterative;64;64;64;63;63;67;63;64;63;66 07:29:52 INFO - PROCESS | 16008 | __end_tp_report 07:29:52 INFO - PROCESS | 16008 | __start_cc_report 07:29:52 INFO - PROCESS | 16008 | _x_x_mozilla_cycle_collect,901 07:29:52 INFO - PROCESS | 16008 | __end_cc_report 07:29:52 INFO - PROCESS | 16008 | __startTimestamp1469802592820__endTimestamp 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | ------- Summary: start ------- 07:29:52 INFO - PROCESS | 16008 | Number of tests: 14 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.46 (3.1%) stddev-sans-first:2.24 07:29:52 INFO - PROCESS | 16008 | Values: 102.0 113.0 105.0 111.0 111.0 112.0 111.0 111.0 111.0 111.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:148.50 stddev:24.64 (16.6%) stddev-sans-first:25.85 07:29:52 INFO - PROCESS | 16008 | Values: 154.0 119.0 145.0 177.0 118.0 152.0 143.0 121.0 187.0 121.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:3.55 (2.2%) stddev-sans-first:3.76 07:29:52 INFO - PROCESS | 16008 | Values: 165.0 162.0 161.0 165.0 166.0 173.0 164.0 161.0 162.0 163.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.50 stddev:39.35 (51.4%) stddev-sans-first:41.09 07:29:52 INFO - PROCESS | 16008 | Values: 75.0 75.0 75.0 177.0 77.0 77.0 77.0 76.0 161.0 77.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:84.00 stddev:35.07 (41.7%) stddev-sans-first:36.20 07:29:52 INFO - PROCESS | 16008 | Values: 83.0 84.0 154.0 85.0 83.0 85.0 160.0 85.0 84.0 156.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 07:29:52 INFO - PROCESS | 16008 | Values: 116.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 07:29:52 INFO - PROCESS | 16008 | Values: 149.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 148.0 148.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:29:52 INFO - PROCESS | 16008 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:1.90 (3.4%) stddev-sans-first:2.01 07:29:52 INFO - PROCESS | 16008 | Values: 56.0 55.0 61.0 55.0 56.0 55.0 58.0 57.0 55.0 57.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 07:29:52 INFO - PROCESS | 16008 | Values: 64.0 63.0 63.0 64.0 63.0 63.0 63.0 63.0 64.0 63.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:77.50 stddev:4.29 (5.5%) stddev-sans-first:4.54 07:29:52 INFO - PROCESS | 16008 | Values: 80.0 90.0 77.0 78.0 77.0 77.0 77.0 76.0 82.0 76.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:129.50 stddev:12.87 (9.9%) stddev-sans-first:13.31 07:29:52 INFO - PROCESS | 16008 | Values: 124.0 139.0 133.0 124.0 126.0 129.0 129.0 130.0 166.0 122.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.00 stddev:2.47 (1.6%) stddev-sans-first:2.39 07:29:52 INFO - PROCESS | 16008 | Values: 161.0 158.0 162.0 156.0 158.0 161.0 158.0 156.0 156.0 155.0 07:29:52 INFO - PROCESS | 16008 | 07:29:52 INFO - PROCESS | 16008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 07:29:52 INFO - PROCESS | 16008 | Values: 64.0 64.0 64.0 63.0 63.0 67.0 63.0 64.0 63.0 66.0 07:29:52 INFO - PROCESS | 16008 | -------- Summary: end -------- 07:29:52 INFO - PROCESS | 16008 | 07:29:54 INFO - TEST-INFO | 16008: exit 0 07:29:54 INFO - TEST-OK | kraken | took 65608ms 07:29:54 INFO - SUITE-END | took 1180s 07:29:54 INFO - Completed test suite (00:19:41) 07:29:54 INFO - javascript benchmark 07:29:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7328.121529677952, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3102.751779857612, 3103.1621462205203, 3131.9530207046882, 3136.6392864820546, 3138.6076740407448, 5233.9793740220675, 5366.382865970415, 5371.19432085187, 5448.700321482317, 5483.0, 5426.647267927582, 5432.972835135819, 5464.207689884975, 5486.506214440709, 5489.39616642169, 4937.530934561211, 4998.225275082368, 5018.949810501885, 5043.773030213649, 5119.872003199913, 5057.443681195065, 5086.821961231358, 5090.312807770959, 5128.2564028216075, 5142.717150556718, 4840.128776820188, 4885.584725298354, 4908.97545512272, 4914.262860570907, 4941.654084214107, 4997.775100120467, 4999.8500044998345, 5002.074616196015, 5062.898742025176, 5075.492450754932, 4940.604751619861, 4959.727215003173, 4970.87572810679, 5026.648134630577, 5046.495350464961, 5218.895622087537, 5384.0, 5461.617686761928, 5508.531774799147, 5527.419620939824, 5829.09649004405, 5836.0, 5849.736761845727, 5862.97068514659, 5887.705614719247, 5845.269341332333, 5864.501517370986, 5864.824055278348, 5865.530757539386, 5879.470847623692, 5172.431032586413, 5323.920141197924, 5345.786168553292, 5440.319960004999, 5451.809186678447, 5898.321693005273, 5904.911426328608, 5941.0, 5987.072003839412, 6006.039033754579, 5739.885202295931, 5742.741576628978, 5751.6549007058875, 5755.827325180251, 5761.0, 5536.972315138399, 5747.540196784247, 5795.0, 5798.188253644493, 5801.274840644919, 5467.781288748485, 5687.971560142173, 5791.536677065825, 5815.534757219412, 5835.095560188178, 5809.331926828384, 5810.302763668303, 5823.88352232953, 5835.912461313083, 5843.386444423274, 4302.827886884552, 4477.059817438374, 4487.237169681162, 4489.595936365743, 4541.318802179633, 3911.02224443889, 3925.0776067624083, 3948.861789837342, 3960.20795840833, 4007.0583412897945, 5410.48600382963, 5410.59420543453, 5439.809606663748, 5463.836084917459, 5489.368722596872, 5621.156826476062, 5840.591158618856, 5846.035404158351, 5852.882942341129, 5858.941410585925, 5383.596230282745, 5390.326209223847, 5423.83728488146, 5517.917231241535, 5533.501984821385, 4656.998745269783, 4668.416447944007, 4671.532846715301, 4673.065386922629, 4675.906481870344, 5761.942380576224, 6072.939270607238, 6078.6048906820915, 6079.118527813531, 6084.178635884187, 5711.857203569944, 5797.2173756542325, 5826.271716035496, 5831.79588714393, 5859.121131830259, 6008.429199226067, 6010.128531363015, 6030.336662966983, 6065.272167339947, 6098.176746139392, 5491.890162196813, 5716.8570785729025, 5731.426857314235, 5820.621659592113, 5822.359540450631, 5736.741846616829, 5787.623804452697, 5844.824655260349, 5847.06446968483, 5914.792982245601, 5666.178404131296, 5673.971630141823, 5690.231818704422, 5701.743421545957, 5745.626534275259, 5428.104362780097, 5660.29246344207, 5678.0, 5678.432156784289, 5683.0, 5547.778088876561, 5640.407757185437, 5644.153376993484, 5666.9716651416475, 5696.088625819849, 5699.943000569941, 5703.058995265735, 5740.971295143498, 5765.5675824314185, 5792.5655575832825, 5363.919541206963, 5529.032419326682, 5643.407442218508, 5648.039833228443, 5663.32040155184], "value": 5349.067072149806, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7728581452178, 583.6760597868184, 593.1725243285616, 607.8541150123971, 633.091513677872, 38795.61204387959, 42012.369814452766, 42116.157676846444, 42148.789256053715, 42180.0, 42323.57676423235, 42348.15303693924, 42695.14609707804, 42752.0, 42783.35824962628, 8790.604422800989, 8832.0, 8835.646574137027, 8842.46945183291, 8886.377953543255, 8833.867491987594, 8846.292296616255, 8919.598618062171, 8944.418612790181, 8959.5968181432, 8940.19538241558, 8958.955205223965, 8973.77565560863, 8984.775380615472, 9002.054784247657, 8937.50843703596, 8952.373333866632, 8966.193042626162, 8977.057408972061, 9006.144416280444, 8776.736697899074, 8841.513716745576, 8851.159139881702, 8864.468131912106, 8867.246284065863, 40995.38506922399, 41373.58626413727, 41472.0, 41766.16467670629, 41880.58119418828, 3548.308079924416, 3699.315626609086, 3712.480252764615, 3830.3871380579253, 4424.491183513905, 31333.0, 32273.677263227535, 32404.675953240403, 32545.837270813732, 32657.183570410692, 4266.957330426687, 4421.491528474235, 4437.378766972626, 4459.464864216315, 4565.406497155382, 351255.0, 351617.0, 355651.0, 356238.0, 356600.0, 56368.43631563714, 56916.43083569111, 56974.14538781922, 57055.71472142613, 57070.42929570734, 59158.40841591615, 59387.40612593905, 59505.70247148736, 59534.40465595289, 59539.40460595425, 15723.135227562594, 15841.52475425739, 15896.284667190004, 15925.601859953595, 15928.840711592737, 12138.211016283913, 12178.086643501772, 12183.086268529718, 12231.327276999851, 12239.69400764988, 14656.267186640625, 15577.376904923676, 15796.36814527429, 15851.286692098884, 15929.761053584205, 6604.877170880962, 6676.699548520328, 6748.797536073926, 6764.647070585903, 6964.79105626832, 954.9522523873778, 1085.3054045410786, 1099.2085698297212, 1182.9349385783692, 1201.8377519034818, 33117.834410828276, 33512.0, 33606.0, 33724.83137584345, 34189.0, 1121.6466812953893, 1131.5530365505579, 1173.730042090324, 1180.392098069495, 1205.4394706461537, 16626.91686541584, 17411.73882391765, 17845.910770446066, 18096.276148953893, 18554.387504737675, 541127.0, 544642.0, 549937.0, 551180.0, 553130.0, 58613.60397970169, 59473.0, 59538.0, 59623.0, 59722.70138649366, 1373.4300265389952, 1374.615107769826, 1390.6731917999261, 1406.1000959386001, 1410.4710733474947, 31211.0, 33172.33655326832, 33266.83366583152, 33419.832900836314, 33446.665533344356, 50181.0, 50690.0, 50752.492475074774, 50838.491615083374, 50972.0, 412298.0, 412877.0, 413982.0, 414821.0, 415026.0, 27065.1880443587, 27185.0, 27411.588826168023, 27439.862800685867, 27519.44961100807, 45316.0, 45731.31403028891, 46601.300980484644, 46986.29520557263, 47260.7636961813, 40003.39994900021, 40923.1815363697, 41054.178916422105, 42104.36843447412, 42643.57356426396, 41155.0, 41462.58537414587, 41682.166356673304, 42002.57997419986, 42127.15745685008, 39142.60857391504, 39267.80366098151, 39731.40402893901, 40032.799836001795, 40831.38752918768, 33789.0, 35581.0, 36207.63792362042, 36557.817210914836, 36601.45097823588, 27880.024199152933, 28168.29579260535, 28192.295192619527, 28297.858510707316, 28299.292517687223], "value": 19995.947044195123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.8828886467466, 357.28364628919013, 365.30227265922076, 368.80269056055016, 369.30386221971577, 18517.16672749726, 18887.811121888775, 18916.81083189168, 19010.0, 19570.902145489254, 18987.0, 19069.332573359934, 19129.808701912978, 19528.31650892219, 19597.118129684164, 5358.142697168463, 5554.694491802949, 5820.796272130477, 5871.765129394819, 5902.88194236115, 5591.161325801142, 5751.1373294006025, 5795.652260864341, 5815.418458154193, 5832.708364581775, 5717.656940583557, 5723.8569035774235, 5769.913451298234, 5802.245708057946, 5803.129530570406, 5742.397048309909, 5743.942560574383, 5793.159991801207, 5799.072148456226, 5803.477687008169, 4988.628127265031, 5043.798248070073, 5072.619553533463, 5074.213496907985, 5103.948960510422, 23225.76774232253, 23235.0, 23282.417939551648, 23576.29271121852, 23709.288721338387, 2379.3932547200525, 2486.154707399493, 2625.3830349867767, 2783.9721602784116, 2921.9415611687646, 14562.199079050648, 14957.7756333654, 14981.325840337211, 15025.173615451145, 15519.767203491956, 1937.4381429385462, 1945.445548018822, 1956.8259044573285, 2005.4785755703622, 2038.9184432622678, 76257.61871190609, 78875.0, 79293.60353198196, 80720.59639701764, 80743.59628201822, 9806.313558050868, 9812.116909478182, 10110.69667909964, 10212.795744085077, 10437.634682786218, 13805.447782088804, 13805.930970345285, 13816.861831381557, 13832.0, 13838.93080534611, 7508.812279693051, 7734.883976740353, 7745.302922736981, 7958.164392738795, 7962.3630109591095, 7407.296306850841, 7533.8116547086765, 7656.196099409593, 7721.0, 7723.459357844897, 6198.900549725137, 6398.29618741938, 6450.193725784277, 6457.806265812033, 6467.741290348427, 1787.4190887961204, 1796.0486928756786, 1798.9550261243573, 1828.9359872404402, 1842.6130512592238, 982.4203719805206, 1002.7292630989592, 1027.9486025698686, 1035.9015893490107, 1064.9520771565299, 19972.700409493867, 20429.897850510653, 20501.89749051275, 20669.379918602466, 20781.272655456985, 1033.379972016784, 1043.4782608695652, 1056.3397876327294, 1065.5950738719237, 1107.869972627931, 10821.404822734825, 11631.6510504685, 11663.533458661559, 11788.23376480526, 11818.34999075042, 462300.0, 462384.0, 464272.0, 466368.0, 467357.0, 46946.53053469422, 64252.678736606016, 79086.74071381969, 79585.60207198927, 80814.59592701998, 1011.716719318592, 1017.4149863828476, 1022.882368527614, 1029.1149611334247, 1036.5439206749006, 16890.40883569069, 17105.657886842444, 17990.910045449687, 18054.277828886698, 18284.817151828312, 29903.102906912827, 35712.464313034805, 42491.36262955996, 42644.0, 45150.096998060515, 53132.0, 54241.18638220509, 55536.444635553125, 60504.0, 62260.377396225456, 7252.238514955854, 8110.675572977251, 8318.667253309799, 8345.624446900025, 8440.620172092147, 10247.795044099226, 12315.26108433461, 12378.0, 12432.440540175532, 12686.111972162229, 10842.349459032483, 10925.726856828644, 11177.55289788432, 11203.71990700239, 11316.094712422822, 10658.62694805678, 10850.837237441287, 10955.945220273848, 10973.177011723992, 11017.889821101686, 10838.694198269288, 10896.128309735044, 11186.944065279622, 11246.493907774333, 11424.428778561205, 7689.3464055555905, 7761.689532418866, 7780.727674531364, 7850.842983140191, 7959.5622240775, 8300.2114799094, 10434.37393756377, 10798.406087665255, 10836.13310935139, 11058.889411105785], "value": 9119.892160475038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1489.2702575737892, 1516.7573188289873, 1616.369615849818, 1746.5982823950483, 1766.0639860873741, 7628.771136865889, 8931.955340223307, 8958.820823583532, 9599.856002159964, 9606.663766768164, 9078.092190780935, 9262.444253344804, 9324.906750932489, 9402.153806157445, 9421.52892355383, 2350.929472115831, 2371.0, 2380.27401642499, 2384.618461046233, 2408.1330720940537, 2324.662923876037, 2355.105060077168, 2378.357843382286, 2394.114177754225, 2397.4965257295903, 2378.643203519477, 2380.238323736405, 2398.46034642205, 2404.158544509425, 2408.638704194367, 2344.7069116360453, 2346.3430239532872, 2354.764523547649, 2360.7049118860227, 2392.5454163709014, 2250.6849041134255, 2260.2315212827552, 2266.626006708891, 2269.580127676385, 2278.270953294946, 9263.166315031613, 9387.295952803499, 9389.295802814817, 9451.196648284904, 9451.527423628791, 5111.207762796736, 5125.846224613268, 5142.228665700138, 5237.3453318335205, 5343.385510666284, 3396.1679388549965, 3412.6246112927556, 3419.333230020147, 3455.671711187433, 3465.9653403465895, 1111.5387114347536, 1117.742919128605, 1119.2109562758235, 1124.2579897267847, 1151.3437340715795, 13103.541376051793, 13122.409491572902, 13128.409221585052, 13212.33938303081, 13220.405081771343, 4416.3596278539435, 4494.37078808967, 4634.72191668501, 4637.211674015425, 4664.813407463731, 10894.291871028516, 10962.56149754001, 10991.835122473169, 10993.065589424828, 11032.44837758109, 5360.3299587551555, 5395.406505284415, 5395.81114660985, 5411.64824286428, 5423.267858839085, 4081.6326530612387, 4830.516948305141, 4939.456659767423, 4952.925706114411, 4970.030843985461, 3842.9423558646645, 3981.8208180631364, 4027.154297597479, 4047.473828402348, 4125.608067233608, 1266.2402558464848, 1267.2649863079391, 1275.2603489975793, 1285.1517998121194, 1303.4655791125592, 926.9165775080276, 1003.4280460137652, 1011.9696409107738, 1028.1466382902174, 1053.536443964653, 6289.433950944345, 6312.5581209314905, 6439.710213040425, 6487.416132548094, 6517.250516190604, 438.17841547099187, 439.20723094814167, 444.04751807373003, 444.55766512320446, 448.37227880966907, 3894.5131858517684, 4078.5921407858978, 4110.116324990082, 4118.258713431551, 4118.485189351331, 11242.269252498561, 11583.0, 11689.88310116888, 11713.88286117128, 11719.12106592009, 11587.826182607268, 11602.76794464106, 11603.0, 11673.124515661359, 11673.76652466946, 8490.448120872, 8653.17794809492, 8653.350998675125, 8722.778810966469, 8723.302135829119, 6208.596441231305, 6244.781432650017, 6325.841853953688, 6326.240851097898, 6436.485081193399, 10542.314749541256, 10749.355038697704, 10750.569977200825, 10750.946245268724, 10819.404932728776, 10716.0, 10729.141668666332, 10780.245382823126, 10820.89179108199, 10933.125349971824, 6838.350356716104, 7819.8436031277915, 8019.478733882279, 8095.907052547831, 8175.509469431853, 8875.112488751074, 8905.109489051301, 8972.461652300883, 8977.730668079968, 8995.055519170393, 7631.38948884099, 7654.387648988179, 7753.1859154787935, 7841.098273698598, 7935.928649632226, 7601.353884919844, 7659.0, 7705.345045671181, 7706.884396734165, 7840.607969601611, 7200.855982880418, 7319.670614822239, 7319.719049166268, 7326.743563975236, 7329.853402932018, 5559.444055594408, 5597.5521958242425, 5679.261695979496, 5686.545076393962, 5804.82585522435, 5369.409364969928, 5382.246485492113, 5455.8363249102595, 5469.535089517435, 5578.748956296895], "value": 4692.596987172993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.03141058549693, 310.49854485006693, 310.5977758802349, 317.52371442835744, 320.60245295833175, 5544.584156188282, 5559.416261292557, 5581.162825576161, 5597.824456864063, 5663.745131469083, 5429.429909859467, 5480.588955828319, 5487.6158668893195, 5493.176023596463, 5518.310211223597, 4069.511658600972, 4161.812718427663, 4238.194742998836, 4281.100968796556, 4282.614564689177, 4265.424167737347, 4272.33778764292, 4272.46594175728, 4276.199089596319, 4276.882942943232, 4235.0682849773, 4264.317709166534, 4276.828926842923, 4280.764557949312, 4334.913301733964, 4049.372347286175, 4139.77231252281, 4233.407322974786, 4252.319628859368, 4316.892077698051, 3714.220013797106, 3718.3307004739136, 3720.795356255405, 3726.981365093184, 3727.7447144477474, 5324.840254792362, 5332.280142180794, 5338.813141540067, 5362.544183744387, 5381.461853814626, 4636.629069674452, 4780.784864681098, 4860.902781944376, 4874.122657921573, 4881.316615673809, 5643.589102724319, 5648.526156413817, 5649.435056494359, 5664.178694089375, 5684.374718780972, 4077.1641813428473, 4094.1811637672586, 4096.938545921814, 4100.835966561334, 4100.91798164035, 5890.97054514729, 5908.67502287374, 5964.314103878066, 5976.880462390728, 6013.819585412444, 4138.379243113557, 4147.129102888427, 4168.6665066794585, 4173.5409104998425, 4187.701812438154, 4247.918519925276, 4248.553901840324, 4261.87214383569, 4270.274053410928, 4276.935845962313, 4716.716996980193, 4804.183288840905, 4821.349117869043, 4889.779959901813, 4893.21708526634, 5682.971585142131, 5690.2887139107615, 5699.0, 5731.856703582361, 5740.512056475163, 1434.0105327324113, 1450.8911831612672, 1453.2007395932194, 1456.7086582683505, 1466.1862666220136, 874.4622057434632, 888.1030159538913, 890.2566357091771, 894.9529051010334, 991.2615101749243, 5490.862728431821, 5496.340439147328, 5504.587155963319, 5540.529055030368, 5545.306836645419, 5833.649981001154, 5858.941410585925, 5880.558958078162, 5882.058870580687, 5897.997340452133, 5342.09698283399, 5354.651947623392, 5423.945760542423, 5446.7276636168035, 5497.47773961481, 3083.0, 3106.9223269417994, 3121.204092956282, 3121.609798775153, 3141.3560220154814, 5782.479576838021, 6026.668533230714, 6060.545459090586, 6078.300995385499, 6118.388161183846, 6021.819345419644, 6086.604370715978, 6094.8171554853425, 6096.664683442454, 6108.633481991094, 6161.106639537332, 6212.844678882973, 6222.564420490522, 6223.128761973237, 6236.407541283571, 5652.7173641318595, 5903.704814759159, 5942.58401911862, 5944.524438045032, 6004.309504407049, 5879.647221166743, 5925.4370834770625, 5928.9110663339225, 5936.910946335895, 5946.316173640087, 5895.351511333835, 6138.355472675305, 6139.079138129317, 6207.968960155351, 6236.158118653923, 4154.376843473382, 4158.500979882433, 4164.1267525407375, 4176.43618111551, 4191.182719369694, 5919.526437884872, 5946.851328716643, 5952.255968003999, 5955.6724380157775, 6049.487628092977, 5685.431456854281, 5729.398413166724, 5786.247787787561, 5792.768289268551, 5805.187273781758, 5743.167240750151, 5757.0, 5761.942380576308, 5771.249737534094, 5787.594868359174, 5198.818041368534, 5651.689157096399, 5674.631148975303, 5696.316442026983, 5705.515031222392, 5775.768969241183, 5787.6816775076095, 5792.913106303325, 5821.912671310019, 5867.471927526543, 5671.816350704926, 5694.715264236855, 5710.5146062585145, 5731.570132240182, 5796.246487956539], "value": 4362.368346888778, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.1155171552714, 780.5355813291089, 821.7288294862695, 844.370943646983, 845.2513104382068, 12589.559365422212, 14512.709745805078, 14795.630109247275, 15477.458288959875, 15647.295871685774, 15678.0, 15779.0, 16570.591499722508, 16595.087270200165, 16620.168991550436, 818.1940788323511, 825.6821123867325, 829.5893532701322, 830.8338332333527, 835.5780330932901, 819.3813670678629, 823.6293667849462, 828.056016141599, 829.1584042197175, 829.4442723375353, 891.1801142948503, 891.3047822698273, 892.5180402582598, 895.3911340288602, 896.4845214001942, 863.8531449653542, 866.441145461174, 875.8335916175906, 884.6726711116896, 887.1882227761623, 644.8226737647137, 645.7707513832569, 646.3762469217181, 646.424682032991, 649.0167396394467, 14384.712305753827, 14533.563993080224, 14596.12423254608, 14604.05073670208, 14613.415463381452, 15297.464588739453, 15359.385624575003, 15393.923030384776, 15980.4406845761, 16039.27823247945, 12806.42371093303, 12906.225626462348, 12940.288284144368, 13116.803247951288, 13228.206307621478, 4043.1711499142607, 4061.614146656063, 4096.672266218696, 4203.26442872496, 4232.746035237896, 78056.21943780604, 78101.0, 78623.6068819658, 79420.60289698573, 80056.0, 12219.266843989211, 12233.877661223274, 12293.446794894073, 12410.627681169579, 12458.190217636005, 21088.894555527124, 21105.78894211069, 21114.261000864895, 21126.366209013755, 21248.575028499345, 8129.593520323961, 8424.957875210584, 8644.135586441305, 8709.259712924346, 8794.60424280909, 4917.852464426073, 5076.0863044652315, 5088.236764485283, 5202.583793296603, 5245.449227831099, 3593.4609808528407, 3725.18046029873, 3728.0, 3747.775133491999, 3750.3624383854262, 640.2924768131242, 651.5048563092084, 653.4837478392112, 654.2443477783168, 654.3489228217953, 607.802464199137, 699.6361891816227, 775.1279810213509, 779.2363483785922, 788.6332855222349, 9391.624335026523, 9837.950810245902, 10358.067773900235, 10498.947505262426, 10623.52194151265, 618.8421952402109, 621.7979156774066, 649.136648257816, 657.4247533408268, 658.8616390557941, 4765.737884416321, 4982.188625701341, 5117.769700363493, 5126.15418455958, 5133.768980395891, 98409.50795245978, 101853.49073254586, 114524.0, 115280.0, 116667.41666291615, 59410.10884836731, 75897.0, 91769.0823091774, 97294.5135274319, 98340.0, 63877.0, 87499.0, 87924.6811297831, 88845.0, 90295.54852225828, 10108.292419530562, 10171.7457063574, 10476.319039262424, 10526.10651358129, 10565.154787617126, 52213.0, 52583.73708131435, 52916.73541632421, 52945.4705452956, 53469.19796202982, 68974.65512672404, 77801.0, 78833.60583197048, 79975.80036299577, 80095.0, 12478.251304921734, 12894.808913232915, 13144.60566183016, 13419.932900335436, 13707.246101464516, 13729.244891530661, 14102.224377659328, 14395.496157634432, 14708.55874323772, 14810.851891480947, 13349.733005339645, 14189.574312770634, 14256.501022464165, 14301.0, 14590.489332873298, 13761.31193440304, 14438.711225775636, 14452.277386130861, 15135.394584216949, 15232.543023709306, 12751.681207969876, 12841.614751557468, 13839.584812455643, 14227.359768810222, 14642.633934151732, 11517.0, 11766.470508826953, 11895.345755983504, 12016.158868879094, 12164.635060948185, 11759.823602645796, 12026.398680065786, 12149.271043737404, 12264.938675306566, 12441.44013519412], "value": 7754.746782112171, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 105.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 145.0, 177.0, 118.0, 152.0, 143.0, 121.0, 187.0, 121.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 165.0, 166.0, 173.0, 164.0, 161.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 177.0, 77.0, 77.0, 77.0, 76.0, 161.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 154.0, 85.0, 83.0, 85.0, 160.0, 85.0, 84.0, 156.0], "value": 105.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 61.0, 55.0, 56.0, 55.0, 58.0, 57.0, 55.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 90.0, 77.0, 78.0, 77.0, 77.0, 77.0, 76.0, 82.0, 76.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 139.0, 133.0, 124.0, 126.0, 129.0, 129.0, 130.0, 166.0, 122.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 162.0, 156.0, 158.0, 161.0, 158.0, 156.0, 156.0, 155.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 63.0, 67.0, 63.0, 64.0, 63.0, 66.0], "value": 64.1, "unit": "score"}]}]} 07:29:55 INFO - Return code: 0 07:29:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:29:55 ERROR - # TBPL SUCCESS # 07:29:55 INFO - Running post-action listener: _resource_record_post_action 07:29:55 INFO - [mozharness: 2016-07-29 14:29:55.122140Z] Finished run-tests step (success) 07:29:55 INFO - Running post-run listener: _resource_record_post_run 07:29:55 INFO - Total resource usage - Wall time: 1202s; CPU: 14.0%; Read bytes: 4096; Write bytes: 560562176; Read time: 12; Write time: 2444736 07:29:55 INFO - TinderboxPrint: CPU usage
13.6% 07:29:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:29:55 INFO - TinderboxPrint: I/O write bytes / time
560,562,176 / 2,444,736 07:29:55 INFO - TinderboxPrint: CPU idle
8,282.3 (86.4%) 07:29:55 INFO - TinderboxPrint: CPU user
1,209.1 (12.6%) 07:29:55 INFO - TinderboxPrint: Swap in / out
0 / 0 07:29:55 INFO - install - Wall time: 21s; CPU: 24.0%; Read bytes: 0; Write bytes: 258777088; Read time: 0; Write time: 1460660 07:29:55 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298639360; Read time: 12; Write time: 915600 07:29:55 INFO - Running post-run listener: _upload_blobber_files 07:29:55 INFO - Blob upload gear active. 07:29:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:29: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 07:29: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:29: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:29:56 INFO - (blobuploader) - INFO - Open directory for files ... 07:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:00 INFO - (blobuploader) - INFO - Done attempting. 07:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:01 INFO - (blobuploader) - INFO - Done attempting. 07:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:30:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:30:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:30:04 INFO - (blobuploader) - INFO - Done attempting. 07:30:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:30:04 INFO - Return code: 0 07:30:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:30:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:30:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c1aee121e383f161a3bdc11fbbcce0ba9a73b368aa218e21ca6b31d4287f67a4064b2085d5bf1e754bb05594c452a67680e4fa0df95655035026310d78497dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9e5365ed46a08cb13d1e453656abe8f156f463d7b34970f40974d33a55cd345b37be5cad2b61069514ce36301092f62aa4a4de2e3da632a1c5a9383538022ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a520edf0c79eda818b0ca1bfcc7a10bdd0f9b464234ce0b9a7fa83e0f75f05fb273fa4f119dc140e2d75b4bbb74525e41defc66b53bd86379fbd88fff7d5753a"} 07:30:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:30:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:30:04 INFO - Contents: 07:30:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c1aee121e383f161a3bdc11fbbcce0ba9a73b368aa218e21ca6b31d4287f67a4064b2085d5bf1e754bb05594c452a67680e4fa0df95655035026310d78497dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9e5365ed46a08cb13d1e453656abe8f156f463d7b34970f40974d33a55cd345b37be5cad2b61069514ce36301092f62aa4a4de2e3da632a1c5a9383538022ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a520edf0c79eda818b0ca1bfcc7a10bdd0f9b464234ce0b9a7fa83e0f75f05fb273fa4f119dc140e2d75b4bbb74525e41defc66b53bd86379fbd88fff7d5753a"} 07:30:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:30:04 INFO - Copying logs to upload dir... 07:30:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:30:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.307457 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-29 07:30:04.853601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 07:30:04.857381) ========= 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=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 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/sha512/5c1aee121e383f161a3bdc11fbbcce0ba9a73b368aa218e21ca6b31d4287f67a4064b2085d5bf1e754bb05594c452a67680e4fa0df95655035026310d78497dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9e5365ed46a08cb13d1e453656abe8f156f463d7b34970f40974d33a55cd345b37be5cad2b61069514ce36301092f62aa4a4de2e3da632a1c5a9383538022ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a520edf0c79eda818b0ca1bfcc7a10bdd0f9b464234ce0b9a7fa83e0f75f05fb273fa4f119dc140e2d75b4bbb74525e41defc66b53bd86379fbd88fff7d5753a"} build_url:https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/PaTPndptQI6rDbZfE2dtVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c1aee121e383f161a3bdc11fbbcce0ba9a73b368aa218e21ca6b31d4287f67a4064b2085d5bf1e754bb05594c452a67680e4fa0df95655035026310d78497dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9e5365ed46a08cb13d1e453656abe8f156f463d7b34970f40974d33a55cd345b37be5cad2b61069514ce36301092f62aa4a4de2e3da632a1c5a9383538022ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a520edf0c79eda818b0ca1bfcc7a10bdd0f9b464234ce0b9a7fa83e0f75f05fb273fa4f119dc140e2d75b4bbb74525e41defc66b53bd86379fbd88fff7d5753a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 07:30:04.882955) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:30:04.883300) ========= 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=33d5923976266a1c518c4bf7000001ab-1469799087.757121-477201060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 07:30:04.967220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 07:30:04.967600) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 07:30:04.967954) ========= ========= Total master_lag: 0.18 =========