builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1469564956.03 results: success (0) buildid: 20160726125302 builduid: 8b78622b744548679c390db8be528510 revision: bac182c6a35717e7e3d63f837713262da8726b71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.032684) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.033161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.033435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.509747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.510126) ========= 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=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 13:29:16-- 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% 61.0M=0s 2016-07-26 13:29:17 (61.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108056 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.714161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.714470) ========= 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=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016258 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:16.746308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 13:29:16.746648) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bac182c6a35717e7e3d63f837713262da8726b71 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev bac182c6a35717e7e3d63f837713262da8726b71 --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=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 13:29:17,245 truncating revision to first 12 chars 2016-07-26 13:29:17,245 Setting DEBUG logging. 2016-07-26 13:29:17,245 attempt 1/10 2016-07-26 13:29:17,245 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bac182c6a357?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 13:29:18,278 unpacking tar archive at: fx-team-bac182c6a357/testing/mozharness/ program finished with exit code 0 elapsedTime=1.358012 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 13:29:18.154794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:18.155312) ========= script_repo_revision: bac182c6a35717e7e3d63f837713262da8726b71 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:18.155888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:18.156276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 13:29:18.172818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-26 13:29:18.173433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:29:18 INFO - MultiFileLogger online at 20160726 13:29:18 in /builds/slave/test 13:29:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:29:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:29:18 INFO - {'append_to_log': False, 13:29:18 INFO - 'base_work_dir': '/builds/slave/test', 13:29:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:29:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:29:18 INFO - 'branch': 'Fx-Team-Non-PGO', 13:29:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:18 INFO - 'config_files': ('talos/linux_config.py',), 13:29:18 INFO - 'default_actions': ('clobber', 13:29:18 INFO - 'read-buildbot-config', 13:29:18 INFO - 'download-and-extract', 13:29:18 INFO - 'populate-webroot', 13:29:18 INFO - 'create-virtualenv', 13:29:18 INFO - 'install', 13:29:18 INFO - 'run-tests'), 13:29:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:18 INFO - 'download_minidump_stackwalk': True, 13:29:18 INFO - 'download_symbols': 'ondemand', 13:29:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:29:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:29:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:29:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:29:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:29:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:29:18 INFO - 'installer_path': 'installer.exe', 13:29:18 INFO - 'log_level': 'info', 13:29:18 INFO - 'log_name': 'talos', 13:29:18 INFO - 'log_to_console': True, 13:29:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:29:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:29:18 INFO - 'opt_config_files': (), 13:29:18 INFO - 'pip_index': False, 13:29:18 INFO - 'sps_profile': False, 13:29:18 INFO - 'sps_profile_interval': 0, 13:29:18 INFO - 'suite': 'dromaeojs', 13:29:18 INFO - 'system_bits': '32', 13:29:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:29:18 INFO - 'title': 'talos-linux64-ix-065', 13:29:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:29:18 INFO - 'use_talos_json': True, 13:29:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:29:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:29:18 INFO - 'work_dir': 'build'} 13:29:18 INFO - [mozharness: 2016-07-26 20:29:18.728292Z] Running clobber step. 13:29:18 INFO - Running pre-action listener: _resource_record_pre_action 13:29:18 INFO - Running main action method: clobber 13:29:18 INFO - rmtree: /builds/slave/test/build 13:29:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:29:19 INFO - Running post-action listener: _resource_record_post_action 13:29:19 INFO - [mozharness: 2016-07-26 20:29:19.201121Z] Finished clobber step (success) 13:29:19 INFO - [mozharness: 2016-07-26 20:29:19.201223Z] Running read-buildbot-config step. 13:29:19 INFO - Running pre-action listener: _resource_record_pre_action 13:29:19 INFO - Running main action method: read_buildbot_config 13:29:19 INFO - Using buildbot properties: 13:29:19 INFO - { 13:29:19 INFO - "project": "", 13:29:19 INFO - "product": "firefox", 13:29:19 INFO - "script_repo_revision": "production", 13:29:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:29:19 INFO - "repository": "", 13:29:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:29:19 INFO - "buildid": "20160726125302", 13:29:19 INFO - "pgo_build": "False", 13:29:19 INFO - "basedir": "/builds/slave/test", 13:29:19 INFO - "buildnumber": 1828, 13:29:19 INFO - "slavename": "talos-linux64-ix-065", 13:29:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:29:19 INFO - "platform": "ubuntu64_hw", 13:29:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:29:19 INFO - "branch": "fx-team", 13:29:19 INFO - "repo_path": "integration/fx-team", 13:29:19 INFO - "revision": "bac182c6a35717e7e3d63f837713262da8726b71", 13:29:19 INFO - "stage_platform": "linux64", 13:29:19 INFO - "builduid": "8b78622b744548679c390db8be528510", 13:29:19 INFO - "slavebuilddir": "test" 13:29:19 INFO - } 13:29:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:29:19 INFO - Running post-action listener: _resource_record_post_action 13:29:19 INFO - [mozharness: 2016-07-26 20:29:19.203655Z] Finished read-buildbot-config step (success) 13:29:19 INFO - [mozharness: 2016-07-26 20:29:19.203743Z] Running download-and-extract step. 13:29:19 INFO - Running pre-action listener: _resource_record_pre_action 13:29:19 INFO - Running main action method: download_and_extract 13:29:19 INFO - mkdir: /builds/slave/test/build/tests 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:19 INFO - Downloaded 1361 bytes. 13:29:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:19 INFO - Using the following test package requirements: 13:29:19 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:19 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:29:19 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:29:19 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'jsshell-linux-x86_64.zip'], 13:29:19 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:29:19 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:19 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:29:19 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:29:19 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:29:19 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:19 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:29:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:19 INFO - https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:21 INFO - Downloaded 22742092 bytes. 13:29:21 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'] 13:29:21 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 13:29:23 INFO - Return code: 0 13:29:23 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 13:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:23 INFO - https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:25 INFO - Downloaded 22742092 bytes. 13:29:25 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'] 13:29:25 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 13:29:27 INFO - Return code: 0 13:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:27 INFO - https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:28 INFO - Downloaded 14413725 bytes. 13:29:28 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'] 13:29:28 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 13:29:28 INFO - Return code: 0 13:29: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')]} 13:29:28 INFO - https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VQIqbLWAS66iYHtq8QwECA/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 13:29:29 INFO - Downloaded 57165128 bytes. 13:29:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:29 INFO - mkdir: /builds/slave/test/properties 13:29:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:29:29 INFO - Writing to file /builds/slave/test/properties/build_url 13:29:29 INFO - Contents: 13:29:29 INFO - build_url:https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:30 INFO - Running post-action listener: _resource_record_post_action 13:29:30 INFO - Running post-action listener: set_extra_try_arguments 13:29:30 INFO - [mozharness: 2016-07-26 20:29:30.341354Z] Finished download-and-extract step (success) 13:29:30 INFO - [mozharness: 2016-07-26 20:29:30.341588Z] Running populate-webroot step. 13:29:30 INFO - Running pre-action listener: _resource_record_pre_action 13:29:30 INFO - Running main action method: populate_webroot 13:29:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:29:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:29:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:29:30 INFO - '--tppagecycles', 13:29:30 INFO - '7'], 13:29:30 INFO - 'tests': ['tsvgm']}}, 13:29:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:29:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:29:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:29:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:29:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['damp', 'tps']}, 13:29:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'tests': ['damp', 'tps']}, 13:29:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['dromaeo_dom']}, 13:29:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:29:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['basic_compositor_video']}, 13:29:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:29:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'other-e10s': {'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['a11yr', 13:29:30 INFO - 'ts_paint', 13:29:30 INFO - 'tpaint', 13:29:30 INFO - 'sessionrestore', 13:29:30 INFO - 'sessionrestore_no_auto_restore', 13:29:30 INFO - 'tabpaint']}, 13:29:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['tsvgx', 13:29:30 INFO - 'tsvgr_opacity', 13:29:30 INFO - 'tart', 13:29:30 INFO - 'tscrollx', 13:29:30 INFO - 'cart']}, 13:29:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:29:30 INFO - 'tsvgr_opacity', 13:29:30 INFO - 'tart', 13:29:30 INFO - 'tscrollx', 13:29:30 INFO - 'cart']}, 13:29:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'talos_options': ['--disable-e10s'], 13:29:30 INFO - 'tests': ['tp5o']}, 13:29:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'tests': ['tp5o']}, 13:29:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'talos_options': ['--disable-e10s', 13:29:30 INFO - '--xperf_path', 13:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:30 INFO - 'tests': ['tp5n']}, 13:29:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:30 INFO - 'talos_options': ['--xperf_path', 13:29:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:30 INFO - 'tests': ['tp5n']}}, 13:29:30 INFO - 'talos.zip': {'path': '', 13:29:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:29:30 INFO - Running post-action listener: _resource_record_post_action 13:29:30 INFO - [mozharness: 2016-07-26 20:29:30.361410Z] Finished populate-webroot step (success) 13:29:30 INFO - [mozharness: 2016-07-26 20:29:30.361499Z] Running create-virtualenv step. 13:29:30 INFO - Running pre-action listener: _resource_record_pre_action 13:29:30 INFO - Running main action method: create_virtualenv 13:29:30 INFO - Creating virtualenv /builds/slave/test/build/venv 13:29: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 13:29:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:29:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:29:30 INFO - Using real prefix '/usr' 13:29:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:29:31 INFO - Installing distribute.............................................................................................................................................................................................done. 13:29:32 INFO - Installing pip.................done. 13:29:33 INFO - Return code: 0 13:29:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:33 INFO - Using env: {'DISPLAY': ':0', 13:29:33 INFO - 'HOME': '/home/cltbld', 13:29:33 INFO - 'LANG': 'en_US.UTF-8', 13:29:33 INFO - 'LANGUAGE': 'en_US:en', 13:29:33 INFO - 'LOGNAME': 'cltbld', 13:29:33 INFO - 'MAIL': '/var/mail/cltbld', 13:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:33 INFO - 'MOZ_NO_REMOTE': '1', 13:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:33 INFO - 'NO_EM_RESTART': '1', 13:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:33 INFO - 'PWD': '/builds/slave/test', 13:29:33 INFO - 'SHELL': '/bin/bash', 13:29:33 INFO - 'SHLVL': '1', 13:29:33 INFO - 'TERM': 'linux', 13:29:33 INFO - 'TMOUT': '86400', 13:29:33 INFO - 'USER': 'cltbld', 13:29:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:33 INFO - '_': '/tools/buildbot/bin/python'} 13:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29: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 13:29:33 INFO - Cleaning up... 13:29:33 INFO - Return code: 0 13:29:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:33 INFO - Using env: {'DISPLAY': ':0', 13:29:33 INFO - 'HOME': '/home/cltbld', 13:29:33 INFO - 'LANG': 'en_US.UTF-8', 13:29:33 INFO - 'LANGUAGE': 'en_US:en', 13:29:33 INFO - 'LOGNAME': 'cltbld', 13:29:33 INFO - 'MAIL': '/var/mail/cltbld', 13:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:33 INFO - 'MOZ_NO_REMOTE': '1', 13:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:33 INFO - 'NO_EM_RESTART': '1', 13:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:33 INFO - 'PWD': '/builds/slave/test', 13:29:33 INFO - 'SHELL': '/bin/bash', 13:29:33 INFO - 'SHLVL': '1', 13:29:33 INFO - 'TERM': 'linux', 13:29:33 INFO - 'TMOUT': '86400', 13:29:33 INFO - 'USER': 'cltbld', 13:29:33 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:33 INFO - '_': '/tools/buildbot/bin/python'} 13:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:33 INFO - Downloading/unpacking psutil>=3.1.1 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:29:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:35 INFO - Installing collected packages: psutil 13:29:35 INFO - Running setup.py install for psutil 13:29:35 INFO - building 'psutil._psutil_linux' extension 13:29: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 13:29: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 13:29:35 INFO - building 'psutil._psutil_posix' extension 13:29: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 13:29: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 13:29:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:35 INFO - Successfully installed psutil 13:29:35 INFO - Cleaning up... 13:29:36 INFO - Return code: 0 13:29:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:36 INFO - Using env: {'DISPLAY': ':0', 13:29:36 INFO - 'HOME': '/home/cltbld', 13:29:36 INFO - 'LANG': 'en_US.UTF-8', 13:29:36 INFO - 'LANGUAGE': 'en_US:en', 13:29:36 INFO - 'LOGNAME': 'cltbld', 13:29:36 INFO - 'MAIL': '/var/mail/cltbld', 13:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:36 INFO - 'MOZ_NO_REMOTE': '1', 13:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:36 INFO - 'NO_EM_RESTART': '1', 13:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:36 INFO - 'PWD': '/builds/slave/test', 13:29:36 INFO - 'SHELL': '/bin/bash', 13:29:36 INFO - 'SHLVL': '1', 13:29:36 INFO - 'TERM': 'linux', 13:29:36 INFO - 'TMOUT': '86400', 13:29:36 INFO - 'USER': 'cltbld', 13:29:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:36 INFO - '_': '/tools/buildbot/bin/python'} 13:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:29:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:29:38 INFO - Installing collected packages: mozsystemmonitor 13:29:38 INFO - Running setup.py install for mozsystemmonitor 13:29:38 INFO - Successfully installed mozsystemmonitor 13:29:38 INFO - Cleaning up... 13:29:38 INFO - Return code: 0 13:29:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:38 INFO - Using env: {'DISPLAY': ':0', 13:29:38 INFO - 'HOME': '/home/cltbld', 13:29:38 INFO - 'LANG': 'en_US.UTF-8', 13:29:38 INFO - 'LANGUAGE': 'en_US:en', 13:29:38 INFO - 'LOGNAME': 'cltbld', 13:29:38 INFO - 'MAIL': '/var/mail/cltbld', 13:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:38 INFO - 'MOZ_NO_REMOTE': '1', 13:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:38 INFO - 'NO_EM_RESTART': '1', 13:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:38 INFO - 'PWD': '/builds/slave/test', 13:29:38 INFO - 'SHELL': '/bin/bash', 13:29:38 INFO - 'SHLVL': '1', 13:29:38 INFO - 'TERM': 'linux', 13:29:38 INFO - 'TMOUT': '86400', 13:29:38 INFO - 'USER': 'cltbld', 13:29:38 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:38 INFO - '_': '/tools/buildbot/bin/python'} 13:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:38 INFO - Downloading/unpacking jsonschema==2.5.1 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:29:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:29:40 INFO - warning: no files found matching '*.txt' 13:29:40 INFO - no previously-included directories found matching 'build' 13:29:40 INFO - no previously-included directories found matching 'dist' 13:29:40 INFO - no previously-included directories found matching '.git*' 13:29:40 INFO - Installing collected packages: jsonschema, functools32 13:29:40 INFO - Running setup.py install for functools32 13:29:40 INFO - warning: no files found matching '*.txt' 13:29:40 INFO - no previously-included directories found matching 'build' 13:29:40 INFO - no previously-included directories found matching 'dist' 13:29:40 INFO - no previously-included directories found matching '.git*' 13:29:40 INFO - Successfully installed jsonschema functools32 13:29:40 INFO - Cleaning up... 13:29:40 INFO - Return code: 0 13:29:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:29:40 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')]} 13:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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')]} 13:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29:40 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 13:29:40 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 13:29:40 INFO - Using env: {'DISPLAY': ':0', 13:29:40 INFO - 'HOME': '/home/cltbld', 13:29:40 INFO - 'LANG': 'en_US.UTF-8', 13:29:40 INFO - 'LANGUAGE': 'en_US:en', 13:29:40 INFO - 'LOGNAME': 'cltbld', 13:29:40 INFO - 'MAIL': '/var/mail/cltbld', 13:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:40 INFO - 'MOZ_NO_REMOTE': '1', 13:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:40 INFO - 'NO_EM_RESTART': '1', 13:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:40 INFO - 'PWD': '/builds/slave/test', 13:29:40 INFO - 'SHELL': '/bin/bash', 13:29:40 INFO - 'SHLVL': '1', 13:29:40 INFO - 'TERM': 'linux', 13:29:40 INFO - 'TMOUT': '86400', 13:29:40 INFO - 'USER': 'cltbld', 13:29:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:40 INFO - '_': '/tools/buildbot/bin/python'} 13:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:29:41 INFO - Cleaning up... 13:29:41 INFO - Return code: 0 13:29:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:41 INFO - Using env: {'DISPLAY': ':0', 13:29:41 INFO - 'HOME': '/home/cltbld', 13:29:41 INFO - 'LANG': 'en_US.UTF-8', 13:29:41 INFO - 'LANGUAGE': 'en_US:en', 13:29:41 INFO - 'LOGNAME': 'cltbld', 13:29:41 INFO - 'MAIL': '/var/mail/cltbld', 13:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:41 INFO - 'MOZ_NO_REMOTE': '1', 13:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:41 INFO - 'NO_EM_RESTART': '1', 13:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:41 INFO - 'PWD': '/builds/slave/test', 13:29:41 INFO - 'SHELL': '/bin/bash', 13:29:41 INFO - 'SHLVL': '1', 13:29:41 INFO - 'TERM': 'linux', 13:29:41 INFO - 'TMOUT': '86400', 13:29:41 INFO - 'USER': 'cltbld', 13:29:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:41 INFO - '_': '/tools/buildbot/bin/python'} 13:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:29:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:29:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:43 INFO - Downloading docopt-0.6.1.tar.gz 13:29:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:29:43 INFO - Installing collected packages: blobuploader, requests, docopt 13:29:43 INFO - Running setup.py install for blobuploader 13:29:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:29:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:29:44 INFO - Running setup.py install for requests 13:29:44 INFO - Running setup.py install for docopt 13:29:44 INFO - Successfully installed blobuploader requests docopt 13:29:44 INFO - Cleaning up... 13:29:44 INFO - Return code: 0 13:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:44 INFO - Using env: {'DISPLAY': ':0', 13:29:44 INFO - 'HOME': '/home/cltbld', 13:29:44 INFO - 'LANG': 'en_US.UTF-8', 13:29:44 INFO - 'LANGUAGE': 'en_US:en', 13:29:44 INFO - 'LOGNAME': 'cltbld', 13:29:44 INFO - 'MAIL': '/var/mail/cltbld', 13:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:44 INFO - 'MOZ_NO_REMOTE': '1', 13:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:44 INFO - 'NO_EM_RESTART': '1', 13:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:44 INFO - 'PWD': '/builds/slave/test', 13:29:44 INFO - 'SHELL': '/bin/bash', 13:29:44 INFO - 'SHLVL': '1', 13:29:44 INFO - 'TERM': 'linux', 13:29:44 INFO - 'TMOUT': '86400', 13:29:44 INFO - 'USER': 'cltbld', 13:29:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:44 INFO - '_': '/tools/buildbot/bin/python'} 13:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:44 INFO - Running setup.py (path:/tmp/pip-td5IJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:44 INFO - Running setup.py (path:/tmp/pip-P1Oh19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:44 INFO - Running setup.py (path:/tmp/pip-SGLEqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:45 INFO - Running setup.py (path:/tmp/pip-Sk9bx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:45 INFO - Running setup.py (path:/tmp/pip-6LlvY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:45 INFO - Running setup.py (path:/tmp/pip-SxAZDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:45 INFO - Running setup.py (path:/tmp/pip-sk__XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:45 INFO - Running setup.py (path:/tmp/pip-n4b4ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:45 INFO - Running setup.py (path:/tmp/pip-SeyRYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:45 INFO - Running setup.py (path:/tmp/pip-mOX8lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:45 INFO - Running setup.py (path:/tmp/pip-BdEsig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:45 INFO - Running setup.py (path:/tmp/pip-A_fWEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:45 INFO - Running setup.py (path:/tmp/pip-zP0sUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:45 INFO - Running setup.py (path:/tmp/pip-Oss4iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:45 INFO - Running setup.py (path:/tmp/pip-7Gky6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:45 INFO - Running setup.py (path:/tmp/pip-yRpKKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:45 INFO - Running setup.py (path:/tmp/pip-FnJgA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:29:46 INFO - Running setup.py install for manifestparser 13:29:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Running setup.py install for mozcrash 13:29:46 INFO - Running setup.py install for mozdebug 13:29:46 INFO - Running setup.py install for mozdevice 13:29:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Running setup.py install for mozfile 13:29:46 INFO - Running setup.py install for mozhttpd 13:29:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Running setup.py install for mozinfo 13:29:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Running setup.py install for mozInstall 13:29:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:29:46 INFO - Running setup.py install for mozleak 13:29:46 INFO - Running setup.py install for mozlog 13:29:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Running setup.py install for moznetwork 13:29:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Running setup.py install for mozprocess 13:29:47 INFO - Running setup.py install for mozprofile 13:29:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Running setup.py install for mozrunner 13:29:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Running setup.py install for mozscreenshot 13:29:47 INFO - Running setup.py install for moztest 13:29:47 INFO - Running setup.py install for mozversion 13:29:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:29:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:29:47 INFO - Cleaning up... 13:29:47 INFO - Return code: 0 13:29:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:29:47 INFO - Using env: {'DISPLAY': ':0', 13:29:47 INFO - 'HOME': '/home/cltbld', 13:29:47 INFO - 'LANG': 'en_US.UTF-8', 13:29:47 INFO - 'LANGUAGE': 'en_US:en', 13:29:47 INFO - 'LOGNAME': 'cltbld', 13:29:47 INFO - 'MAIL': '/var/mail/cltbld', 13:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:47 INFO - 'MOZ_NO_REMOTE': '1', 13:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:47 INFO - 'NO_EM_RESTART': '1', 13:29:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:47 INFO - 'PWD': '/builds/slave/test', 13:29:47 INFO - 'SHELL': '/bin/bash', 13:29:47 INFO - 'SHLVL': '1', 13:29:47 INFO - 'TERM': 'linux', 13:29:47 INFO - 'TMOUT': '86400', 13:29:47 INFO - 'USER': 'cltbld', 13:29:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:47 INFO - '_': '/tools/buildbot/bin/python'} 13:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:48 INFO - Running setup.py (path:/tmp/pip-ywwI2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:48 INFO - Running setup.py (path:/tmp/pip-9XqCyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:48 INFO - Running setup.py (path:/tmp/pip-ZuDffV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:48 INFO - Running setup.py (path:/tmp/pip-HLfKqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:48 INFO - Running setup.py (path:/tmp/pip-NGdbVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:48 INFO - Running setup.py (path:/tmp/pip-tKV511-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:48 INFO - Running setup.py (path:/tmp/pip-X3e_0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:48 INFO - Running setup.py (path:/tmp/pip-8bqkq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:48 INFO - Running setup.py (path:/tmp/pip-pEDNA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29: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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:48 INFO - Running setup.py (path:/tmp/pip-N0PND1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:48 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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:48 INFO - Running setup.py (path:/tmp/pip-EMBtbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:48 INFO - Running setup.py (path:/tmp/pip-39WGmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:48 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)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:48 INFO - Running setup.py (path:/tmp/pip-Po5rYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:29:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:49 INFO - Running setup.py (path:/tmp/pip-vPYcoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29: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)) 13:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:49 INFO - Running setup.py (path:/tmp/pip-ul7Qjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29: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)) 13:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:49 INFO - Running setup.py (path:/tmp/pip-Kv_aqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29: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)) 13:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:49 INFO - Running setup.py (path:/tmp/pip-OKASdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29: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)) 13:29: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)) 13:29: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)) 13:29: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)) 13:29: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)) 13:29: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)) 13:29:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29: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 13:29:51 INFO - Downloading blessings-1.6.tar.gz 13:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:29:51 INFO - Installing collected packages: blessings 13:29:51 INFO - Running setup.py install for blessings 13:29:51 INFO - Successfully installed blessings 13:29:51 INFO - Cleaning up... 13:29:51 INFO - Return code: 0 13:29:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:29:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:51 INFO - Reading from file tmpfile_stdout 13:29:51 INFO - Current package versions: 13:29:51 INFO - argparse == 1.2.1 13:29:51 INFO - blessings == 1.6 13:29:51 INFO - blobuploader == 1.2.4 13:29:51 INFO - docopt == 0.6.1 13:29:51 INFO - functools32 == 3.2.3-2 13:29:51 INFO - jsonschema == 2.5.1 13:29:51 INFO - manifestparser == 1.1 13:29:51 INFO - mozInstall == 1.12 13:29:51 INFO - mozcrash == 0.17 13:29:51 INFO - mozdebug == 0.1 13:29:51 INFO - mozdevice == 0.48 13:29:51 INFO - mozfile == 1.2 13:29:51 INFO - mozhttpd == 0.7 13:29:51 INFO - mozinfo == 0.9 13:29:51 INFO - mozleak == 0.1 13:29:51 INFO - mozlog == 3.3 13:29:51 INFO - moznetwork == 0.27 13:29:51 INFO - mozprocess == 0.23 13:29:51 INFO - mozprofile == 0.28 13:29:51 INFO - mozrunner == 6.12 13:29:51 INFO - mozscreenshot == 0.1 13:29:51 INFO - mozsystemmonitor == 0.3 13:29:51 INFO - moztest == 0.7 13:29:51 INFO - mozversion == 1.4 13:29:51 INFO - psutil == 3.1.1 13:29:51 INFO - requests == 1.2.3 13:29:51 INFO - wsgiref == 0.1.2 13:29:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29: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 13:29: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 13:29:51 INFO - Using env: {'DISPLAY': ':0', 13:29:51 INFO - 'HOME': '/home/cltbld', 13:29:51 INFO - 'LANG': 'en_US.UTF-8', 13:29:51 INFO - 'LANGUAGE': 'en_US:en', 13:29:51 INFO - 'LOGNAME': 'cltbld', 13:29:51 INFO - 'MAIL': '/var/mail/cltbld', 13:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:51 INFO - 'MOZ_NO_REMOTE': '1', 13:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:51 INFO - 'NO_EM_RESTART': '1', 13:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:51 INFO - 'PWD': '/builds/slave/test', 13:29:51 INFO - 'SHELL': '/bin/bash', 13:29:51 INFO - 'SHLVL': '1', 13:29:51 INFO - 'TERM': 'linux', 13:29:51 INFO - 'TMOUT': '86400', 13:29:51 INFO - 'USER': 'cltbld', 13:29:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:51 INFO - '_': '/tools/buildbot/bin/python'} 13:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:29:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:29:51 INFO - Cleaning up... 13:29:51 INFO - Return code: 0 13:29:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:29: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')]} 13:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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')]} 13:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11dc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, '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': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', '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 13:29:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:29:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:29:51 INFO - Using env: {'DISPLAY': ':0', 13:29:51 INFO - 'HOME': '/home/cltbld', 13:29:51 INFO - 'LANG': 'en_US.UTF-8', 13:29:51 INFO - 'LANGUAGE': 'en_US:en', 13:29:51 INFO - 'LOGNAME': 'cltbld', 13:29:51 INFO - 'MAIL': '/var/mail/cltbld', 13:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:51 INFO - 'MOZ_NO_REMOTE': '1', 13:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:51 INFO - 'NO_EM_RESTART': '1', 13:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:51 INFO - 'PWD': '/builds/slave/test', 13:29:51 INFO - 'SHELL': '/bin/bash', 13:29:51 INFO - 'SHLVL': '1', 13:29:51 INFO - 'TERM': 'linux', 13:29:51 INFO - 'TMOUT': '86400', 13:29:51 INFO - 'USER': 'cltbld', 13:29:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:51 INFO - '_': '/tools/buildbot/bin/python'} 13:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:29:52 INFO - Cleaning up... 13:29:52 INFO - Return code: 0 13:29:52 INFO - Running post-action listener: _resource_record_post_action 13:29:52 INFO - Running post-action listener: _start_resource_monitoring 13:29:52 INFO - Starting resource monitoring. 13:29:52 INFO - [mozharness: 2016-07-26 20:29:52.140669Z] Finished create-virtualenv step (success) 13:29:52 INFO - [mozharness: 2016-07-26 20:29:52.141101Z] Running install step. 13:29:52 INFO - Running pre-action listener: _resource_record_pre_action 13:29:52 INFO - Running main action method: install 13:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:52 INFO - Reading from file tmpfile_stdout 13:29:52 INFO - Detecting whether we're running mozinstall >=1.0... 13:29:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:29:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:29:52 INFO - Reading from file tmpfile_stdout 13:29:52 INFO - Output received: 13:29:52 INFO - Usage: mozinstall [options] installer 13:29:52 INFO - Options: 13:29:52 INFO - -h, --help show this help message and exit 13:29:52 INFO - -d DEST, --destination=DEST 13:29:52 INFO - Directory to install application into. [default: 13:29:52 INFO - "/builds/slave/test"] 13:29:52 INFO - --app=APP Application being installed. [default: firefox] 13:29:52 INFO - mkdir: /builds/slave/test/build/application 13:29: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'] 13:29: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 13:30:08 INFO - Reading from file tmpfile_stdout 13:30:08 INFO - Output received: 13:30:08 INFO - /builds/slave/test/build/application/firefox/firefox 13:30:08 INFO - Running post-action listener: _resource_record_post_action 13:30:08 INFO - [mozharness: 2016-07-26 20:30:08.847262Z] Finished install step (success) 13:30:08 INFO - [mozharness: 2016-07-26 20:30:08.847536Z] Running run-tests step. 13:30:08 INFO - Running pre-action listener: _resource_record_pre_action 13:30:08 INFO - Running main action method: run_tests 13:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:08 INFO - Python 2.7.3 13:30:08 INFO - Return code: 0 13:30:08 INFO - grabbing minidump binary from tooltool 13:30:08 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')]} 13:30:08 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 0x149b3b0>, '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 0x149c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:08 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 13:30:08 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 13:30:08 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 13:30:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:08 INFO - Return code: 0 13:30:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:30:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:30:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:30:08 INFO - Using env: {'DISPLAY': ':0', 13:30:08 INFO - 'HOME': '/home/cltbld', 13:30:08 INFO - 'LANG': 'en_US.UTF-8', 13:30:08 INFO - 'LANGUAGE': 'en_US:en', 13:30:08 INFO - 'LOGNAME': 'cltbld', 13:30:08 INFO - 'MAIL': '/var/mail/cltbld', 13:30:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:08 INFO - 'MOZ_NO_REMOTE': '1', 13:30:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:08 INFO - 'NO_EM_RESTART': '1', 13:30:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:08 INFO - 'PWD': '/builds/slave/test', 13:30:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:08 INFO - 'SHELL': '/bin/bash', 13:30:08 INFO - 'SHLVL': '1', 13:30:08 INFO - 'TERM': 'linux', 13:30:08 INFO - 'TMOUT': '86400', 13:30:08 INFO - 'USER': 'cltbld', 13:30:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310', 13:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:08 INFO - '_': '/tools/buildbot/bin/python'} 13:30:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:30:09 INFO - mozversion application_buildid: 20160726125302 13:30:09 INFO - mozversion application_changeset: bac182c6a35717e7e3d63f837713262da8726b71 13:30:09 INFO - mozversion application_display_name: Nightly 13:30:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:09 INFO - mozversion application_name: Firefox 13:30:09 INFO - mozversion application_remotingname: firefox 13:30:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:30:09 INFO - mozversion application_vendor: Mozilla 13:30:09 INFO - mozversion application_version: 50.0a1 13:30:09 INFO - mozversion platform_buildid: 20160726125302 13:30:09 INFO - mozversion platform_changeset: bac182c6a35717e7e3d63f837713262da8726b71 13:30:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:30:09 INFO - mozversion platform_version: 50.0a1 13:30:09 INFO - using testdate: 1469565009 13:30:09 INFO - actual date: 1469565009 13:30:09 INFO - starting webserver on 'localhost:56142' 13:30:09 INFO - SUITE-START | Running 2 tests 13:30:09 INFO - TEST-START | dromaeo_css 13:30:09 INFO - operating with platform_type : linux_ 13:30:09 INFO - Initialising browser for dromaeo_css test... 13:30:09 INFO - TEST-INFO | started process 4696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_kslxy/profile http://localhost:56142/getInfo.html) 13:30:12 INFO - PROCESS | 4696 | JavaScript error: , line 0: uncaught exception: undefined 13:30:13 INFO - PROCESS | 4696 | __metrics Screen width/height:1600/1200 13:30:13 INFO - PROCESS | 4696 | colorDepth:24 13:30:13 INFO - PROCESS | 4696 | Browser inner width/height: 1024/697 13:30:13 INFO - PROCESS | 4696 | __metrics 13:30:14 INFO - PROCESS | 4696 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:30:14 INFO - PROCESS | 4696 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:15 INFO - TEST-INFO | 4696: exit 0 13:30:15 INFO - Browser initialized. 13:30:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:30:15 INFO - TEST-INFO | started process 4777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_kslxy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:27 INFO - PROCESS | 4777 | RSS: Main: 159068160 13:30:27 INFO - PROCESS | 4777 | 13:31:18 INFO - PROCESS | 4777 | 1469565077999 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] 13:33:31 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56142/tests/dromaeo/cssquery-ext.html) 13:33:32 INFO - PROCESS | 4777 | RSS: Main: 248737792 13:33:32 INFO - PROCESS | 4777 | 13:36:35 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-ext.html (next: http://localhost:56142/tests/dromaeo/cssquery-jquery.html) 13:36:35 INFO - PROCESS | 4777 | RSS: Main: 242348032 13:36:35 INFO - PROCESS | 4777 | 13:39:37 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56142/tests/dromaeo/cssquery-mootools.html) 13:39:38 INFO - PROCESS | 4777 | RSS: Main: 189898752 13:39:38 INFO - PROCESS | 4777 | 13:42:40 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56142/tests/dromaeo/cssquery-prototype.html) 13:42:41 INFO - PROCESS | 4777 | RSS: Main: 190103552 13:42:41 INFO - PROCESS | 4777 | 13:45:44 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56142/tests/dromaeo/cssquery-yui.html) 13:45:45 INFO - PROCESS | 4777 | RSS: Main: 190427136 13:45:45 INFO - PROCESS | 4777 | 13:48:47 INFO - PROCESS | 4777 | Cycle 1(1): loaded http://localhost:56142/tests/dromaeo/cssquery-yui.html (next: http://localhost:56142/tests/dromaeo/cssquery-dojo.html) 13:48:48 INFO - PROCESS | 4777 | RSS: Main: 283521024 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | __start_tp_report 13:48:48 INFO - PROCESS | 4777 | _x_x_mozilla_page_load 13:48:48 INFO - PROCESS | 4777 | _x_x_mozilla_page_load_details 13:48:48 INFO - PROCESS | 4777 | |i|pagename|runs| 13:48:48 INFO - PROCESS | 4777 | |0;dojo.html;2605.9087931922386;2611.1383243529635;2644.537205988952;2658.5879188725744;2661.1484325016004;4615.69997950133;4701.365315682382;4706.152892479352;4741.217699079652;4744.57298843104;4654.697444666094;4675.322078298653;4693.27254275587;4706.764661766906;4719.457262414815;4214.178235244129;4245.915081698364;4292.97853510732;4342.891427714301;4400.515943246241;4320.179165958458;4339.2406328892475;4383.517813040563;4395.516493185747;4396.20868243716;4227.661787057028;4273.594008569181;4361.781910904474;4381.058072514425;4459.732416055047;4244.448221731155;4284.635805956497;4314.784260786948;4321.805518751664;4332.9566704332865;4275.615194632467;4340.348947657845;4349.434573505424;4349.9130017399475;4392.363107349416;4605.30920361945;4733.384659994179;4734.100520901018;4791.041791641651;4796.52034796521;4918.458969513351;4961.131801934683;5022.372203474566;5111.131107711698;5114.181730923035;5085.542301192873;5120.257562653432;5123.052235336438;5132.204508301219;5134.871628209287;4573.245414506636;4645.512221216791;4751.239801631722;4760.666753327234;4765.523447655241;5143.897122057613;5186.299849520266;5206.505381988705;5236.371635403776;5240.0567897778;5010.1983682611335;5026.321446604661;5028.823991160292;5032.220005899091;5036.445990940993;4920;4941.2835138905375;5088.92366614501;5110.412302585176;5116.795328186905;4908.092002979389;4975.676581022222;4978.153713868651;4995.925061124086;4997.775100120503;4946.109700253917;4952.083864485082;4961.181405068123;4961.181405068195;5005.7997680092385;4231.30183519722;4276.8452517820015;4283.378910058086;4289.592488713567;4339.7830108494445;3724.7206459515646;3737.439384092408;3770.0386401468;3782.7541209821275;3833.271678381099;4373.956260437419;4375.934360984587;4388.71473354231;4411.867643970686;4420.646348292129;4887.0714564232685;5100.413452452941;5104.515071068243;5108.489151084936;5133.717645529532;4260.595243451867;4272.29507131326;4322.243607368698;4327.935080973788;4380.233459144701;4531.116432295671;4555.681102322806;4568.451785785661;4571.931421028621;4603.056373443436;4783.521647835259;4787.329773831597;4790.928136077892;4791.784369703441;4835.178019736653;4906.705597664151;5012;5059.949400505948;5066.189409694432;5102.591792656653;4800.615950724004;4801.087793319258;4825.5174482551465;4826.6621336506105;4869.70781753096;5009.0983622948215;5017.37282839645;5021.146405111067;5024.949750502595;5069.239614057921;4829.66192366531;4867.099586576494;5025.145725226794;5073.644844860824;5146.665466744799;4967.230079337708;4988.476209997898;4988.775505102351;4989.80040798364;5035.874103147451;4941.50584941503;4955.2567114933045;4958.851234462828;4965.702057876539;5019.096562618618;4723.173444647242;4813.205821039629;4854.393200849894;4873.780679869344;4899.142650036159;4957.082939656175;4972.453030166751;4973.179425394769;4975.477574854588;5020.246962955586;4848.636352273523;4856.1987272099705;4858.659893807399;4861.416630004422;4905.681130726492 13:48:48 INFO - PROCESS | 4777 | |1;ext.html;546.6037123085763;558.5029323901729;568.5366426362511;573.2318692951445;575.6114622629724;27231;29843.253918652044;29879.850600746966;29901.85049074757;29945.25136871579;29378.853105734495;39230.8038459808;40711.796441017825;40914;44672.3299150513;7622.542647441143;7739.148693643695;7741.57421341826;7745.3029227369525;7748.651310691004;7607.733729319475;7697.499662521946;7708.730194443196;7709.884351734729;7713.228677132298;7347.191808901043;7543.358814500747;7553.8866916996285;7715.6913723451;9848;9701.951490242538;10036.447995360253;10037.89962100377;10038.899611003942;10041.347312424705;9796.853047204298;10017.899821001842;10019.949900250525;10025.59897604095;10028.849567256497;37661.81169094137;37971.430428543594;37997.62002379996;38002.80998595017;38047.809760951015;3031.9393612127856;3040.9695903040906;3094;3170.286685495768;3195;28272.293192670142;28975.85512072447;29315;29328;29378.70621293781;3375.4093033719;3469.5663042119736;3478.286951175003;3578.874739384135;3585.2112535242204;253168;253271;254244;255068;255420;53343.73328133334;53478.46521534813;53706;53830.461695383325;53925.73037134789;55654.44345556493;55679.721601391735;55714.442855570924;55734.72132639392;55840;15221.238938053053;15508.68982620364;15525.534233973;15542.378304867905;15551.533453996399;10385.065344118915;10651.414172220602;10655.733606659896;10958.945205273923;11694;14272.571822845332;15670.686586268212;15989.1205983672;16063.678726425405;16621.0858402789;4476.673742131194;6055.364186760326;6356.523260755462;6396.744130234832;6609.471242300604;788.7594283743399;891.6745387933357;900.8963969143501;923.4808739623417;948.1127377751166;27505.31236719098;27521.724782751917;27599.448011039665;28616;29316.413671726445;952.219180272184;985.8964808694984;998.5905778630727;1010.0202803280806;1040.6721882606955;14725.779113313309;14852.480163194236;15104.924475377553;15472.381104755683;15600.687986240211;405715;407823;409781;410168;410643;50743.492565074615;50997.99999999926;51162.744186279575;51168.744156279725;51194.23208651873;1061.5859814672283;1132.2017977325802;1180.654054378027;1192.5349113845607;1207.402335843763;27816.86091569529;28951.276218093873;29262.561061584518;29676.703232967393;29721.405571888874;37009.62990370062;37377;37397.626023739416;37450.8127459361;37471;247221;247728;247854;248724;248981;24617.261482155565;25588.488230234918;25855.482890342464;26683.33291667724;26912.461750765266;38738.225235495695;38771;38820.80589597034;38929;39063;35036.299274013865;35809.28381432409;35826.641733583376;36037.27925441529;36850.8157459211;35377;35650;35924.82037589795;36807.81596092002;36896;34256.143596410286;34369;34422.31155376929;34490.31019379648;34682.47976280307;30446.543301850932;31905.361892762478;32116.759134302807;32349.676503234667;32501.34997300088;25083.24750257495;25241.495170096863;25455.74544254608;25797.3550661235;25967.74032259729 13:48:48 INFO - PROCESS | 4777 | |2;jquery.html;347.63845600575405;359.46260340790525;366.4759394066485;368.3903140302798;381.2108934505575;12705;16192.190390480473;16480.67038659226;17333.7399939001;17486.21312040958;16911.154442277897;17001.31994720213;17328.56678583036;17695.911520442412;17868.409080683294;4939.827106051289;4978.352814134158;5102.132637451624;5124.256982737501;5126.051680439131;3724.9627503724887;5048.29323894655;5127.820526281581;5573.888522229553;5900.675462849542;5920.141579470974;5931.851703707421;5940.108983652443;5949.137375080611;5951.196588460567;5088.1095808233595;5314.3091398117995;5342.225377320306;5406;5924.733386997574;5236.895262094775;5242.842714718527;5244.580433565306;5250.501202385767;5254.97372513135;11914.106442016797;17347.392841250497;20227.595448091102;20582.176712931465;20745.688814667792;1867.2904296367294;1891.3474851176322;1898.4684288399271;1960.304092047331;2336.4042169246904;8447.746567602982;9203.631854725803;9387.26335627911;12532.248065116122;12756.425960831692;1745.467632372126;1749.80752117267;1769.840714335716;1775.6537475192342;1790.9015004174764;65919.67040164817;67294.66352668205;68635.31364686388;68679.31320686829;69137;9826.213902887752;9905.603775848886;10012.499375031219;10098.444585547866;10159.187265018782;13680.247586382844;13696.452141914411;13706.657333566542;13711.725765484634;13717.657058573615;7054.57672539639;7269.818254543573;7300.926990730131;7359.264073592705;7473.962630186923;6911.965440172868;6920.619365934821;7112.324329188718;7167.92832071683;7216.206217316091;4048.6558642515715;4054.7972601369815;4149.97925010373;4205.137946720914;4409.691321607456;1676.6311411489453;1746.318935615111;1762.1453595006412;1804.1340156724584;1833.3766519383207;686.704716971707;792.9818611633407;815.5106935838568;816.2653611749473;891.4562117108559;15889.52331430059;17293.65412691739;17652.823471765376;17832.55418614545;17852.642947141245;777.455780953335;807.7334479621711;856.9442986205877;881.3213825354442;888.2545797507928;9328.39365441244;9877.753056173653;9907.306488545733;9926.911095135354;9932.255080868963;424668;429156;429307;435333;437828;81689.59155204304;85132.57433712792;86874.13125868786;87262;87724.1227587716;907.682311191091;925.144241576539;950.496236994394;954.4893481987242;962.8074385122864;15681.451149209723;15967.121808300655;16253.756193657342;16365.263563139926;16655.16724163811;29564.852175738983;36045.27909441849;38134.042574465144;38639.613603864724;38918.221635567694;50455.747721262625;50523;51977.96044079173;52870.471295288095;58997.70501147467;5840.240768700041;7235.819104522429;7297.708091676486;7441.330280274801;7605.771826845204;8564.914350856412;11028.889711102785;11624.94187529057;11980.940095299817;12189.878101218874;9636.951815240878;9736.269779766688;9819.214462843098;10056.41304945262;10579.4710264488;9814.362066465657;9977.650782222587;10010.249231307535;10129.64546240878;10342.844857326996;9940.502974851373;10107.591153616082;10190.74523136898;10247.128994035293;10256.43589602579;7241.855162896607;7243.420526357984;7320.267973202637;7595.848083038198;7792.766217013499;8968;9756.853647195156;9804.656837010956;9987.500624968869;10441 13:48:48 INFO - PROCESS | 4777 | |3;mootools.html;1339.8057281694153;1391.499060338278;1451.7241724072426;1625.163041033867;1682.0496419522976;7613.657385417656;7962.283394494494;7967.72112976046;7970.163132871052;7973;6551;7237.203907570163;7476.96261518693;7478.364339031189;7824.687012519506;2137.7969092936187;2152.547964927367;2164.6969424280614;2165.6426689596196;2165.9566808663817;2156.762756096828;2166.458385403649;2168.5988092202915;2172.0443005077796;2179.553191595719;2042.6629606114973;2049.9897500512475;2053.1068984991502;2053.5687505623837;2112.2923820520145;2088.1021160900805;2096.643570593003;2097.5804839032253;2098.1083039708137;2098.5907747988995;2053.774084850665;2104.884231367274;2104.926327578543;2105.9368218953455;2106.8314534837177;7526.510776799545;7585.317321441097;7586.544807311579;7600.885986710204;7605.087389513294;4591.219492686251;4713.740744259065;4715.41057367829;4716.29255611661;4722.3152642866935;2671.2386969713734;2750.5049091163582;2808.101407549585;2809.7330753578376;2818.7040360762235;850.3877208409934;872.2019352292708;881.457903389411;888.8355654203993;891.790429249126;10246.9487652562;10291.588336466531;10301.124404425633;10303.330283531546;10316.432596207205;3979.602039796055;4132.2561938850695;4260.744355338689;4272.636825869836;4315.158544083936;8895.822083558422;8897.11028897118;8898.021217666052;8901.866472002925;8911.064338244521;4640.976795116003;4664.416947881515;4674.789634466457;4680.461746899082;4681.812727490862;3693.778373297611;4090.7341022834016;4203.957960420418;4228.344606585984;4269.466316710411;3656.140806910374;3678.9632103679155;3790.8104594770152;3793.4499497572697;3799.7340186186702;1186.323795436593;1208.9455974480993;1212.5331747277362;1214.0469731260919;1230.889219970207;731.2541207967843;812.3744716568209;821.1296026212234;849.6473963305283;874.3180319350917;5166.741662916839;5265.605079619044;5270.10408230594;5345.732713364317;5389.218563308298;391.7414506425802;399.3091950924858;411.6521539299287;413.35722950811174;415.55535576932994;3453.1539772755837;3510.1049232446076;3544.663256990582;3566.946495802565;3589.6410358964417;9139.954300228455;9641.614335426644;9658.420494770337;9660.903390966001;9672.274579406432;9385.67150149755;9482;9563.804524434445;9575.186109180797;9605.855912161323;7270.200277969419;7377.557346559116;7385.412136390594;7386.0767404074495;7393.297636724503;5223.764930578057;5240.475952404881;5245.396779370269;5260.789568417221;5462.3445186577865;8791.34064945119;8872.112788721077;8910;8935.151160639729;9005.099490050943;8946.955265223633;9031.909680903107;9160.129787670161;9191.908080919105;9198.770030749018;5996.790112346047;6529.379708927644;6832.59004459734;6952.930470695431;6965.7213711453005;7324.487285889936;7546.9245307546225;7576;7585.2035536267895;7586.924130758622;6537.607743535403;6597.505187111082;6647.60114393138;6736.865262694817;6784.86430271382;6295.811125666238;6447.742090316335;6451.41937225652;6629.403353698191;6672.6997285121315;6281.811545653638;6382.138411314599;6383.648899310397;6389.55273130895;6391.201099862517;4568.451785785594;4600.378948841863;4633.142868569325;4676.672632915664;4764.76176191196;4363.105563359567;4549.545045495556;4613.838515651936;4660.4640466345445;4821.325014497903 13:48:48 INFO - PROCESS | 4777 | |4;prototype.html;278.30840361701166;283.9377315650707;285.5303026521374;285.6958628659858;293.2171103154577;4801.879953001172;4802.135615589193;4811.206150985087;4813.90372192556;4842.515748425156;4730.763461826903;4732.550407711262;4749.311349854269;4756.191447453933;4758.714477131366;3511.8244087795574;3609.079684680403;3609.981950090246;3679.466477360781;3691.8338674759566;3709.202521457886;3717.516722826029;3723.3484140275477;3724.29238444696;3727.7017838572983;3692.1692619160744;3702.0929872181355;3702.333579955607;3702.5927148013698;3704.9259014819822;3506.9824650876835;3562.946555801665;3682.3371793077235;3695.575008873987;3706.499622550948;3246.3345014272018;3259.5925509311337;3274.361499507597;3280.557124788147;3285.490748933919;4597.609203217697;4611.9077618447445;4641.721496710208;4642.744649044301;4668.393108895856;4106.281400754886;4158.7296825706235;4189.560096189917;4191.344418954496;4199.559046300155;4881;4912.950870491285;4917.262410638397;4920.163572192736;4924.507549245082;3537.4693795930557;3543.3090547343277;3544.2734239480847;3552.662497062775;3552.8578856845697;5139.8458046258675;5155.149400348938;5159.1487404578575;5171.276021357013;5172.948270517284;3357.2110554019787;3527.7883327000463;3539.964600354015;3570.589382221078;3571.8392672329805;3608.3685355063285;3616.945745813815;3618.185908170693;3620.2035552178477;3626.87566854276;4127.153933443637;4141.585841415895;4171.374293855885;4172.374143878443;4173.31140361843;4751.192297309397;4889.682170658896;4927.975360123177;4928.728919909439;4932.778024988884;1221.9816702749465;1250.7561025600103;1250.8624051354343;1254.3352023427599;1254.9623511294676;773.4353921637124;776.7320274505287;787.110933758983;791.4380789639306;797.5453991224946;4296.462942132233;4404.757738324359;4421.182081314967;4425.491068527096;4433.46798384196;5114.897702045938;5125.692458452505;5137.871553211125;5139.254808052811;5143.897122057538;4432.224360736858;4447.266201076851;4447.755373454426;4450.310201918708;4450.621697155713;2581.4191806843687;2717.6331195288776;2725.6320396746582;2728.1951824211906;2737.219892330716;4875.34182885313;4878.609711223094;4887.853364399002;4905.607551395879;4924.261360795909;5021.271915572222;5244.763985620656;5246.213068039825;5258.789648414097;5262.342207224097;4897.975510122498;4907.484714104968;4909.189983652657;4911.754412279301;4940.777665005084;5164.7791449677;5173.63784535079;5188.169892817131;5192.506711862367;5195.896082078261;4855.320255164351;5035.446100928822;5044.243363495359;5081.288619593334;5096.210087436453;4905.326597004712;4912.680675756064;4926.630502712239;4927.384076990376;4940.283658869515;3562.5724913010604;3565.5721313442555;3575.839087241028;3580.212353282274;3583.175869549966;4908.582770464551;5133.512316329943;5154.278401023785;5164.32863727713;5174.249733788655;4968.552830245295;4970;4975.353204083446;4979;4988.4263309719845;4948.331975183448;4982.701037937735;4992.80028798844;5005.624578156726;5011.072951503984;4795.352627395397;4892.021595680807;4925.556699897026;4934.703917764946;4936.703797772145;4791.520847915181;4902.534259245366;4980.651354405157;5004.099262132705;5027.2207807789855;4838.250071238964;4861.854144375674;4869.805207791649;4877.926831097608;4882.633802464758 13:48:48 INFO - PROCESS | 4777 | |5;yui.html;602.6534742523049;624.1449214576029;683.5693513086754;688.7348370877211;699.4928676709383;12090;12923.935380323086;13008.349582520872;13021.414036368362;13043.152195107336;12664.303463309514;12738.426770795337;12767.808482872764;12770.233785972849;12771.361431928413;623.5198896849423;757.6060448566742;772.3435080181856;774.3495463810398;775.6432041261027;739.2127384335665;767.6890859202005;767.8924950506934;776.4603600497657;778.0585491555225;805.7341077444459;805.9758207253792;807.1887752808449;808.0424696734389;808.3290868579065;643.2634633344794;803.0644299391203;804.4650307545504;806.2743530822248;806.3267171911461;568.088218409451;581.4650521520211;582.3274118393263;584.4506164205633;584.7953216374235;13084.953203743678;13090.738185236338;13121.147125436815;13130.0808943374;13130.540431084866;11270.774584508265;11654.242474239147;11702.414879256088;11863.703407414798;12077.275363478131;11552.422378881107;11703.122265830098;11755.647330580096;11819.468123934443;11864.940675296568;3982.4424580558743;4034.919301613951;4058.066644671742;4105.794710264505;4116.547179810218;57295;58512.41487585112;58900.70549647267;59497.10754338645;59964.100538491955;9478.857817132748;9622.663206787729;9782.168515676105;9856;9871.950640246896;17222.224999875034;17242.655146897243;17416.30334786594;17660.911695441697;17682.734758978626;6371.108044873721;6377.298497165308;6411.487081033506;6428.5178611604315;6672.399484046459;3594.676479116892;3614.4578313253223;3622.166901612644;3647.6717095461536;3663.377225871608;2667.1865081150436;2732.453509298148;2747.8763455644544;2749.738774816389;2752.1193218170392;469.2492012779525;473.4153320648996;474.02824210369295;474.89789695215006;478.6123240175469;532.5819231903015;535.1250705097194;542.3248056170094;554.3514088516446;565.6351653183674;6694.765683201064;6800.965995169992;7065.646717664096;7068.964655176794;7348.52234604749;403.3284581172374;437.51654421863384;486.418729618103;506.1269310439536;509.9576197329671;3433.2275238071234;3512.8067956262653;3567.839447224881;3615.4215325547784;3657.5428071491065;91678;93631.53184234035;95757;95907.52046239724;99845;48440.75779621079;49791.50208497869;81995.5900220507;82145;82909.58545207235;43838.56161438409;44687.32969005468;45376.54623453723;74125.62937185279;75950.24049759543;6766.086578311865;6815.488838337244;6853.211880633591;6997.370236678723;7085.964570177116;47307.290390644856;47333.52666473429;47982;48870.51129488659;50251.49748502468;58137.18628137153;66691;68704.6564767173;69479.48542589071;69868.6506567464;8852.778680533038;8906.109389061301;8941.418807777474;9013.594388252413;9107;9948.850767238642;10220.846687299845;10681.305715128492;12471.314077725812;12833.550825721055;10686.786264274826;10927.781444371227;11151.107911367233;11320.943395282971;11335.263207891461;10782.353058816496;10828.566857325934;10892.40091794959;11089.223754337441;11491.597794077166;11154.442277885912;11184;11247.325160490396;11497.712557186138;11570.247933884271;8806.20744133031;9472.336936414385;9756.902430975882;9827.85258221113;9888.505574721092;9519;9712.854307185256;9840.458774767456;9925.404475731479;9929.932721468838 13:48:48 INFO - PROCESS | 4777 | __end_tp_report 13:48:48 INFO - PROCESS | 4777 | __start_cc_report 13:48:48 INFO - PROCESS | 4777 | _x_x_mozilla_cycle_collect,1012 13:48:48 INFO - PROCESS | 4777 | __end_cc_report 13:48:48 INFO - PROCESS | 4777 | __startTimestamp1469566128213__endTimestamp 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | ------- Summary: start ------- 13:48:48 INFO - PROCESS | 4777 | Number of tests: 6 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#0] dojo.html Cycles:165 Average:4671.41 Median:4813.21 stddev:492.21 (10.2%) stddev-sans-first:466.28 13:48:48 INFO - PROCESS | 4777 | Values: 2605.9 2611.1 2644.5 2658.6 2661.1 4615.7 4701.4 4706.2 4741.2 4744.6 4654.7 4675.3 4693.3 4706.8 4719.5 4214.2 4245.9 4293.0 4342.9 4400.5 4320.2 4339.2 4383.5 4395.5 4396.2 4227.7 4273.6 4361.8 4381.1 4459.7 4244.4 4284.6 4314.8 4321.8 4333.0 4275.6 4340.3 4349.4 4349.9 4392.4 4605.3 4733.4 4734.1 4791.0 4796.5 4918.5 4961.1 5022.4 5111.1 5114.2 5085.5 5120.3 5123.1 5132.2 5134.9 4573.2 4645.5 4751.2 4760.7 4765.5 5143.9 5186.3 5206.5 5236.4 5240.1 5010.2 5026.3 5028.8 5032.2 5036.4 4920.0 4941.3 5088.9 5110.4 5116.8 4908.1 4975.7 4978.2 4995.9 4997.8 4946.1 4952.1 4961.2 4961.2 5005.8 4231.3 4276.8 4283.4 4289.6 4339.8 3724.7 3737.4 3770.0 3782.8 3833.3 4374.0 4375.9 4388.7 4411.9 4420.6 4887.1 5100.4 5104.5 5108.5 5133.7 4260.6 4272.3 4322.2 4327.9 4380.2 4531.1 4555.7 4568.5 4571.9 4603.1 4783.5 4787.3 4790.9 4791.8 4835.2 4906.7 5012.0 5059.9 5066.2 5102.6 4800.6 4801.1 4825.5 4826.7 4869.7 5009.1 5017.4 5021.1 5024.9 5069.2 4829.7 4867.1 5025.1 5073.6 5146.7 4967.2 4988.5 4988.8 4989.8 5035.9 4941.5 4955.3 4958.9 4965.7 5019.1 4723.2 4813.2 4854.4 4873.8 4899.1 4957.1 4972.5 4973.2 4975.5 5020.2 4848.6 4856.2 4858.7 4861.4 4905.7 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#1] ext.html Cycles:180 Average:45746.81 Median:34586.39 stddev:82424.83 (238.3%) stddev-sans-first:82586.19 13:48:48 INFO - PROCESS | 4777 | Values: 546.6 558.5 568.5 573.2 575.6 27231.0 29843.3 29879.9 29901.9 29945.3 29378.9 39230.8 40711.8 40914.0 44672.3 7622.5 7739.1 7741.6 7745.3 7748.7 7607.7 7697.5 7708.7 7709.9 7713.2 7347.2 7543.4 7553.9 7715.7 9848.0 9702.0 10036.4 10037.9 10038.9 10041.3 9796.9 10017.9 10019.9 10025.6 10028.8 37661.8 37971.4 37997.6 38002.8 38047.8 3031.9 3041.0 3094.0 3170.3 3195.0 28272.3 28975.9 29315.0 29328.0 29378.7 3375.4 3469.6 3478.3 3578.9 3585.2 253168.0 253271.0 254244.0 255068.0 255420.0 53343.7 53478.5 53706.0 53830.5 53925.7 55654.4 55679.7 55714.4 55734.7 55840.0 15221.2 15508.7 15525.5 15542.4 15551.5 10385.1 10651.4 10655.7 10958.9 11694.0 14272.6 15670.7 15989.1 16063.7 16621.1 4476.7 6055.4 6356.5 6396.7 6609.5 788.8 891.7 900.9 923.5 948.1 27505.3 27521.7 27599.4 28616.0 29316.4 952.2 985.9 998.6 1010.0 1040.7 14725.8 14852.5 15104.9 15472.4 15600.7 405715.0 407823.0 409781.0 410168.0 410643.0 50743.5 50998.0 51162.7 51168.7 51194.2 1061.6 1132.2 1180.7 1192.5 1207.4 27816.9 28951.3 29262.6 29676.7 29721.4 37009.6 37377.0 37397.6 37450.8 37471.0 247221.0 247728.0 247854.0 248724.0 248981.0 24617.3 25588.5 25855.5 26683.3 26912.5 38738.2 38771.0 38820.8 38929.0 39063.0 35036.3 35809.3 35826.6 36037.3 36850.8 35377.0 35650.0 35924.8 36807.8 36896.0 34256.1 34369.0 34422.3 34490.3 34682.5 30446.5 31905.4 32116.8 32349.7 32501.3 25083.2 25241.5 25455.7 25797.4 25967.7 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#2] jquery.html Cycles:180 Average:25623.89 Median:5095.12 stddev:71173.76 (1396.9%) stddev-sans-first:71348.12 13:48:48 INFO - PROCESS | 4777 | Values: 347.6 359.5 366.5 368.4 381.2 12705.0 16192.2 16480.7 17333.7 17486.2 16911.2 17001.3 17328.6 17695.9 17868.4 4939.8 4978.4 5102.1 5124.3 5126.1 3725.0 5048.3 5127.8 5573.9 5900.7 5920.1 5931.9 5940.1 5949.1 5951.2 5088.1 5314.3 5342.2 5406.0 5924.7 5236.9 5242.8 5244.6 5250.5 5255.0 11914.1 17347.4 20227.6 20582.2 20745.7 1867.3 1891.3 1898.5 1960.3 2336.4 8447.7 9203.6 9387.3 12532.2 12756.4 1745.5 1749.8 1769.8 1775.7 1790.9 65919.7 67294.7 68635.3 68679.3 69137.0 9826.2 9905.6 10012.5 10098.4 10159.2 13680.2 13696.5 13706.7 13711.7 13717.7 7054.6 7269.8 7300.9 7359.3 7474.0 6912.0 6920.6 7112.3 7167.9 7216.2 4048.7 4054.8 4150.0 4205.1 4409.7 1676.6 1746.3 1762.1 1804.1 1833.4 686.7 793.0 815.5 816.3 891.5 15889.5 17293.7 17652.8 17832.6 17852.6 777.5 807.7 856.9 881.3 888.3 9328.4 9877.8 9907.3 9926.9 9932.3 424668.0 429156.0 429307.0 435333.0 437828.0 81689.6 85132.6 86874.1 87262.0 87724.1 907.7 925.1 950.5 954.5 962.8 15681.5 15967.1 16253.8 16365.3 16655.2 29564.9 36045.3 38134.0 38639.6 38918.2 50455.7 50523.0 51978.0 52870.5 58997.7 5840.2 7235.8 7297.7 7441.3 7605.8 8564.9 11028.9 11624.9 11980.9 12189.9 9637.0 9736.3 9819.2 10056.4 10579.5 9814.4 9977.7 10010.2 10129.6 10342.8 9940.5 10107.6 10190.7 10247.1 10256.4 7241.9 7243.4 7320.3 7595.8 7792.8 8968.0 9756.9 9804.7 9987.5 10441.0 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#3] mootools.html Cycles:180 Average:5084.71 Median:5195.25 stddev:2862.92 (55.1%) stddev-sans-first:2857.11 13:48:48 INFO - PROCESS | 4777 | Values: 1339.8 1391.5 1451.7 1625.2 1682.0 7613.7 7962.3 7967.7 7970.2 7973.0 6551.0 7237.2 7477.0 7478.4 7824.7 2137.8 2152.5 2164.7 2165.6 2166.0 2156.8 2166.5 2168.6 2172.0 2179.6 2042.7 2050.0 2053.1 2053.6 2112.3 2088.1 2096.6 2097.6 2098.1 2098.6 2053.8 2104.9 2104.9 2105.9 2106.8 7526.5 7585.3 7586.5 7600.9 7605.1 4591.2 4713.7 4715.4 4716.3 4722.3 2671.2 2750.5 2808.1 2809.7 2818.7 850.4 872.2 881.5 888.8 891.8 10246.9 10291.6 10301.1 10303.3 10316.4 3979.6 4132.3 4260.7 4272.6 4315.2 8895.8 8897.1 8898.0 8901.9 8911.1 4641.0 4664.4 4674.8 4680.5 4681.8 3693.8 4090.7 4204.0 4228.3 4269.5 3656.1 3679.0 3790.8 3793.4 3799.7 1186.3 1208.9 1212.5 1214.0 1230.9 731.3 812.4 821.1 849.6 874.3 5166.7 5265.6 5270.1 5345.7 5389.2 391.7 399.3 411.7 413.4 415.6 3453.2 3510.1 3544.7 3566.9 3589.6 9140.0 9641.6 9658.4 9660.9 9672.3 9385.7 9482.0 9563.8 9575.2 9605.9 7270.2 7377.6 7385.4 7386.1 7393.3 5223.8 5240.5 5245.4 5260.8 5462.3 8791.3 8872.1 8910.0 8935.2 9005.1 8947.0 9031.9 9160.1 9191.9 9198.8 5996.8 6529.4 6832.6 6952.9 6965.7 7324.5 7546.9 7576.0 7585.2 7586.9 6537.6 6597.5 6647.6 6736.9 6784.9 6295.8 6447.7 6451.4 6629.4 6672.7 6281.8 6382.1 6383.6 6389.6 6391.2 4568.5 4600.4 4633.1 4676.7 4764.8 4363.1 4549.5 4613.8 4660.5 4821.3 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#4] prototype.html Cycles:180 Average:4127.11 Median:4775.12 stddev:1215.61 (25.5%) stddev-sans-first:1184.20 13:48:48 INFO - PROCESS | 4777 | Values: 278.3 283.9 285.5 285.7 293.2 4801.9 4802.1 4811.2 4813.9 4842.5 4730.8 4732.6 4749.3 4756.2 4758.7 3511.8 3609.1 3610.0 3679.5 3691.8 3709.2 3717.5 3723.3 3724.3 3727.7 3692.2 3702.1 3702.3 3702.6 3704.9 3507.0 3562.9 3682.3 3695.6 3706.5 3246.3 3259.6 3274.4 3280.6 3285.5 4597.6 4611.9 4641.7 4642.7 4668.4 4106.3 4158.7 4189.6 4191.3 4199.6 4881.0 4913.0 4917.3 4920.2 4924.5 3537.5 3543.3 3544.3 3552.7 3552.9 5139.8 5155.1 5159.1 5171.3 5172.9 3357.2 3527.8 3540.0 3570.6 3571.8 3608.4 3616.9 3618.2 3620.2 3626.9 4127.2 4141.6 4171.4 4172.4 4173.3 4751.2 4889.7 4928.0 4928.7 4932.8 1222.0 1250.8 1250.9 1254.3 1255.0 773.4 776.7 787.1 791.4 797.5 4296.5 4404.8 4421.2 4425.5 4433.5 5114.9 5125.7 5137.9 5139.3 5143.9 4432.2 4447.3 4447.8 4450.3 4450.6 2581.4 2717.6 2725.6 2728.2 2737.2 4875.3 4878.6 4887.9 4905.6 4924.3 5021.3 5244.8 5246.2 5258.8 5262.3 4898.0 4907.5 4909.2 4911.8 4940.8 5164.8 5173.6 5188.2 5192.5 5195.9 4855.3 5035.4 5044.2 5081.3 5096.2 4905.3 4912.7 4926.6 4927.4 4940.3 3562.6 3565.6 3575.8 3580.2 3583.2 4908.6 5133.5 5154.3 5164.3 5174.2 4968.6 4970.0 4975.4 4979.0 4988.4 4948.3 4982.7 4992.8 5005.6 5011.1 4795.4 4892.0 4925.6 4934.7 4936.7 4791.5 4902.5 4980.7 5004.1 5027.2 4838.3 4861.9 4869.8 4877.9 4882.6 13:48:48 INFO - PROCESS | 4777 | 13:48:48 INFO - PROCESS | 4777 | [#5] yui.html Cycles:180 Average:16593.65 Median:538.72 stddev:23669.33 (4393.6%) stddev-sans-first:23705.27 13:48:48 INFO - PROCESS | 4777 | Values: 602.7 624.1 683.6 688.7 699.5 12090.0 12923.9 13008.3 13021.4 13043.2 12664.3 12738.4 12767.8 12770.2 12771.4 623.5 757.6 772.3 774.3 775.6 739.2 767.7 767.9 776.5 778.1 805.7 806.0 807.2 808.0 808.3 643.3 803.1 804.5 806.3 806.3 568.1 581.5 582.3 584.5 584.8 13085.0 13090.7 13121.1 13130.1 13130.5 11270.8 11654.2 11702.4 11863.7 12077.3 11552.4 11703.1 11755.6 11819.5 11864.9 3982.4 4034.9 4058.1 4105.8 4116.5 57295.0 58512.4 58900.7 59497.1 59964.1 9478.9 9622.7 9782.2 9856.0 9872.0 17222.2 17242.7 17416.3 17660.9 17682.7 6371.1 6377.3 6411.5 6428.5 6672.4 3594.7 3614.5 3622.2 3647.7 3663.4 2667.2 2732.5 2747.9 2749.7 2752.1 469.2 473.4 474.0 474.9 478.6 532.6 535.1 542.3 554.4 565.6 6694.8 6801.0 7065.6 7069.0 7348.5 403.3 437.5 486.4 506.1 510.0 3433.2 3512.8 3567.8 3615.4 3657.5 91678.0 93631.5 95757.0 95907.5 99845.0 48440.8 49791.5 81995.6 82145.0 82909.6 43838.6 44687.3 45376.5 74125.6 75950.2 6766.1 6815.5 6853.2 6997.4 7086.0 47307.3 47333.5 47982.0 48870.5 50251.5 58137.2 66691.0 68704.7 69479.5 69868.7 8852.8 8906.1 8941.4 9013.6 9107.0 9948.9 10220.8 10681.3 12471.3 12833.6 10686.8 10927.8 11151.1 11320.9 11335.3 10782.4 10828.6 10892.4 11089.2 11491.6 11154.4 11184.0 11247.3 11497.7 11570.2 8806.2 9472.3 9756.9 9827.9 9888.5 9519.0 9712.9 9840.5 9925.4 9929.9 13:48:48 INFO - PROCESS | 4777 | -------- Summary: end -------- 13:48:48 INFO - PROCESS | 4777 | 13:48:49 INFO - TEST-INFO | 4777: exit 0 13:48:49 INFO - TEST-OK | dromaeo_css | took 1119943ms 13:48:49 INFO - TEST-START | kraken 13:48:49 INFO - operating with platform_type : linux_ 13:48:49 INFO - Initialising browser for kraken test... 13:48:49 INFO - TEST-INFO | started process 4965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5d5AHU/profile http://localhost:56142/getInfo.html) 13:48:52 INFO - PROCESS | 4965 | JavaScript error: , line 0: uncaught exception: undefined 13:48:53 INFO - PROCESS | 4965 | __metrics Screen width/height:1600/1200 13:48:53 INFO - PROCESS | 4965 | colorDepth:24 13:48:53 INFO - PROCESS | 4965 | Browser inner width/height: 1024/697 13:48:53 INFO - PROCESS | 4965 | __metrics 13:48:54 INFO - PROCESS | 4965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:48:54 INFO - PROCESS | 4965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:48:55 INFO - TEST-INFO | 4965: exit 0 13:48:55 INFO - Browser initialized. 13:48:55 INFO - Running cycle 1/1 for kraken test... 13:48:55 INFO - TEST-INFO | started process 5042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5d5AHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:07 INFO - PROCESS | 5042 | RSS: Main: 159559680 13:49:07 INFO - PROCESS | 5042 | 13:49:09 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56142/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:10 INFO - PROCESS | 5042 | RSS: Main: 215683072 13:49:10 INFO - PROCESS | 5042 | 13:49:13 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56142/tests/kraken/driver.html?testName=audio-dft) 13:49:14 INFO - PROCESS | 5042 | RSS: Main: 193155072 13:49:14 INFO - PROCESS | 5042 | 13:49:17 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56142/tests/kraken/driver.html?testName=audio-fft) 13:49:18 INFO - PROCESS | 5042 | RSS: Main: 273588224 13:49:18 INFO - PROCESS | 5042 | 13:49:20 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56142/tests/kraken/driver.html?testName=audio-oscillator) 13:49:20 INFO - PROCESS | 5042 | RSS: Main: 182501376 13:49:20 INFO - PROCESS | 5042 | 13:49:23 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:23 INFO - PROCESS | 5042 | RSS: Main: 186699776 13:49:23 INFO - PROCESS | 5042 | 13:49:26 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56142/tests/kraken/driver.html?testName=imaging-darkroom) 13:49:27 INFO - PROCESS | 5042 | RSS: Main: 223182848 13:49:27 INFO - PROCESS | 5042 | 13:49:31 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56142/tests/kraken/driver.html?testName=imaging-desaturate) 13:49:31 INFO - PROCESS | 5042 | RSS: Main: 216862720 13:49:31 INFO - PROCESS | 5042 | 13:49:34 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56142/tests/kraken/driver.html?testName=json-parse-financial) 13:49:35 INFO - PROCESS | 5042 | RSS: Main: 220610560 13:49:35 INFO - PROCESS | 5042 | 13:49:36 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:49:37 INFO - PROCESS | 5042 | RSS: Main: 186028032 13:49:37 INFO - PROCESS | 5042 | 13:49:39 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:49:39 INFO - PROCESS | 5042 | RSS: Main: 192143360 13:49:39 INFO - PROCESS | 5042 | 13:49:42 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:49:42 INFO - PROCESS | 5042 | RSS: Main: 196407296 13:49:42 INFO - PROCESS | 5042 | 13:49:45 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:49:46 INFO - PROCESS | 5042 | RSS: Main: 191922176 13:49:46 INFO - PROCESS | 5042 | 13:49:48 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:49:49 INFO - PROCESS | 5042 | RSS: Main: 194289664 13:49:49 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:56142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56142/tests/kraken/driver.html?testName=ai-astar) 13:49:51 INFO - PROCESS | 5042 | RSS: Main: 245366784 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | __start_tp_report 13:49:51 INFO - PROCESS | 5042 | _x_x_mozilla_page_load 13:49:51 INFO - PROCESS | 5042 | _x_x_mozilla_page_load_details 13:49:51 INFO - PROCESS | 5042 | |i|pagename|runs| 13:49:51 INFO - PROCESS | 5042 | |0;ai-astar;105;116;115;115;114;115;114;114;115;114 13:49:51 INFO - PROCESS | 5042 | |1;audio-beat-detection;154;121;123;182;123;126;148;123;196;128 13:49:51 INFO - PROCESS | 5042 | |2;audio-dft;161;161;162;161;161;163;161;161;163;177 13:49:51 INFO - PROCESS | 5042 | |3;audio-fft;76;78;77;119;77;76;76;76;120;75 13:49:51 INFO - PROCESS | 5042 | |4;audio-oscillator;85;85;127;84;86;84;126;86;85;133 13:49:51 INFO - PROCESS | 5042 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;116 13:49:51 INFO - PROCESS | 5042 | |6;imaging-darkroom;147;146;146;147;147;146;146;146;147;147 13:49:51 INFO - PROCESS | 5042 | |7;imaging-desaturate;95;96;95;96;95;96;95;95;95;95 13:49:51 INFO - PROCESS | 5042 | |8;json-parse-financial;62;61;60;62;60;64;61;60;62;69 13:49:51 INFO - PROCESS | 5042 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;64;65 13:49:51 INFO - PROCESS | 5042 | |10;stanford-crypto-aes;85;79;79;81;79;87;85;80;78;78 13:49:51 INFO - PROCESS | 5042 | |11;stanford-crypto-ccm;137;139;145;138;137;131;127;124;182;137 13:49:51 INFO - PROCESS | 5042 | |12;stanford-crypto-pbkdf2;166;164;165;164;163;165;165;169;164;164 13:49:51 INFO - PROCESS | 5042 | |13;stanford-crypto-sha256-iterative;69;67;69;66;66;67;67;66;65;66 13:49:51 INFO - PROCESS | 5042 | __end_tp_report 13:49:51 INFO - PROCESS | 5042 | __start_cc_report 13:49:51 INFO - PROCESS | 5042 | _x_x_mozilla_cycle_collect,1939 13:49:51 INFO - PROCESS | 5042 | __end_cc_report 13:49:51 INFO - PROCESS | 5042 | __startTimestamp1469566191582__endTimestamp 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | ------- Summary: start ------- 13:49:51 INFO - PROCESS | 5042 | Number of tests: 14 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.13 (2.7%) stddev-sans-first:0.71 13:49:51 INFO - PROCESS | 5042 | Values: 105.0 116.0 115.0 115.0 114.0 115.0 114.0 114.0 115.0 114.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:138.00 stddev:27.22 (19.7%) stddev-sans-first:28.55 13:49:51 INFO - PROCESS | 5042 | Values: 154.0 121.0 123.0 182.0 123.0 126.0 148.0 123.0 196.0 128.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#2] audio-dft Cycles:10 Average:163.10 Median:161.50 stddev:4.95 (3.1%) stddev-sans-first:5.20 13:49:51 INFO - PROCESS | 5042 | Values: 161.0 161.0 162.0 161.0 161.0 163.0 161.0 161.0 163.0 177.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.00 stddev:18.20 (24.0%) stddev-sans-first:19.01 13:49:51 INFO - PROCESS | 5042 | Values: 76.0 78.0 77.0 119.0 77.0 76.0 76.0 76.0 120.0 75.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:21.18 (24.9%) stddev-sans-first:21.93 13:49:51 INFO - PROCESS | 5042 | Values: 85.0 85.0 127.0 84.0 86.0 84.0 126.0 86.0 85.0 133.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:49:51 INFO - PROCESS | 5042 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:49:51 INFO - PROCESS | 5042 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:49:51 INFO - PROCESS | 5042 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.00 stddev:2.73 (4.4%) stddev-sans-first:2.89 13:49:51 INFO - PROCESS | 5042 | Values: 62.0 61.0 60.0 62.0 60.0 64.0 61.0 60.0 62.0 69.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 13:49:51 INFO - PROCESS | 5042 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 64.0 65.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.50 stddev:3.31 (4.1%) stddev-sans-first:3.20 13:49:51 INFO - PROCESS | 5042 | Values: 85.0 79.0 79.0 81.0 79.0 87.0 85.0 80.0 78.0 78.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:137.50 stddev:16.08 (11.7%) stddev-sans-first:17.02 13:49:51 INFO - PROCESS | 5042 | Values: 137.0 139.0 145.0 138.0 137.0 131.0 127.0 124.0 182.0 137.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.00 stddev:1.66 (1.0%) stddev-sans-first:1.72 13:49:51 INFO - PROCESS | 5042 | Values: 166.0 164.0 165.0 164.0 163.0 165.0 165.0 169.0 164.0 164.0 13:49:51 INFO - PROCESS | 5042 | 13:49:51 INFO - PROCESS | 5042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:1.13 13:49:51 INFO - PROCESS | 5042 | Values: 69.0 67.0 69.0 66.0 66.0 67.0 67.0 66.0 65.0 66.0 13:49:51 INFO - PROCESS | 5042 | -------- Summary: end -------- 13:49:51 INFO - PROCESS | 5042 | 13:49:52 INFO - TEST-INFO | 5042: exit 0 13:49:52 INFO - TEST-OK | kraken | took 63659ms 13:49:52 INFO - SUITE-END | took 1183s 13:49:52 INFO - Completed test suite (00:19:43) 13:49:52 INFO - javascript benchmark 13:49:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.9087931922386, 2611.1383243529635, 2644.537205988952, 2658.5879188725744, 2661.1484325016004, 4615.69997950133, 4701.365315682382, 4706.152892479352, 4741.217699079652, 4744.57298843104, 4654.697444666094, 4675.322078298653, 4693.27254275587, 4706.764661766906, 4719.457262414815, 4214.178235244129, 4245.915081698364, 4292.97853510732, 4342.891427714301, 4400.515943246241, 4320.179165958458, 4339.2406328892475, 4383.517813040563, 4395.516493185747, 4396.20868243716, 4227.661787057028, 4273.594008569181, 4361.781910904474, 4381.058072514425, 4459.732416055047, 4244.448221731155, 4284.635805956497, 4314.784260786948, 4321.805518751664, 4332.9566704332865, 4275.615194632467, 4340.348947657845, 4349.434573505424, 4349.9130017399475, 4392.363107349416, 4605.30920361945, 4733.384659994179, 4734.100520901018, 4791.041791641651, 4796.52034796521, 4918.458969513351, 4961.131801934683, 5022.372203474566, 5111.131107711698, 5114.181730923035, 5085.542301192873, 5120.257562653432, 5123.052235336438, 5132.204508301219, 5134.871628209287, 4573.245414506636, 4645.512221216791, 4751.239801631722, 4760.666753327234, 4765.523447655241, 5143.897122057613, 5186.299849520266, 5206.505381988705, 5236.371635403776, 5240.0567897778, 5010.1983682611335, 5026.321446604661, 5028.823991160292, 5032.220005899091, 5036.445990940993, 4920.0, 4941.2835138905375, 5088.92366614501, 5110.412302585176, 5116.795328186905, 4908.092002979389, 4975.676581022222, 4978.153713868651, 4995.925061124086, 4997.775100120503, 4946.109700253917, 4952.083864485082, 4961.181405068123, 4961.181405068195, 5005.7997680092385, 4231.30183519722, 4276.8452517820015, 4283.378910058086, 4289.592488713567, 4339.7830108494445, 3724.7206459515646, 3737.439384092408, 3770.0386401468, 3782.7541209821275, 3833.271678381099, 4373.956260437419, 4375.934360984587, 4388.71473354231, 4411.867643970686, 4420.646348292129, 4887.0714564232685, 5100.413452452941, 5104.515071068243, 5108.489151084936, 5133.717645529532, 4260.595243451867, 4272.29507131326, 4322.243607368698, 4327.935080973788, 4380.233459144701, 4531.116432295671, 4555.681102322806, 4568.451785785661, 4571.931421028621, 4603.056373443436, 4783.521647835259, 4787.329773831597, 4790.928136077892, 4791.784369703441, 4835.178019736653, 4906.705597664151, 5012.0, 5059.949400505948, 5066.189409694432, 5102.591792656653, 4800.615950724004, 4801.087793319258, 4825.5174482551465, 4826.6621336506105, 4869.70781753096, 5009.0983622948215, 5017.37282839645, 5021.146405111067, 5024.949750502595, 5069.239614057921, 4829.66192366531, 4867.099586576494, 5025.145725226794, 5073.644844860824, 5146.665466744799, 4967.230079337708, 4988.476209997898, 4988.775505102351, 4989.80040798364, 5035.874103147451, 4941.50584941503, 4955.2567114933045, 4958.851234462828, 4965.702057876539, 5019.096562618618, 4723.173444647242, 4813.205821039629, 4854.393200849894, 4873.780679869344, 4899.142650036159, 4957.082939656175, 4972.453030166751, 4973.179425394769, 4975.477574854588, 5020.246962955586, 4848.636352273523, 4856.1987272099705, 4858.659893807399, 4861.416630004422, 4905.681130726492], "value": 4639.902595312534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6037123085763, 558.5029323901729, 568.5366426362511, 573.2318692951445, 575.6114622629724, 27231.0, 29843.253918652044, 29879.850600746966, 29901.85049074757, 29945.25136871579, 29378.853105734495, 39230.8038459808, 40711.796441017825, 40914.0, 44672.3299150513, 7622.542647441143, 7739.148693643695, 7741.57421341826, 7745.3029227369525, 7748.651310691004, 7607.733729319475, 7697.499662521946, 7708.730194443196, 7709.884351734729, 7713.228677132298, 7347.191808901043, 7543.358814500747, 7553.8866916996285, 7715.6913723451, 9848.0, 9701.951490242538, 10036.447995360253, 10037.89962100377, 10038.899611003942, 10041.347312424705, 9796.853047204298, 10017.899821001842, 10019.949900250525, 10025.59897604095, 10028.849567256497, 37661.81169094137, 37971.430428543594, 37997.62002379996, 38002.80998595017, 38047.809760951015, 3031.9393612127856, 3040.9695903040906, 3094.0, 3170.286685495768, 3195.0, 28272.293192670142, 28975.85512072447, 29315.0, 29328.0, 29378.70621293781, 3375.4093033719, 3469.5663042119736, 3478.286951175003, 3578.874739384135, 3585.2112535242204, 253168.0, 253271.0, 254244.0, 255068.0, 255420.0, 53343.73328133334, 53478.46521534813, 53706.0, 53830.461695383325, 53925.73037134789, 55654.44345556493, 55679.721601391735, 55714.442855570924, 55734.72132639392, 55840.0, 15221.238938053053, 15508.68982620364, 15525.534233973, 15542.378304867905, 15551.533453996399, 10385.065344118915, 10651.414172220602, 10655.733606659896, 10958.945205273923, 11694.0, 14272.571822845332, 15670.686586268212, 15989.1205983672, 16063.678726425405, 16621.0858402789, 4476.673742131194, 6055.364186760326, 6356.523260755462, 6396.744130234832, 6609.471242300604, 788.7594283743399, 891.6745387933357, 900.8963969143501, 923.4808739623417, 948.1127377751166, 27505.31236719098, 27521.724782751917, 27599.448011039665, 28616.0, 29316.413671726445, 952.219180272184, 985.8964808694984, 998.5905778630727, 1010.0202803280806, 1040.6721882606955, 14725.779113313309, 14852.480163194236, 15104.924475377553, 15472.381104755683, 15600.687986240211, 405715.0, 407823.0, 409781.0, 410168.0, 410643.0, 50743.492565074615, 50997.99999999926, 51162.744186279575, 51168.744156279725, 51194.23208651873, 1061.5859814672283, 1132.2017977325802, 1180.654054378027, 1192.5349113845607, 1207.402335843763, 27816.86091569529, 28951.276218093873, 29262.561061584518, 29676.703232967393, 29721.405571888874, 37009.62990370062, 37377.0, 37397.626023739416, 37450.8127459361, 37471.0, 247221.0, 247728.0, 247854.0, 248724.0, 248981.0, 24617.261482155565, 25588.488230234918, 25855.482890342464, 26683.33291667724, 26912.461750765266, 38738.225235495695, 38771.0, 38820.80589597034, 38929.0, 39063.0, 35036.299274013865, 35809.28381432409, 35826.641733583376, 36037.27925441529, 36850.8157459211, 35377.0, 35650.0, 35924.82037589795, 36807.81596092002, 36896.0, 34256.143596410286, 34369.0, 34422.31155376929, 34490.31019379648, 34682.47976280307, 30446.543301850932, 31905.361892762478, 32116.759134302807, 32349.676503234667, 32501.34997300088, 25083.24750257495, 25241.495170096863, 25455.74544254608, 25797.3550661235, 25967.74032259729], "value": 17332.350846291803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.63845600575405, 359.46260340790525, 366.4759394066485, 368.3903140302798, 381.2108934505575, 12705.0, 16192.190390480473, 16480.67038659226, 17333.7399939001, 17486.21312040958, 16911.154442277897, 17001.31994720213, 17328.56678583036, 17695.911520442412, 17868.409080683294, 4939.827106051289, 4978.352814134158, 5102.132637451624, 5124.256982737501, 5126.051680439131, 3724.9627503724887, 5048.29323894655, 5127.820526281581, 5573.888522229553, 5900.675462849542, 5920.141579470974, 5931.851703707421, 5940.108983652443, 5949.137375080611, 5951.196588460567, 5088.1095808233595, 5314.3091398117995, 5342.225377320306, 5406.0, 5924.733386997574, 5236.895262094775, 5242.842714718527, 5244.580433565306, 5250.501202385767, 5254.97372513135, 11914.106442016797, 17347.392841250497, 20227.595448091102, 20582.176712931465, 20745.688814667792, 1867.2904296367294, 1891.3474851176322, 1898.4684288399271, 1960.304092047331, 2336.4042169246904, 8447.746567602982, 9203.631854725803, 9387.26335627911, 12532.248065116122, 12756.425960831692, 1745.467632372126, 1749.80752117267, 1769.840714335716, 1775.6537475192342, 1790.9015004174764, 65919.67040164817, 67294.66352668205, 68635.31364686388, 68679.31320686829, 69137.0, 9826.213902887752, 9905.603775848886, 10012.499375031219, 10098.444585547866, 10159.187265018782, 13680.247586382844, 13696.452141914411, 13706.657333566542, 13711.725765484634, 13717.657058573615, 7054.57672539639, 7269.818254543573, 7300.926990730131, 7359.264073592705, 7473.962630186923, 6911.965440172868, 6920.619365934821, 7112.324329188718, 7167.92832071683, 7216.206217316091, 4048.6558642515715, 4054.7972601369815, 4149.97925010373, 4205.137946720914, 4409.691321607456, 1676.6311411489453, 1746.318935615111, 1762.1453595006412, 1804.1340156724584, 1833.3766519383207, 686.704716971707, 792.9818611633407, 815.5106935838568, 816.2653611749473, 891.4562117108559, 15889.52331430059, 17293.65412691739, 17652.823471765376, 17832.55418614545, 17852.642947141245, 777.455780953335, 807.7334479621711, 856.9442986205877, 881.3213825354442, 888.2545797507928, 9328.39365441244, 9877.753056173653, 9907.306488545733, 9926.911095135354, 9932.255080868963, 424668.0, 429156.0, 429307.0, 435333.0, 437828.0, 81689.59155204304, 85132.57433712792, 86874.13125868786, 87262.0, 87724.1227587716, 907.682311191091, 925.144241576539, 950.496236994394, 954.4893481987242, 962.8074385122864, 15681.451149209723, 15967.121808300655, 16253.756193657342, 16365.263563139926, 16655.16724163811, 29564.852175738983, 36045.27909441849, 38134.042574465144, 38639.613603864724, 38918.221635567694, 50455.747721262625, 50523.0, 51977.96044079173, 52870.471295288095, 58997.70501147467, 5840.240768700041, 7235.819104522429, 7297.708091676486, 7441.330280274801, 7605.771826845204, 8564.914350856412, 11028.889711102785, 11624.94187529057, 11980.940095299817, 12189.878101218874, 9636.951815240878, 9736.269779766688, 9819.214462843098, 10056.41304945262, 10579.4710264488, 9814.362066465657, 9977.650782222587, 10010.249231307535, 10129.64546240878, 10342.844857326996, 9940.502974851373, 10107.591153616082, 10190.74523136898, 10247.128994035293, 10256.43589602579, 7241.855162896607, 7243.420526357984, 7320.267973202637, 7595.848083038198, 7792.766217013499, 8968.0, 9756.853647195156, 9804.656837010956, 9987.500624968869, 10441.0], "value": 8188.176642663192, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.8057281694153, 1391.499060338278, 1451.7241724072426, 1625.163041033867, 1682.0496419522976, 7613.657385417656, 7962.283394494494, 7967.72112976046, 7970.163132871052, 7973.0, 6551.0, 7237.203907570163, 7476.96261518693, 7478.364339031189, 7824.687012519506, 2137.7969092936187, 2152.547964927367, 2164.6969424280614, 2165.6426689596196, 2165.9566808663817, 2156.762756096828, 2166.458385403649, 2168.5988092202915, 2172.0443005077796, 2179.553191595719, 2042.6629606114973, 2049.9897500512475, 2053.1068984991502, 2053.5687505623837, 2112.2923820520145, 2088.1021160900805, 2096.643570593003, 2097.5804839032253, 2098.1083039708137, 2098.5907747988995, 2053.774084850665, 2104.884231367274, 2104.926327578543, 2105.9368218953455, 2106.8314534837177, 7526.510776799545, 7585.317321441097, 7586.544807311579, 7600.885986710204, 7605.087389513294, 4591.219492686251, 4713.740744259065, 4715.41057367829, 4716.29255611661, 4722.3152642866935, 2671.2386969713734, 2750.5049091163582, 2808.101407549585, 2809.7330753578376, 2818.7040360762235, 850.3877208409934, 872.2019352292708, 881.457903389411, 888.8355654203993, 891.790429249126, 10246.9487652562, 10291.588336466531, 10301.124404425633, 10303.330283531546, 10316.432596207205, 3979.602039796055, 4132.2561938850695, 4260.744355338689, 4272.636825869836, 4315.158544083936, 8895.822083558422, 8897.11028897118, 8898.021217666052, 8901.866472002925, 8911.064338244521, 4640.976795116003, 4664.416947881515, 4674.789634466457, 4680.461746899082, 4681.812727490862, 3693.778373297611, 4090.7341022834016, 4203.957960420418, 4228.344606585984, 4269.466316710411, 3656.140806910374, 3678.9632103679155, 3790.8104594770152, 3793.4499497572697, 3799.7340186186702, 1186.323795436593, 1208.9455974480993, 1212.5331747277362, 1214.0469731260919, 1230.889219970207, 731.2541207967843, 812.3744716568209, 821.1296026212234, 849.6473963305283, 874.3180319350917, 5166.741662916839, 5265.605079619044, 5270.10408230594, 5345.732713364317, 5389.218563308298, 391.7414506425802, 399.3091950924858, 411.6521539299287, 413.35722950811174, 415.55535576932994, 3453.1539772755837, 3510.1049232446076, 3544.663256990582, 3566.946495802565, 3589.6410358964417, 9139.954300228455, 9641.614335426644, 9658.420494770337, 9660.903390966001, 9672.274579406432, 9385.67150149755, 9482.0, 9563.804524434445, 9575.186109180797, 9605.855912161323, 7270.200277969419, 7377.557346559116, 7385.412136390594, 7386.0767404074495, 7393.297636724503, 5223.764930578057, 5240.475952404881, 5245.396779370269, 5260.789568417221, 5462.3445186577865, 8791.34064945119, 8872.112788721077, 8910.0, 8935.151160639729, 9005.099490050943, 8946.955265223633, 9031.909680903107, 9160.129787670161, 9191.908080919105, 9198.770030749018, 5996.790112346047, 6529.379708927644, 6832.59004459734, 6952.930470695431, 6965.7213711453005, 7324.487285889936, 7546.9245307546225, 7576.0, 7585.2035536267895, 7586.924130758622, 6537.607743535403, 6597.505187111082, 6647.60114393138, 6736.865262694817, 6784.86430271382, 6295.811125666238, 6447.742090316335, 6451.41937225652, 6629.403353698191, 6672.6997285121315, 6281.811545653638, 6382.138411314599, 6383.648899310397, 6389.55273130895, 6391.201099862517, 4568.451785785594, 4600.378948841863, 4633.142868569325, 4676.672632915664, 4764.76176191196, 4363.105563359567, 4549.545045495556, 4613.838515651936, 4660.4640466345445, 4821.325014497903], "value": 4018.4575545061516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.30840361701166, 283.9377315650707, 285.5303026521374, 285.6958628659858, 293.2171103154577, 4801.879953001172, 4802.135615589193, 4811.206150985087, 4813.90372192556, 4842.515748425156, 4730.763461826903, 4732.550407711262, 4749.311349854269, 4756.191447453933, 4758.714477131366, 3511.8244087795574, 3609.079684680403, 3609.981950090246, 3679.466477360781, 3691.8338674759566, 3709.202521457886, 3717.516722826029, 3723.3484140275477, 3724.29238444696, 3727.7017838572983, 3692.1692619160744, 3702.0929872181355, 3702.333579955607, 3702.5927148013698, 3704.9259014819822, 3506.9824650876835, 3562.946555801665, 3682.3371793077235, 3695.575008873987, 3706.499622550948, 3246.3345014272018, 3259.5925509311337, 3274.361499507597, 3280.557124788147, 3285.490748933919, 4597.609203217697, 4611.9077618447445, 4641.721496710208, 4642.744649044301, 4668.393108895856, 4106.281400754886, 4158.7296825706235, 4189.560096189917, 4191.344418954496, 4199.559046300155, 4881.0, 4912.950870491285, 4917.262410638397, 4920.163572192736, 4924.507549245082, 3537.4693795930557, 3543.3090547343277, 3544.2734239480847, 3552.662497062775, 3552.8578856845697, 5139.8458046258675, 5155.149400348938, 5159.1487404578575, 5171.276021357013, 5172.948270517284, 3357.2110554019787, 3527.7883327000463, 3539.964600354015, 3570.589382221078, 3571.8392672329805, 3608.3685355063285, 3616.945745813815, 3618.185908170693, 3620.2035552178477, 3626.87566854276, 4127.153933443637, 4141.585841415895, 4171.374293855885, 4172.374143878443, 4173.31140361843, 4751.192297309397, 4889.682170658896, 4927.975360123177, 4928.728919909439, 4932.778024988884, 1221.9816702749465, 1250.7561025600103, 1250.8624051354343, 1254.3352023427599, 1254.9623511294676, 773.4353921637124, 776.7320274505287, 787.110933758983, 791.4380789639306, 797.5453991224946, 4296.462942132233, 4404.757738324359, 4421.182081314967, 4425.491068527096, 4433.46798384196, 5114.897702045938, 5125.692458452505, 5137.871553211125, 5139.254808052811, 5143.897122057538, 4432.224360736858, 4447.266201076851, 4447.755373454426, 4450.310201918708, 4450.621697155713, 2581.4191806843687, 2717.6331195288776, 2725.6320396746582, 2728.1951824211906, 2737.219892330716, 4875.34182885313, 4878.609711223094, 4887.853364399002, 4905.607551395879, 4924.261360795909, 5021.271915572222, 5244.763985620656, 5246.213068039825, 5258.789648414097, 5262.342207224097, 4897.975510122498, 4907.484714104968, 4909.189983652657, 4911.754412279301, 4940.777665005084, 5164.7791449677, 5173.63784535079, 5188.169892817131, 5192.506711862367, 5195.896082078261, 4855.320255164351, 5035.446100928822, 5044.243363495359, 5081.288619593334, 5096.210087436453, 4905.326597004712, 4912.680675756064, 4926.630502712239, 4927.384076990376, 4940.283658869515, 3562.5724913010604, 3565.5721313442555, 3575.839087241028, 3580.212353282274, 3583.175869549966, 4908.582770464551, 5133.512316329943, 5154.278401023785, 5164.32863727713, 5174.249733788655, 4968.552830245295, 4970.0, 4975.353204083446, 4979.0, 4988.4263309719845, 4948.331975183448, 4982.701037937735, 4992.80028798844, 5005.624578156726, 5011.072951503984, 4795.352627395397, 4892.021595680807, 4925.556699897026, 4934.703917764946, 4936.703797772145, 4791.520847915181, 4902.534259245366, 4980.651354405157, 5004.099262132705, 5027.2207807789855, 4838.250071238964, 4861.854144375674, 4869.805207791649, 4877.926831097608, 4882.633802464758], "value": 3733.145220279908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.6534742523049, 624.1449214576029, 683.5693513086754, 688.7348370877211, 699.4928676709383, 12090.0, 12923.935380323086, 13008.349582520872, 13021.414036368362, 13043.152195107336, 12664.303463309514, 12738.426770795337, 12767.808482872764, 12770.233785972849, 12771.361431928413, 623.5198896849423, 757.6060448566742, 772.3435080181856, 774.3495463810398, 775.6432041261027, 739.2127384335665, 767.6890859202005, 767.8924950506934, 776.4603600497657, 778.0585491555225, 805.7341077444459, 805.9758207253792, 807.1887752808449, 808.0424696734389, 808.3290868579065, 643.2634633344794, 803.0644299391203, 804.4650307545504, 806.2743530822248, 806.3267171911461, 568.088218409451, 581.4650521520211, 582.3274118393263, 584.4506164205633, 584.7953216374235, 13084.953203743678, 13090.738185236338, 13121.147125436815, 13130.0808943374, 13130.540431084866, 11270.774584508265, 11654.242474239147, 11702.414879256088, 11863.703407414798, 12077.275363478131, 11552.422378881107, 11703.122265830098, 11755.647330580096, 11819.468123934443, 11864.940675296568, 3982.4424580558743, 4034.919301613951, 4058.066644671742, 4105.794710264505, 4116.547179810218, 57295.0, 58512.41487585112, 58900.70549647267, 59497.10754338645, 59964.100538491955, 9478.857817132748, 9622.663206787729, 9782.168515676105, 9856.0, 9871.950640246896, 17222.224999875034, 17242.655146897243, 17416.30334786594, 17660.911695441697, 17682.734758978626, 6371.108044873721, 6377.298497165308, 6411.487081033506, 6428.5178611604315, 6672.399484046459, 3594.676479116892, 3614.4578313253223, 3622.166901612644, 3647.6717095461536, 3663.377225871608, 2667.1865081150436, 2732.453509298148, 2747.8763455644544, 2749.738774816389, 2752.1193218170392, 469.2492012779525, 473.4153320648996, 474.02824210369295, 474.89789695215006, 478.6123240175469, 532.5819231903015, 535.1250705097194, 542.3248056170094, 554.3514088516446, 565.6351653183674, 6694.765683201064, 6800.965995169992, 7065.646717664096, 7068.964655176794, 7348.52234604749, 403.3284581172374, 437.51654421863384, 486.418729618103, 506.1269310439536, 509.9576197329671, 3433.2275238071234, 3512.8067956262653, 3567.839447224881, 3615.4215325547784, 3657.5428071491065, 91678.0, 93631.53184234035, 95757.0, 95907.52046239724, 99845.0, 48440.75779621079, 49791.50208497869, 81995.5900220507, 82145.0, 82909.58545207235, 43838.56161438409, 44687.32969005468, 45376.54623453723, 74125.62937185279, 75950.24049759543, 6766.086578311865, 6815.488838337244, 6853.211880633591, 6997.370236678723, 7085.964570177116, 47307.290390644856, 47333.52666473429, 47982.0, 48870.51129488659, 50251.49748502468, 58137.18628137153, 66691.0, 68704.6564767173, 69479.48542589071, 69868.6506567464, 8852.778680533038, 8906.109389061301, 8941.418807777474, 9013.594388252413, 9107.0, 9948.850767238642, 10220.846687299845, 10681.305715128492, 12471.314077725812, 12833.550825721055, 10686.786264274826, 10927.781444371227, 11151.107911367233, 11320.943395282971, 11335.263207891461, 10782.353058816496, 10828.566857325934, 10892.40091794959, 11089.223754337441, 11491.597794077166, 11154.442277885912, 11184.0, 11247.325160490396, 11497.712557186138, 11570.247933884271, 8806.20744133031, 9472.336936414385, 9756.902430975882, 9827.85258221113, 9888.505574721092, 9519.0, 9712.854307185256, 9840.458774767456, 9925.404475731479, 9929.932721468838], "value": 6202.714338666973, "unit": "score"}], "name": "dromaeo_css", "value": 6278.946497185233, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 123.0, 182.0, 123.0, 126.0, 148.0, 123.0, 196.0, 128.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0, 177.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 119.0, 77.0, 76.0, 76.0, 76.0, 120.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 127.0, 84.0, 86.0, 84.0, 126.0, 86.0, 85.0, 133.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 62.0, 60.0, 64.0, 61.0, 60.0, 62.0, 69.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 79.0, 81.0, 79.0, 87.0, 85.0, 80.0, 78.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 145.0, 138.0, 137.0, 131.0, 127.0, 124.0, 182.0, 137.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 164.0, 163.0, 165.0, 165.0, 169.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1540.3000000000002, "alertThreshold": 2.0}]} 13:49:52 INFO - Return code: 0 13:49:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:49:52 INFO - # TBPL SUCCESS # 13:49:52 INFO - Running post-action listener: _resource_record_post_action 13:49:52 INFO - [mozharness: 2016-07-26 20:49:52.888992Z] Finished run-tests step (success) 13:49:52 INFO - Running post-run listener: _resource_record_post_run 13:49:52 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 547303424; Read time: 12; Write time: 507404 13:49:52 INFO - TinderboxPrint: CPU usage
13.0% 13:49:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:49:52 INFO - TinderboxPrint: I/O write bytes / time
547,303,424 / 507,404 13:49:52 INFO - TinderboxPrint: CPU idle
8,335.1 (87.0%) 13:49:52 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 13:49:52 INFO - TinderboxPrint: Swap in / out
0 / 0 13:49:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 259088384; Read time: 0; Write time: 289296 13:49:52 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288215040; Read time: 12; Write time: 218108 13:49:53 INFO - Running post-run listener: _upload_blobber_files 13:49:53 INFO - Blob upload gear active. 13:49:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:49:53 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 13:49:53 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:49:53 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:49:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:59 INFO - (blobuploader) - INFO - Done attempting. 13:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:00 INFO - (blobuploader) - INFO - Done attempting. 13:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:01 INFO - (blobuploader) - INFO - Done attempting. 13:50:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:50:01 INFO - Return code: 0 13:50:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:50:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:50:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/877c2875c25f493783710ff1c2dd15d0dba6111d90b9f266bc6f8225b267ee2d16e236cc37c549f2a18f3a16468b8588b1f26c6231369997b3c6bc6260eee283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e4e3bd3a71501b1efb32070bf72f14ea8f48f5f524891d8e2af2bb74ac3dfa5983b0e59ff2c3b73b1e1d74c40247f21bcacef3afb86c353078e8ccebf659985", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc717f4313bb913e185fe577fa52992bb26dd937a4f1d9c7c0458e77a89de6234942911f7b4bb1dc33fa6cb2166baa15954cdd4e3eb6149d03e418eb6b34a39d"} 13:50:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:50:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:50:01 INFO - Contents: 13:50:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/877c2875c25f493783710ff1c2dd15d0dba6111d90b9f266bc6f8225b267ee2d16e236cc37c549f2a18f3a16468b8588b1f26c6231369997b3c6bc6260eee283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e4e3bd3a71501b1efb32070bf72f14ea8f48f5f524891d8e2af2bb74ac3dfa5983b0e59ff2c3b73b1e1d74c40247f21bcacef3afb86c353078e8ccebf659985", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc717f4313bb913e185fe577fa52992bb26dd937a4f1d9c7c0458e77a89de6234942911f7b4bb1dc33fa6cb2166baa15954cdd4e3eb6149d03e418eb6b34a39d"} 13:50:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:50:01 INFO - Copying logs to upload dir... 13:50:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:50:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.064044 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-26 13:50:01.245257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:50:01.248508) ========= 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=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/877c2875c25f493783710ff1c2dd15d0dba6111d90b9f266bc6f8225b267ee2d16e236cc37c549f2a18f3a16468b8588b1f26c6231369997b3c6bc6260eee283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e4e3bd3a71501b1efb32070bf72f14ea8f48f5f524891d8e2af2bb74ac3dfa5983b0e59ff2c3b73b1e1d74c40247f21bcacef3afb86c353078e8ccebf659985", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc717f4313bb913e185fe577fa52992bb26dd937a4f1d9c7c0458e77a89de6234942911f7b4bb1dc33fa6cb2166baa15954cdd4e3eb6149d03e418eb6b34a39d"} build_url:https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/VQIqbLWAS66iYHtq8QwECA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/877c2875c25f493783710ff1c2dd15d0dba6111d90b9f266bc6f8225b267ee2d16e236cc37c549f2a18f3a16468b8588b1f26c6231369997b3c6bc6260eee283", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6e4e3bd3a71501b1efb32070bf72f14ea8f48f5f524891d8e2af2bb74ac3dfa5983b0e59ff2c3b73b1e1d74c40247f21bcacef3afb86c353078e8ccebf659985", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc717f4313bb913e185fe577fa52992bb26dd937a4f1d9c7c0458e77a89de6234942911f7b4bb1dc33fa6cb2166baa15954cdd4e3eb6149d03e418eb6b34a39d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 13:50:01.273787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:50:01.274119) ========= 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=523ca41ca1e0623de333ad52000001bf-1469564952.786701-2055475310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 13:50:01.360009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:50:01.360335) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 13:50:01.360678) ========= ========= Total master_lag: 0.26 =========