builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1469735833.48 results: success (0) buildid: 20160728113021 builduid: 629ae2e4ba444c76ad83fce06f13bd64 revision: 2d6fced8b624ce179cef1053d9e3952dae7c726b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.483628) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.484078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.484379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.521226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.521568) ========= 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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-28 12:57:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-07-28 12:57:13 (111 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.708636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.708970) ========= 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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019319 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.763297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:13.764080) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2d6fced8b624ce179cef1053d9e3952dae7c726b --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 2d6fced8b624ce179cef1053d9e3952dae7c726b --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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-28 12:57:13,898 truncating revision to first 12 chars 2016-07-28 12:57:13,898 Setting DEBUG logging. 2016-07-28 12:57:13,898 attempt 1/10 2016-07-28 12:57:13,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2d6fced8b624?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-28 12:57:14,214 unpacking tar archive at: fx-team-2d6fced8b624/testing/mozharness/ program finished with exit code 0 elapsedTime=0.709912 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:14.487724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:14.488057) ========= script_repo_revision: 2d6fced8b624ce179cef1053d9e3952dae7c726b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:14.488462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:14.488742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-28 12:57:14.499638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-28 12:57:14.499990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:57:14 INFO - MultiFileLogger online at 20160728 12:57:14 in /builds/slave/test 12:57:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:57:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:57:14 INFO - {'append_to_log': False, 12:57:14 INFO - 'base_work_dir': '/builds/slave/test', 12:57:14 INFO - 'blob_upload_branch': 'Fx-Team', 12:57:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:57:14 INFO - 'branch': 'Fx-Team', 12:57:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:14 INFO - 'config_files': ('talos/linux_config.py',), 12:57:14 INFO - 'default_actions': ('clobber', 12:57:14 INFO - 'read-buildbot-config', 12:57:14 INFO - 'download-and-extract', 12:57:14 INFO - 'populate-webroot', 12:57:14 INFO - 'create-virtualenv', 12:57:14 INFO - 'install', 12:57:14 INFO - 'run-tests'), 12:57:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:14 INFO - 'download_minidump_stackwalk': True, 12:57:14 INFO - 'download_symbols': 'ondemand', 12:57:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:14 INFO - 'installer_path': 'installer.exe', 12:57:14 INFO - 'log_level': 'info', 12:57:14 INFO - 'log_name': 'talos', 12:57:14 INFO - 'log_to_console': True, 12:57:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:57:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:57:14 INFO - 'opt_config_files': (), 12:57:14 INFO - 'pip_index': False, 12:57:14 INFO - 'sps_profile': False, 12:57:14 INFO - 'sps_profile_interval': 0, 12:57:14 INFO - 'suite': 'dromaeojs', 12:57:14 INFO - 'system_bits': '32', 12:57:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:14 INFO - 'title': 'talos-linux64-ix-032', 12:57:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:14 INFO - 'use_talos_json': True, 12:57:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:57:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:14 INFO - 'work_dir': 'build'} 12:57:14 INFO - [mozharness: 2016-07-28 19:57:14.727017Z] Running clobber step. 12:57:14 INFO - Running pre-action listener: _resource_record_pre_action 12:57:14 INFO - Running main action method: clobber 12:57:14 INFO - rmtree: /builds/slave/test/build 12:57:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:57:15 INFO - Running post-action listener: _resource_record_post_action 12:57:15 INFO - [mozharness: 2016-07-28 19:57:15.197011Z] Finished clobber step (success) 12:57:15 INFO - [mozharness: 2016-07-28 19:57:15.197113Z] Running read-buildbot-config step. 12:57:15 INFO - Running pre-action listener: _resource_record_pre_action 12:57:15 INFO - Running main action method: read_buildbot_config 12:57:15 INFO - Using buildbot properties: 12:57:15 INFO - { 12:57:15 INFO - "project": "", 12:57:15 INFO - "product": "firefox", 12:57:15 INFO - "script_repo_revision": "production", 12:57:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:57:15 INFO - "repository": "", 12:57:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:57:15 INFO - "buildid": "20160728113021", 12:57:15 INFO - "pgo_build": "True", 12:57:15 INFO - "basedir": "/builds/slave/test", 12:57:15 INFO - "buildnumber": 1382, 12:57:15 INFO - "slavename": "talos-linux64-ix-032", 12:57:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:57:15 INFO - "platform": "ubuntu64_hw", 12:57:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:57:15 INFO - "branch": "fx-team", 12:57:15 INFO - "repo_path": "integration/fx-team", 12:57:15 INFO - "revision": "2d6fced8b624ce179cef1053d9e3952dae7c726b", 12:57:15 INFO - "stage_platform": "linux64-pgo", 12:57:15 INFO - "builduid": "629ae2e4ba444c76ad83fce06f13bd64", 12:57:15 INFO - "slavebuilddir": "test" 12:57:15 INFO - } 12:57:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:57:15 INFO - Running post-action listener: _resource_record_post_action 12:57:15 INFO - [mozharness: 2016-07-28 19:57:15.199556Z] Finished read-buildbot-config step (success) 12:57:15 INFO - [mozharness: 2016-07-28 19:57:15.199645Z] Running download-and-extract step. 12:57:15 INFO - Running pre-action listener: _resource_record_pre_action 12:57:15 INFO - Running main action method: download_and_extract 12:57:15 INFO - mkdir: /builds/slave/test/build/tests 12:57:15 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')]} 12:57:15 INFO - https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:15 INFO - Downloaded 1361 bytes. 12:57:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:57:15 INFO - Using the following test package requirements: 12:57:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:57:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:57:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:57:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'jsshell-linux-x86_64.zip'], 12:57:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:57:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:57:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:57:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:57:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:57:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:57:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:57:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:57:15 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')]} 12:57:15 INFO - https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:18 INFO - Downloaded 24321788 bytes. 12:57:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:57:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:57:19 INFO - Return code: 0 12:57:19 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:57: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')]} 12:57:19 INFO - https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:57:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:57:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:22 INFO - Downloaded 24321788 bytes. 12:57:22 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'] 12:57:22 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 12:57:24 INFO - Return code: 0 12:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:24 INFO - https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:25 INFO - Downloaded 14413725 bytes. 12:57:25 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'] 12:57:25 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 12:57:25 INFO - Return code: 0 12:57:25 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')]} 12:57:25 INFO - https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiZSlYTRR6W-yqzpg94SLw/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 12:57:27 INFO - Downloaded 60997254 bytes. 12:57:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:57:27 INFO - mkdir: /builds/slave/test/properties 12:57:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:27 INFO - Contents: 12:57:27 INFO - build_url:https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:57:27 INFO - Running post-action listener: _resource_record_post_action 12:57:27 INFO - Running post-action listener: set_extra_try_arguments 12:57:27 INFO - [mozharness: 2016-07-28 19:57:27.925214Z] Finished download-and-extract step (success) 12:57:27 INFO - [mozharness: 2016-07-28 19:57:27.925488Z] Running populate-webroot step. 12:57:27 INFO - Running pre-action listener: _resource_record_pre_action 12:57:27 INFO - Running main action method: populate_webroot 12:57:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:27 INFO - '--tppagecycles', 12:57:27 INFO - '7'], 12:57:27 INFO - 'tests': ['tsvgm']}}, 12:57:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:57:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:57:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['damp', 'tps']}, 12:57:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'tests': ['damp', 'tps']}, 12:57:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['dromaeo_dom']}, 12:57:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['basic_compositor_video']}, 12:57:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:57:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['a11yr', 12:57:27 INFO - 'ts_paint', 12:57:27 INFO - 'tpaint', 12:57:27 INFO - 'sessionrestore', 12:57:27 INFO - 'sessionrestore_no_auto_restore', 12:57:27 INFO - 'tabpaint']}, 12:57:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['tsvgx', 12:57:27 INFO - 'tsvgr_opacity', 12:57:27 INFO - 'tart', 12:57:27 INFO - 'tscrollx', 12:57:27 INFO - 'cart']}, 12:57:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:57:27 INFO - 'tsvgr_opacity', 12:57:27 INFO - 'tart', 12:57:27 INFO - 'tscrollx', 12:57:27 INFO - 'cart']}, 12:57:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'talos_options': ['--disable-e10s'], 12:57:27 INFO - 'tests': ['tp5o']}, 12:57:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'tests': ['tp5o']}, 12:57:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'talos_options': ['--disable-e10s', 12:57:27 INFO - '--xperf_path', 12:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:27 INFO - 'tests': ['tp5n']}, 12:57:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:27 INFO - 'talos_options': ['--xperf_path', 12:57:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:27 INFO - 'tests': ['tp5n']}}, 12:57:27 INFO - 'talos.zip': {'path': '', 12:57:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:27 INFO - Running post-action listener: _resource_record_post_action 12:57:27 INFO - [mozharness: 2016-07-28 19:57:27.946287Z] Finished populate-webroot step (success) 12:57:27 INFO - [mozharness: 2016-07-28 19:57:27.946375Z] Running create-virtualenv step. 12:57:27 INFO - Running pre-action listener: _resource_record_pre_action 12:57:27 INFO - Running main action method: create_virtualenv 12:57:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:27 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 12:57:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:28 INFO - Using real prefix '/usr' 12:57:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:30 INFO - Installing pip.................done. 12:57:30 INFO - Return code: 0 12:57:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:57:30 INFO - Using env: {'DISPLAY': ':0', 12:57:30 INFO - 'HOME': '/home/cltbld', 12:57:30 INFO - 'LANG': 'en_US.UTF-8', 12:57:30 INFO - 'LANGUAGE': 'en_US:en', 12:57:30 INFO - 'LOGNAME': 'cltbld', 12:57:30 INFO - 'MAIL': '/var/mail/cltbld', 12:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:30 INFO - 'MOZ_NO_REMOTE': '1', 12:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:30 INFO - 'NO_EM_RESTART': '1', 12:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:30 INFO - 'PWD': '/builds/slave/test', 12:57:30 INFO - 'SHELL': '/bin/bash', 12:57:30 INFO - 'SHLVL': '1', 12:57:30 INFO - 'TERM': 'linux', 12:57:30 INFO - 'TMOUT': '86400', 12:57:30 INFO - 'USER': 'cltbld', 12:57:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:30 INFO - '_': '/tools/buildbot/bin/python'} 12:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:57:30 INFO - Cleaning up... 12:57:30 INFO - Return code: 0 12:57:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:57:30 INFO - Using env: {'DISPLAY': ':0', 12:57:30 INFO - 'HOME': '/home/cltbld', 12:57:30 INFO - 'LANG': 'en_US.UTF-8', 12:57:30 INFO - 'LANGUAGE': 'en_US:en', 12:57:30 INFO - 'LOGNAME': 'cltbld', 12:57:30 INFO - 'MAIL': '/var/mail/cltbld', 12:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:30 INFO - 'MOZ_NO_REMOTE': '1', 12:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:30 INFO - 'NO_EM_RESTART': '1', 12:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:30 INFO - 'PWD': '/builds/slave/test', 12:57:30 INFO - 'SHELL': '/bin/bash', 12:57:30 INFO - 'SHLVL': '1', 12:57:30 INFO - 'TERM': 'linux', 12:57:30 INFO - 'TMOUT': '86400', 12:57:30 INFO - 'USER': 'cltbld', 12:57:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:30 INFO - '_': '/tools/buildbot/bin/python'} 12:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:31 INFO - Downloading/unpacking psutil>=3.1.1 12:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:33 INFO - Installing collected packages: psutil 12:57:33 INFO - Running setup.py install for psutil 12:57:33 INFO - building 'psutil._psutil_linux' extension 12:57:33 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 12:57:33 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 12:57:33 INFO - building 'psutil._psutil_posix' extension 12:57:33 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 12:57:33 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 12:57:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:33 INFO - Successfully installed psutil 12:57:33 INFO - Cleaning up... 12:57:33 INFO - Return code: 0 12:57:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:57: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 mozsystemmonitor==0.3 12:57:33 INFO - Using env: {'DISPLAY': ':0', 12:57:33 INFO - 'HOME': '/home/cltbld', 12:57:33 INFO - 'LANG': 'en_US.UTF-8', 12:57:33 INFO - 'LANGUAGE': 'en_US:en', 12:57:33 INFO - 'LOGNAME': 'cltbld', 12:57:33 INFO - 'MAIL': '/var/mail/cltbld', 12:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:33 INFO - 'MOZ_NO_REMOTE': '1', 12:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:33 INFO - 'NO_EM_RESTART': '1', 12:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:33 INFO - 'PWD': '/builds/slave/test', 12:57:33 INFO - 'SHELL': '/bin/bash', 12:57:33 INFO - 'SHLVL': '1', 12:57:33 INFO - 'TERM': 'linux', 12:57:33 INFO - 'TMOUT': '86400', 12:57:33 INFO - 'USER': 'cltbld', 12:57:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:33 INFO - '_': '/tools/buildbot/bin/python'} 12:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:57:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:57:35 INFO - Installing collected packages: mozsystemmonitor 12:57:35 INFO - Running setup.py install for mozsystemmonitor 12:57:35 INFO - Successfully installed mozsystemmonitor 12:57:35 INFO - Cleaning up... 12:57:35 INFO - Return code: 0 12:57:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:57:35 INFO - Using env: {'DISPLAY': ':0', 12:57:35 INFO - 'HOME': '/home/cltbld', 12:57:35 INFO - 'LANG': 'en_US.UTF-8', 12:57:35 INFO - 'LANGUAGE': 'en_US:en', 12:57:35 INFO - 'LOGNAME': 'cltbld', 12:57:35 INFO - 'MAIL': '/var/mail/cltbld', 12:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:35 INFO - 'MOZ_NO_REMOTE': '1', 12:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:35 INFO - 'NO_EM_RESTART': '1', 12:57:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:35 INFO - 'PWD': '/builds/slave/test', 12:57:35 INFO - 'SHELL': '/bin/bash', 12:57:35 INFO - 'SHLVL': '1', 12:57:35 INFO - 'TERM': 'linux', 12:57:35 INFO - 'TMOUT': '86400', 12:57:35 INFO - 'USER': 'cltbld', 12:57:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:35 INFO - '_': '/tools/buildbot/bin/python'} 12:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:38 INFO - warning: no files found matching '*.txt' 12:57:38 INFO - no previously-included directories found matching 'build' 12:57:38 INFO - no previously-included directories found matching 'dist' 12:57:38 INFO - no previously-included directories found matching '.git*' 12:57:38 INFO - Installing collected packages: jsonschema, functools32 12:57:38 INFO - Running setup.py install for functools32 12:57:38 INFO - warning: no files found matching '*.txt' 12:57:38 INFO - no previously-included directories found matching 'build' 12:57:38 INFO - no previously-included directories found matching 'dist' 12:57:38 INFO - no previously-included directories found matching '.git*' 12:57:38 INFO - Successfully installed jsonschema functools32 12:57:38 INFO - Cleaning up... 12:57:38 INFO - Return code: 0 12:57:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', '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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:57: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 functools32==3.2.3-2 12:57:38 INFO - Using env: {'DISPLAY': ':0', 12:57:38 INFO - 'HOME': '/home/cltbld', 12:57:38 INFO - 'LANG': 'en_US.UTF-8', 12:57:38 INFO - 'LANGUAGE': 'en_US:en', 12:57:38 INFO - 'LOGNAME': 'cltbld', 12:57:38 INFO - 'MAIL': '/var/mail/cltbld', 12:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:38 INFO - 'MOZ_NO_REMOTE': '1', 12:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:38 INFO - 'NO_EM_RESTART': '1', 12:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:38 INFO - 'PWD': '/builds/slave/test', 12:57:38 INFO - 'SHELL': '/bin/bash', 12:57:38 INFO - 'SHLVL': '1', 12:57:38 INFO - 'TERM': 'linux', 12:57:38 INFO - 'TMOUT': '86400', 12:57:38 INFO - 'USER': 'cltbld', 12:57:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:38 INFO - '_': '/tools/buildbot/bin/python'} 12:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:57:38 INFO - Cleaning up... 12:57:38 INFO - Return code: 0 12:57:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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', '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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:57: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 blobuploader==1.2.4 12:57:38 INFO - Using env: {'DISPLAY': ':0', 12:57:38 INFO - 'HOME': '/home/cltbld', 12:57:38 INFO - 'LANG': 'en_US.UTF-8', 12:57:38 INFO - 'LANGUAGE': 'en_US:en', 12:57:38 INFO - 'LOGNAME': 'cltbld', 12:57:38 INFO - 'MAIL': '/var/mail/cltbld', 12:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:38 INFO - 'MOZ_NO_REMOTE': '1', 12:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:38 INFO - 'NO_EM_RESTART': '1', 12:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:38 INFO - 'PWD': '/builds/slave/test', 12:57:38 INFO - 'SHELL': '/bin/bash', 12:57:38 INFO - 'SHLVL': '1', 12:57:38 INFO - 'TERM': 'linux', 12:57:38 INFO - 'TMOUT': '86400', 12:57:38 INFO - 'USER': 'cltbld', 12:57:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:38 INFO - '_': '/tools/buildbot/bin/python'} 12:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:38 INFO - Downloading/unpacking blobuploader==1.2.4 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:40 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:41 INFO - Downloading docopt-0.6.1.tar.gz 12:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:41 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:41 INFO - Running setup.py install for blobuploader 12:57:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:41 INFO - Running setup.py install for requests 12:57:42 INFO - Running setup.py install for docopt 12:57:42 INFO - Successfully installed blobuploader requests docopt 12:57:42 INFO - Cleaning up... 12:57:42 INFO - Return code: 0 12:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:42 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')]} 12:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:42 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')]} 12:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:42 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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:42 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 12:57:42 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 12:57:42 INFO - Using env: {'DISPLAY': ':0', 12:57:42 INFO - 'HOME': '/home/cltbld', 12:57:42 INFO - 'LANG': 'en_US.UTF-8', 12:57:42 INFO - 'LANGUAGE': 'en_US:en', 12:57:42 INFO - 'LOGNAME': 'cltbld', 12:57:42 INFO - 'MAIL': '/var/mail/cltbld', 12:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:42 INFO - 'MOZ_NO_REMOTE': '1', 12:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:42 INFO - 'NO_EM_RESTART': '1', 12:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:42 INFO - 'PWD': '/builds/slave/test', 12:57:42 INFO - 'SHELL': '/bin/bash', 12:57:42 INFO - 'SHLVL': '1', 12:57:42 INFO - 'TERM': 'linux', 12:57:42 INFO - 'TMOUT': '86400', 12:57:42 INFO - 'USER': 'cltbld', 12:57:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:42 INFO - '_': '/tools/buildbot/bin/python'} 12:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:42 INFO - Running setup.py (path:/tmp/pip-XdcVMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:42 INFO - Running setup.py (path:/tmp/pip-9gbTkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:42 INFO - Running setup.py (path:/tmp/pip-h8HIAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:42 INFO - Running setup.py (path:/tmp/pip-F6q6iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:42 INFO - Running setup.py (path:/tmp/pip-7A5UVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:42 INFO - Running setup.py (path:/tmp/pip-6VqhYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:42 INFO - Running setup.py (path:/tmp/pip-DlqSY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:42 INFO - Running setup.py (path:/tmp/pip-EgrYXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:43 INFO - Running setup.py (path:/tmp/pip-1DkTAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:43 INFO - Running setup.py (path:/tmp/pip-Q9HFFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:43 INFO - Running setup.py (path:/tmp/pip-o1Bg0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:43 INFO - Running setup.py (path:/tmp/pip-PMMCwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:43 INFO - Running setup.py (path:/tmp/pip-vQyueo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:43 INFO - Running setup.py (path:/tmp/pip-7AVezR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:43 INFO - Running setup.py (path:/tmp/pip-x4AaQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:43 INFO - Running setup.py (path:/tmp/pip-UGwYNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:43 INFO - Running setup.py (path:/tmp/pip-OGwJdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:43 INFO - Running setup.py install for manifestparser 12:57:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:43 INFO - Running setup.py install for mozcrash 12:57:43 INFO - Running setup.py install for mozdebug 12:57:43 INFO - Running setup.py install for mozdevice 12:57:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for mozfile 12:57:44 INFO - Running setup.py install for mozhttpd 12:57:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for mozinfo 12:57:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for mozInstall 12:57:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for mozleak 12:57:44 INFO - Running setup.py install for mozlog 12:57:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for moznetwork 12:57:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Running setup.py install for mozprocess 12:57:44 INFO - Running setup.py install for mozprofile 12:57:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:45 INFO - Running setup.py install for mozrunner 12:57:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:45 INFO - Running setup.py install for mozscreenshot 12:57:45 INFO - Running setup.py install for moztest 12:57:45 INFO - Running setup.py install for mozversion 12:57:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:45 INFO - Cleaning up... 12:57:45 INFO - Return code: 0 12:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:45 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')]} 12:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 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')]} 12:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:45 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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:45 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 12:57:45 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 12:57:45 INFO - Using env: {'DISPLAY': ':0', 12:57:45 INFO - 'HOME': '/home/cltbld', 12:57:45 INFO - 'LANG': 'en_US.UTF-8', 12:57:45 INFO - 'LANGUAGE': 'en_US:en', 12:57:45 INFO - 'LOGNAME': 'cltbld', 12:57:45 INFO - 'MAIL': '/var/mail/cltbld', 12:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:45 INFO - 'MOZ_NO_REMOTE': '1', 12:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:45 INFO - 'NO_EM_RESTART': '1', 12:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:45 INFO - 'PWD': '/builds/slave/test', 12:57:45 INFO - 'SHELL': '/bin/bash', 12:57:45 INFO - 'SHLVL': '1', 12:57:45 INFO - 'TERM': 'linux', 12:57:45 INFO - 'TMOUT': '86400', 12:57:45 INFO - 'USER': 'cltbld', 12:57:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:45 INFO - '_': '/tools/buildbot/bin/python'} 12:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:45 INFO - Running setup.py (path:/tmp/pip-6QUfJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:45 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)) 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:45 INFO - Running setup.py (path:/tmp/pip-da2WpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:45 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)) 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:45 INFO - Running setup.py (path:/tmp/pip-0nYs1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:45 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)) 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:45 INFO - Running setup.py (path:/tmp/pip-PdxeCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:45 INFO - Running setup.py (path:/tmp/pip-itIQPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:46 INFO - Running setup.py (path:/tmp/pip-O4GSqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:46 INFO - Running setup.py (path:/tmp/pip-2puWqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:46 INFO - Running setup.py (path:/tmp/pip-pcl97g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:46 INFO - Running setup.py (path:/tmp/pip-DEAhBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:46 INFO - Running setup.py (path:/tmp/pip-fpGzuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:46 INFO - Running setup.py (path:/tmp/pip-beOOKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:46 INFO - Running setup.py (path:/tmp/pip-x3Qtzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:46 INFO - Running setup.py (path:/tmp/pip-ovuCVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:46 INFO - Running setup.py (path:/tmp/pip-NGL8B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:46 INFO - Running setup.py (path:/tmp/pip-KH3UQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:46 INFO - Running setup.py (path:/tmp/pip-hcP4Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:46 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)) 12:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:46 INFO - Running setup.py (path:/tmp/pip-ZRwMcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:46 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)) 12:57:46 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)) 12:57:46 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)) 12:57:46 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)) 12:57:46 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)) 12:57:46 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)) 12:57:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:46 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 12:57:46 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 12:57:46 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 12:57:46 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 12:57:46 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 12:57:46 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 12:57:48 INFO - Downloading blessings-1.6.tar.gz 12:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:48 INFO - Installing collected packages: blessings 12:57:48 INFO - Running setup.py install for blessings 12:57:49 INFO - Successfully installed blessings 12:57:49 INFO - Cleaning up... 12:57:49 INFO - Return code: 0 12:57:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:49 INFO - Reading from file tmpfile_stdout 12:57:49 INFO - Current package versions: 12:57:49 INFO - argparse == 1.2.1 12:57:49 INFO - blessings == 1.6 12:57:49 INFO - blobuploader == 1.2.4 12:57:49 INFO - docopt == 0.6.1 12:57:49 INFO - functools32 == 3.2.3-2 12:57:49 INFO - jsonschema == 2.5.1 12:57:49 INFO - manifestparser == 1.1 12:57:49 INFO - mozInstall == 1.12 12:57:49 INFO - mozcrash == 0.17 12:57:49 INFO - mozdebug == 0.1 12:57:49 INFO - mozdevice == 0.48 12:57:49 INFO - mozfile == 1.2 12:57:49 INFO - mozhttpd == 0.7 12:57:49 INFO - mozinfo == 0.9 12:57:49 INFO - mozleak == 0.1 12:57:49 INFO - mozlog == 3.3 12:57:49 INFO - moznetwork == 0.27 12:57:49 INFO - mozprocess == 0.23 12:57:49 INFO - mozprofile == 0.28 12:57:49 INFO - mozrunner == 6.12 12:57:49 INFO - mozscreenshot == 0.1 12:57:49 INFO - mozsystemmonitor == 0.3 12:57:49 INFO - moztest == 0.7 12:57:49 INFO - mozversion == 1.4 12:57:49 INFO - psutil == 3.1.1 12:57:49 INFO - requests == 1.2.3 12:57:49 INFO - wsgiref == 0.1.2 12:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:49 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')]} 12:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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')]} 12:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:49 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 12:57:49 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 12:57:49 INFO - Using env: {'DISPLAY': ':0', 12:57:49 INFO - 'HOME': '/home/cltbld', 12:57:49 INFO - 'LANG': 'en_US.UTF-8', 12:57:49 INFO - 'LANGUAGE': 'en_US:en', 12:57:49 INFO - 'LOGNAME': 'cltbld', 12:57:49 INFO - 'MAIL': '/var/mail/cltbld', 12:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:49 INFO - 'MOZ_NO_REMOTE': '1', 12:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:49 INFO - 'NO_EM_RESTART': '1', 12:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:49 INFO - 'PWD': '/builds/slave/test', 12:57:49 INFO - 'SHELL': '/bin/bash', 12:57:49 INFO - 'SHLVL': '1', 12:57:49 INFO - 'TERM': 'linux', 12:57:49 INFO - 'TMOUT': '86400', 12:57:49 INFO - 'USER': 'cltbld', 12:57:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:49 INFO - '_': '/tools/buildbot/bin/python'} 12:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 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)) 12:57:49 INFO - Cleaning up... 12:57:49 INFO - Return code: 0 12:57:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:49 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')]} 12:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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')]} 12:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:49 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 0x21c5030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2486180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, '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': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', '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 12:57:49 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 12:57:49 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 12:57:49 INFO - Using env: {'DISPLAY': ':0', 12:57:49 INFO - 'HOME': '/home/cltbld', 12:57:49 INFO - 'LANG': 'en_US.UTF-8', 12:57:49 INFO - 'LANGUAGE': 'en_US:en', 12:57:49 INFO - 'LOGNAME': 'cltbld', 12:57:49 INFO - 'MAIL': '/var/mail/cltbld', 12:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:49 INFO - 'MOZ_NO_REMOTE': '1', 12:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:49 INFO - 'NO_EM_RESTART': '1', 12:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:49 INFO - 'PWD': '/builds/slave/test', 12:57:49 INFO - 'SHELL': '/bin/bash', 12:57:49 INFO - 'SHLVL': '1', 12:57:49 INFO - 'TERM': 'linux', 12:57:49 INFO - 'TMOUT': '86400', 12:57:49 INFO - 'USER': 'cltbld', 12:57:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:49 INFO - '_': '/tools/buildbot/bin/python'} 12:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:57:49 INFO - Cleaning up... 12:57:49 INFO - Return code: 0 12:57:49 INFO - Running post-action listener: _resource_record_post_action 12:57:49 INFO - Running post-action listener: _start_resource_monitoring 12:57:49 INFO - Starting resource monitoring. 12:57:49 INFO - [mozharness: 2016-07-28 19:57:49.760133Z] Finished create-virtualenv step (success) 12:57:49 INFO - [mozharness: 2016-07-28 19:57:49.760620Z] Running install step. 12:57:49 INFO - Running pre-action listener: _resource_record_pre_action 12:57:49 INFO - Running main action method: install 12:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:49 INFO - Reading from file tmpfile_stdout 12:57:49 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:50 INFO - Reading from file tmpfile_stdout 12:57:50 INFO - Output received: 12:57:50 INFO - Usage: mozinstall [options] installer 12:57:50 INFO - Options: 12:57:50 INFO - -h, --help show this help message and exit 12:57:50 INFO - -d DEST, --destination=DEST 12:57:50 INFO - Directory to install application into. [default: 12:57:50 INFO - "/builds/slave/test"] 12:57:50 INFO - --app=APP Application being installed. [default: firefox] 12:57:50 INFO - mkdir: /builds/slave/test/build/application 12:57:50 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'] 12:57:50 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 12:58:07 INFO - Reading from file tmpfile_stdout 12:58:07 INFO - Output received: 12:58:07 INFO - /builds/slave/test/build/application/firefox/firefox 12:58:07 INFO - Running post-action listener: _resource_record_post_action 12:58:07 INFO - [mozharness: 2016-07-28 19:58:07.313824Z] Finished install step (success) 12:58:07 INFO - [mozharness: 2016-07-28 19:58:07.314099Z] Running run-tests step. 12:58:07 INFO - Running pre-action listener: _resource_record_pre_action 12:58:07 INFO - Running main action method: run_tests 12:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:58:07 INFO - Python 2.7.3 12:58:07 INFO - Return code: 0 12:58:07 INFO - grabbing minidump binary from tooltool 12:58:07 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')]} 12:58:07 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 0x24843b0>, '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 0x24852b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:58:07 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 12:58:07 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 12:58:07 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 12:58:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:07 INFO - Return code: 0 12:58:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:58:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:58:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:58:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:58:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 12:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 12:58:07 INFO - Using env: {'DISPLAY': ':0', 12:58:07 INFO - 'HOME': '/home/cltbld', 12:58:07 INFO - 'LANG': 'en_US.UTF-8', 12:58:07 INFO - 'LANGUAGE': 'en_US:en', 12:58:07 INFO - 'LOGNAME': 'cltbld', 12:58:07 INFO - 'MAIL': '/var/mail/cltbld', 12:58:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:58:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:07 INFO - 'MOZ_NO_REMOTE': '1', 12:58:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:07 INFO - 'NO_EM_RESTART': '1', 12:58:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:07 INFO - 'PWD': '/builds/slave/test', 12:58:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:58:07 INFO - 'SHELL': '/bin/bash', 12:58:07 INFO - 'SHLVL': '1', 12:58:07 INFO - 'TERM': 'linux', 12:58:07 INFO - 'TMOUT': '86400', 12:58:07 INFO - 'USER': 'cltbld', 12:58:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1469735608.405056-1343629016', 12:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:07 INFO - '_': '/tools/buildbot/bin/python'} 12:58:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 12:58:07 INFO - mozversion application_buildid: 20160728113021 12:58:07 INFO - mozversion application_changeset: 2d6fced8b624ce179cef1053d9e3952dae7c726b 12:58:07 INFO - mozversion application_display_name: Nightly 12:58:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:07 INFO - mozversion application_name: Firefox 12:58:07 INFO - mozversion application_remotingname: firefox 12:58:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:58:07 INFO - mozversion application_vendor: Mozilla 12:58:07 INFO - mozversion application_version: 50.0a1 12:58:07 INFO - mozversion platform_buildid: 20160728113021 12:58:07 INFO - mozversion platform_changeset: 2d6fced8b624ce179cef1053d9e3952dae7c726b 12:58:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:58:07 INFO - mozversion platform_version: 50.0a1 12:58:07 INFO - using testdate: 1469735887 12:58:07 INFO - actual date: 1469735887 12:58:07 INFO - starting webserver on 'localhost:33916' 12:58:07 INFO - SUITE-START | Running 2 tests 12:58:07 INFO - TEST-START | dromaeo_css 12:58:07 INFO - operating with platform_type : linux_ 12:58:07 INFO - Initialising browser for dromaeo_css test... 12:58:07 INFO - TEST-INFO | started process 27363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FMeMU/profile http://localhost:33916/getInfo.html) 12:58:11 INFO - PROCESS | 27363 | JavaScript error: , line 0: uncaught exception: undefined 12:58:11 INFO - PROCESS | 27363 | __metrics Screen width/height:1600/1200 12:58:11 INFO - PROCESS | 27363 | colorDepth:24 12:58:11 INFO - PROCESS | 27363 | Browser inner width/height: 1024/697 12:58:11 INFO - PROCESS | 27363 | __metrics 12:58:13 INFO - PROCESS | 27363 | 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" 12:58:13 INFO - PROCESS | 27363 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:14 INFO - TEST-INFO | 27363: exit 0 12:58:14 INFO - Browser initialized. 12:58:14 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:14 INFO - TEST-INFO | started process 27445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FMeMU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:26 INFO - PROCESS | 27445 | RSS: Main: 157933568 12:58:26 INFO - PROCESS | 27445 | 12:59:16 INFO - PROCESS | 27445 | 1469735956761 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:01:25 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33916/tests/dromaeo/cssquery-ext.html) 13:01:26 INFO - PROCESS | 27445 | RSS: Main: 261468160 13:01:26 INFO - PROCESS | 27445 | 13:04:29 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-ext.html (next: http://localhost:33916/tests/dromaeo/cssquery-jquery.html) 13:04:29 INFO - PROCESS | 27445 | RSS: Main: 237608960 13:04:29 INFO - PROCESS | 27445 | 13:07:31 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33916/tests/dromaeo/cssquery-mootools.html) 13:07:32 INFO - PROCESS | 27445 | RSS: Main: 228528128 13:07:32 INFO - PROCESS | 27445 | 13:10:34 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33916/tests/dromaeo/cssquery-prototype.html) 13:10:34 INFO - PROCESS | 27445 | RSS: Main: 187334656 13:10:34 INFO - PROCESS | 27445 | 13:13:37 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33916/tests/dromaeo/cssquery-yui.html) 13:13:38 INFO - PROCESS | 27445 | RSS: Main: 187129856 13:13:38 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | Cycle 1(1): loaded http://localhost:33916/tests/dromaeo/cssquery-yui.html (next: http://localhost:33916/tests/dromaeo/cssquery-dojo.html) 13:16:41 INFO - PROCESS | 27445 | RSS: Main: 272699392 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | __start_tp_report 13:16:41 INFO - PROCESS | 27445 | _x_x_mozilla_page_load 13:16:41 INFO - PROCESS | 27445 | _x_x_mozilla_page_load_details 13:16:41 INFO - PROCESS | 27445 | |i|pagename|runs| 13:16:41 INFO - PROCESS | 27445 | |0;dojo.html;2938.7355138037587;2959.1862237884584;2975.7470614997733;2996.4007198560294;3015.894443694471;5026.698398096117;5099.745012749357;5115.9488405115935;5188.8702782430455;5200;5218.973905130469;5228.29418028566;5255.632105752589;5296.920546191801;5306.602004849642;4714.693544919569;4730.432348118231;4808.759562021903;4809.206480930642;4962.330085438473;4867.847864852651;4888.853334399956;4918.508149185089;4933.260010998343;4938.259261110827;4663.417072865892;4709.952900471003;4733.479317275097;4785.808567657289;4843.491433399495;4730.124926888537;4737.478877323491;4742.075295317414;4818.132736107499;4843.9515604843855;4725.054989002179;4770.045990801819;4773.474917759044;4779.426468823729;4814.988852341013;5016.222485514714;5179.352580927384;5255.1329030709885;5294.973525132388;5295.867603309909;5536.612437129403;5607.719614019324;5610.074337734269;5613.4386561343945;5614.242077319551;5600.1599760035915;5605.859853503654;5625.634333768292;5635.8591035224445;5653.689047102408;4998.075356059141;5175.560077393464;5230.660007099526;5264.42091369949;5267.051930652481;5758.74085666146;5763.567732420085;5796.072628379439;5817.331006934257;5818.2436283282905;5542.224088627595;5577.470140336662;5587.8882422352135;5590.86022849432;5591.832245032656;5387.892242155135;5467.043267428184;5488.231647569263;5613.578981576398;5675.035244008528;5506.284183056177;5513.476219759116;5514.944850551443;5546.445355464502;5554.888902221933;5497.312835895513;5524.1989911463415;5538.086215774352;5543.445655434424;5543.556515478752;4183.372494125905;4235.936460953027;4271.636910862611;4292.441982542312;4329.956700433018;3845.250176215667;3854.113553882623;3878.7478813877005;3912.765234085964;3938.5667576566557;5286.81496147633;5322.840314790485;5334.866628334323;5335.759890804923;5338.759755810997;5343.385510666323;5522.91715624266;5651.717414129359;5655.5475561954945;5689.203511508392;5275.736213189325;5326.707031113326;5332.946670533245;5353.063213937546;5355.758990845421;4832.1543729847135;4839.032193561302;4839.370881785416;4841.903161936812;4881.243407271879;5613.158026296007;5741.655500669973;5856.648601083949;5862.325832529314;5867.559933004956;5547.7780888764;5588.41321661236;5595.188697638901;5638.436156384329;5643.717814109196;5788.305403351625;5801.477866991991;5803.7678492861505;5807.767689292381;5834.124881267844;5310.575153987595;5385.272988146707;5490.560755139659;5495.725213739217;5509.393966663744;5349.866253343697;5519.530839878656;5544.500994910478;5571.7492712828835;5613.747381367766;5353.411124776194;5379.462053794589;5390.946090539044;5391.353037635509;5395.406505284494;5249.47505249472;5333.973330133324;5356.785728570813;5383.138697808332;5427.945720542902;5402.162664786964;5446.700431476307;5450.672959622435;5498.202760599771;5499.010178167968;5462.91805622908;5466.590005749665;5513.807016754395;5518.889622207453;5530.364008139116;5141.640085194001;5180.48195180494;5326;5331.920021199763;5338.519533242027 13:16:41 INFO - PROCESS | 27445 | |1;ext.html;591.8727473593177;601.8916595012896;631.8988961766119;645.0839807473387;654.6464908949167;31354.84322578387;43403.78298108509;44245.55754442463;44260.55739442605;44290.557094429045;46477.30284045742;46920;47143.52856471434;47159;47169.29246061303;8986.865197022034;9128.817423651522;9132.954335228314;9134.040925702806;9147;8916.465012099296;9021.503817290046;9025.503597302146;9032.187103160713;9033.954830225839;9037.412568183046;9087.500187489686;9087.772805679844;9089.54552272387;9096.226820720247;9003;9014.143656352637;9051.59267832949;9053.909460905372;9060;8858.11418858109;8921.509316987564;8930.240929520998;8934.329925255566;8935.463872167691;43560.56439435628;43750.12499749987;43940.340894886605;43985.78007109944;43991.56008439939;3371;3607.2965771674535;3651.7443778935485;3727.9440808387894;4054.1486287879284;30470.695293047007;30472.238194045105;30478;30512.389752205054;30828.691713082808;4194.706370554062;4210.873673789792;4405.537418571068;4427.070315233805;4564.977175114136;371594;373381;374493;374538;377291.99999999726;64365;64759.67620161869;64875.351246486935;64876;64961.35038649647;66023.33976660269;66168.33831661718;66193.6690316555;66268;66276;15096.471623493344;15234.619134521725;15261.160636165117;15285.6178595536;15297.847021529866;11879;11885.821712674317;11887.583934562423;11890.464929078213;11896.167268291136;18398.681126603933;19683.311084112273;19726.506837328896;19783;19834.801651983584;6079.452849243589;6884.759033433906;7036.437085033185;7259.637018149071;7282.854342913112;984.389678399397;1079.4063265204106;1111.8348756147184;1121.6578943422335;1142.2917790969486;31982.680173198434;33185.83407082949;33324.166895827315;33423.66576334254;33451.49822752661;1079.2121751121567;1079.7408621930838;1104.729341311384;1104.8895110488886;1112.7663190729875;16531.33874645025;17228.310867565157;17387.217575209146;17501.08880706341;17559.561010974572;565413;568787;569339;569423;570767;41295;41300.38049429261;41343.379849302284;41420.58579414227;41459;1247.476060054761;1338.1435881036145;1355;1379.2345248387242;1395;32679.34641307113;33742.831285843415;34232.657673422946;34530.82734586311;34657.65342346645;50607.49392506028;51336.48663513317;51381.48618513917;51403.74298128486;51456.74271628618;380135;380610;381841;383434;383938;27977.20227977186;28340.10106926889;28438.573421398283;30108.548371774003;30134;49530;49635;49750.25374619456;50627.24059139042;50649.49350506448;41728.37407438952;42544.36183457312;43721.97197322349;44051.559484404745;44117.77941110402;43308.35037474504;43679;43680.344794828736;43984;44227.557724422346;40628;41640;42523.14953700847;42647.360289596305;42816.57183428126;36197;37914;38229.235415292096;38820.2235955285;39003.41494877636;28289;28348.85825570859;28661.713382865906;28742.568861466676;28861.711382885904 13:16:41 INFO - PROCESS | 27445 | |2;jquery.html;370.1948262528999;392.4055056589266;397.6699339548175;403.81828177320205;420.8505980376966;14023.228722420263;17869.642607147867;19482.318118865842;19760.90119549404;19804.702929456034;18187.54531136719;18721.719174212398;18778.342758003473;18979.905100474512;18982.145803438845;5343.1985202219785;5642.322921249445;5843.328017278003;5848.795292164775;5849.064149736043;5562.9443705562835;5694.202811606378;5708.372079071299;5719.170720245562;5721.427857214266;5592.133219351007;5627.352854421732;5645.745941432645;5673.319201695802;5762.7406766695385;5706.686132262724;5767.509761670263;5771.480566748992;5780.046292361776;5827.096799996008;5514.117741161435;5652.576056795716;5653.321601407857;5655.688937108457;5658.207850900877;13145.868541314656;14029.579112626638;22263.888680556494;22305.330840074825;22439.663405048937;2194.418479103023;2262.7963483286417;2348.283773449097;2539.885705143273;2657.7740892024203;9353.625854965792;9858.729805289606;10078.546465409001;10168.44073575953;10204.183665306758;1807.6384723055442;1813.8730288879783;1890.6124244529838;1916.5208697825544;1921.1738952250528;81734;83545;84973.57513212456;85434.16526677851;85803.14196858014;10540.156787456985;10764.300320479144;10949.233553651167;11136.220464567565;11182.273152245078;15034.323455444532;15195.468158614396;15232.543023709306;15236;15239.771403428736;7606.125295591078;7745.264199901;7890.64492097857;8036.357091432671;8090.83818323642;7436.479446438806;7506.249375062559;7585.937968684389;7738.574378409242;7739.226077392215;4648.3259927310355;4679.672422930362;4695.765211739399;4717.905641887143;4758.595519380822;1889.215975370206;1925.3165126379934;2000.899955002244;2017.465371676507;2040.9285675001602;923.1414784250711;981.6367943860818;984.5717113055844;1034.3483605328595;1036.9170466362823;18415.81584184168;19123.2350705973;19598.70601940972;19784;19992.50018749543;947.7914858731068;966.5505539923969;1007.4056306779036;1018.908298253146;1028.8559601655775;10448.837498445853;10876.782464350827;10906.61826836057;10946.288491248044;10982.890171098186;499002;504634;531122;536286;537096;54380.45619543833;75820.62089689517;95813.52093239629;96346.51826740822;97983;966.6761634852263;976.5751897924425;986.5018165826211;992.5483904823288;1047.225053460449;17080.57298567546;17145.228464718868;17821.643567128845;17928.641427171122;18208.271669133617;40393.59606403898;43075.56924430841;43645.78177109221;44219.77890110529;45053.774731126134;58412.4158758407;59295.703521482115;59750;60771;61184.082238765564;7598;7660.34887034586;7790.9220907790195;7847;7893.921060789318;11667.708307292047;11776.88223117792;12014.699632509257;12157.635270941886;12167.33079680626;10467.528961196916;10480.842787358044;10600.363978161335;10615.469226538797;10853.131749460183;10015.248856335658;10085.344452610558;10231.539580719034;10412;10545.789084218426;10480.475976201007;10714.357138571711;10724.356538607708;10830.241883068426;11429.142814289127;7835.255650713173;8142.674293028213;8233.547154906299;8256.339492840438;8297.95851020741;8584.957075214585;11013.504392302206;11417.1437142213;11616;11831.881681183078 13:16:41 INFO - PROCESS | 27445 | |3;mootools.html;1340.7318536292744;1465.2161093814811;1525.3669727063268;1650.7523871419285;1774.6894293498642;8416.326693864492;8657.69698060568;8763.430377025497;8932.33007524435;8944.821103577924;8845.557722113901;8928.598213080411;8929.73210803677;8933.374663773538;8938.597763100659;2294.919677811277;2314.687517185184;2320.1183550250967;2322.500662357593;2345.2846881701075;2332.1604222479896;2377.7146742390937;2401.939951501209;2405.050005247926;2405.651180578815;2242.7981481666648;2249.156566287642;2278.5329007553496;2336.380859072347;2371.122684606698;2161.5352699169753;2189.3541405285478;2210.7015552900393;2211.9336419907427;2216.445888527868;2249.3139592424304;2258.6160352740076;2260.050778672945;2261.570301642699;2262.2534563593977;8617.69838055665;8707.782305442352;8711.085336039689;8742.344324175649;8748.21266086049;5052.595792336641;5157.252198431244;5175.792968281265;5216.165413533854;5221.843344699665;3314.9226104519234;3325.7173140283103;3338.6661333866664;3408.5909690837257;3415.9146021349416;1082.0532034469838;1085.3596378136938;1095.3920574081383;1099.8185299425586;1109.035139428694;12189.634310970685;12318.322492262922;12340.13619046667;12341.382930853422;12347.073969452327;4348.978255108705;4426.203283409017;4530.954690453053;4563;4568.954310456919;9636;9638.855417168748;9645.565949532147;9653.71038868835;9657.275704322063;5206.062908676475;5211.035958347642;5212.400573934046;5214.270002199619;5214.556762675139;4207.5161356444405;4568.74871882043;4722.905541889212;4747.098051370229;4878.097551952829;3795.259924314732;3870.651641352292;3954.940675889864;3963.326234540135;4037.7173597848455;1152.2567943676281;1164.173436859822;1168.6201984355118;1174.8472698549133;1194.1282863509687;810.4124509730399;937.2736129499692;946.9810603788023;949.7937619223685;966.4249771386014;5839.240898683144;5915.37888521699;6178.505719542426;6193.628382297076;6491.642959637265;866.8049688820091;914.6825396825396;933.9719808405758;963.0946909904667;973.756560859785;3870.903227419337;3874.496315479026;3946.2896678597554;3949.960500395017;4049.0484736086996;10734.302270352402;11157.72105697364;11176.832347514794;11180.776384472265;11184.049355804686;11039.061679757311;11046.723831904106;11053.834192487118;11063.557457701601;11138.164637652208;7953.323967462715;8256.711015114563;8283.544405057659;8438.873416898752;8444.282236010007;6261.405166509175;6299.401556852092;6354.3963323484195;6356.396142366468;6391.105245265573;10139.645112421325;10321;10390.58437662485;10420.531076101744;10493.737656558342;10535.683929482127;10615.734606634587;10652.147828173882;10670.413127278074;10671.733206669895;7112.35988761014;7677.232276772278;7799.06411230656;7968.521888686697;8146.063202731525;8702.782430439289;8765.956170219108;8841.867371989296;8851.070637582961;8851.601677924638;7608;7721.53670779755;7761.534307941542;7837;7994.120646728739;7486.288802563748;7502.849943001219;7581.50720203185;7615.581143037186;7731.304182623591;6857.27998560164;6956.2695916928;6963.059986901703;6969.4424446045205;6970.407515361251;5009.4489606144025;5024.949750502448;5031.679091799395;5033.899322013466;5293.126634105483;5169.147090729987;5259.579233661374;5294.629375943647;5347.144456886879;5434.456554344692 13:16:41 INFO - PROCESS | 27445 | |4;prototype.html;314.13612565445027;322.0499526397129;322.19612067890614;323.6359096016981;327.31754292300553;5211.2704221408985;5268.4731526847345;5278.049951008817;5283.656562323446;5320.654157479771;5247.711375874325;5247.947520524794;5267.920981185276;5268.0517506848755;5271.499207575283;3946.78292693901;4024.859129930453;4053.736507127042;4054.878353649395;4064.4919385076864;4044.7977601119974;4098.139390727936;4107.322291821861;4125.566815484376;4134.891205485209;4060.4112403701447;4081.7755023473696;4086.427900093974;4086.8160932758096;4102.282100632392;4085.611866872642;4088.4480595119726;4107.466029416157;4126.649234815044;4135.731177473484;3446.3968805459194;3508.6842184203288;3519.6480351964597;3573.356795776759;3670.376036073874;5055;5092.26162206478;5097.923531147036;5107.157319042391;5160.380754309469;4672.135654903854;4683.2038553446;4684.742339171345;4695.826043489128;4706.599939005188;5250.947490525123;5293.258943747878;5341.252224688546;5363.892722145574;5379.327584051994;3935.704822138351;3943.369060950234;3945.565987741375;3954;3973.7417067890497;5404.189371594253;5459.890802183934;5649.322081350223;5696.430356964312;5718.42815718429;4061.4923134608175;4063;4074.490688663917;4083.8366465341055;4089.6932730045364;4141.81361838718;4147.253494370982;4158.043649960466;4173.353130264813;4176.644985176234;4411.514733379326;4699.355225671056;4716.669833111718;4733.360996265529;4745.2882067690125;5484.287042684426;5485.588580856452;5486.780528778804;5492.901419716073;5569.693666848281;1375.7386096641806;1394.6513371657086;1400.6778440958637;1405.2692599848021;1407.9648008799657;815.9265666090081;868.1795703060548;874.3398733955822;885.880406145175;888.7644774134859;4726.338312636165;4729.456112547033;4731.455882573479;4731.556875153111;4744.312074749142;4978.303037574742;4991.301217829507;5023.346964894614;5062.797877761449;5069.417017043013;4707.529247075334;4727.409073865767;4793.736344501086;4832.903341933212;4928.654994150375;2941.279386550309;2966.2139533023765;2985.552167174941;2986.4922963096324;3000.129962310949;5804.970975145182;5822.0684690449325;5839.328477225088;5852.473277405054;5865.853353666193;5519.558435325164;5715.885682286331;5739.962313378691;5742.59801813869;5762.078067509262;5820.447057529528;5834.124881267759;5835.591508594358;5843.5325173985975;5849.883002339844;5371.865703357291;5503.2020357048805;5566.582506311962;5606.24315717373;5650.378458369494;5565.805196818092;5579.916301255404;5582.944170558242;5586;5587.70903929387;5575.414581468887;5707.916610437078;5799.536037117105;5822.621529600562;5911.201987731773;4041.171559830169;4054.553999060042;4058.939115913323;4074.775887326107;4084.36692312692;5665.603407761417;5672.914906276492;5683.65898046102;5694.971525142348;5716.657000579979;5304.549113325256;5471.2887324647545;5535.142052981794;5535.8892822144135;5539.362973258127;5477.452254774491;5510.9448905510435;5532.336119665666;5540.695261760642;5545.3622833373065;5324.707141107277;5465.098258787415;5502.119660854244;5512.972435137799;5524.640898341595;5539.224508568885;5544.528715059265;5545.390007099297;5547.4175211603815;5549.972250138723;5368.489993450616;5404.83785486436;5423.376311724202;5428.240046393429;5461.972690136524 13:16:41 INFO - PROCESS | 27445 | |5;yui.html;730.9561426314425;762.8664983627865;784.8194915169511;828.3704384667651;860.5525126933994;14622.48821291255;15806.683866322695;15824.287907044181;15842.524724258275;15866.603334916634;14842.851571484282;15050.322735476902;15053.698926021472;15060.623484412896;15167.469138580153;641.6919878458343;761.794315534808;785.8114052627371;792.9643166057541;801.7073768074669;790.1426951757351;798.4690181029608;800.4796882026671;801.4429971170039;801.4590151647644;850.8723691446271;852.2500199824177;852.4757274276337;852.7484392104313;853.607340623314;674.4671709349633;834.4993004197494;849.8087930215682;850.5407080176698;861.3152543727689;618.5639124417276;619.4796371048341;619.804761500126;620.0915658560231;620.2464006232449;14908.105513669214;15006.474773382988;15023.399064037425;15026.474073407488;15027.774583381259;15578.844211557966;15630.531084067496;15782.526524204291;15809.683806323808;15861;12368.319742414164;12414.441350139265;12484.250944943333;12605;12662.303573303465;4003.0592810689463;4087.6934229932576;4163.500379954395;4206.495220573551;4208.642265407444;74573.62713186453;77878;78623;78845.60577197078;78990.21009789943;11809.822852657217;11885.40572971348;11930.582429615095;12006.939965300118;12359.32023738685;22749.976251068743;22799.658005129935;22840;22840.086396543953;22883;8269.21442462965;8388;8488.830223395498;8615.052344242129;8662.177093176138;4707.7881495332795;4763.071201115818;4891.388576427947;4943.060818444484;4956.4547899731;3425.469052296898;3483.372992861259;3505.9123521912156;3520.2959408118477;3524.4713293005743;607.3167686352853;608.2002167150272;621.1149112514648;623.6414061914327;626.317314127594;573.3607028163567;587.0938360097433;699.912510936133;747.2527472527472;751.7744676596999;8813.691520796741;9139.954300228455;9146.131117543822;9239.90760092404;9289.489078100634;541.0261529247417;627.209715758148;681.3391010719594;682.5392859819602;683.993160068393;3901.5903330150495;4125.566815484331;4147.3778933160265;4163;4258.574142585779;105226;109592;111138.44430777794;112446;113593.43203284097;92355;95282.52358738301;95474.52262738642;96159.51920240495;96405.5179724111;51137.48862511327;53373.7331313341;63929.99999999907;85257;85721;7663.195364486649;7745.457817952914;7891.487053341514;7975.80060498469;7998.520273749375;36686.63313366832;42428.57571424246;50405.24392134047;50498.2425263614;53570;68980;71089.64455177692;77940;78057;78325.60837195777;11499.425028748696;11534.94232528832;12552.686182845502;12583.112533120106;12831.679208019874;12871.420786064462;13383.464661413824;13430.4102576848;13587;14478.493252736525;12364.381780910739;12455.128141030042;12481.438335274754;13227;13470.461181552628;12174.269543827399;12338.136330456782;12916.741665166832;13644.93177534106;13826.30868456553;11424.257423267461;11705.531778728755;11935.343556104497;12179.208351457128;12182.451789669663;10364.429956352473;10680;10721.517531711248;10939.562417503528;11132.88867111351;10504.894951050392;10944.288621239593;10944.343339399662;10969.122470202205;11014.779704406028 13:16:41 INFO - PROCESS | 27445 | __end_tp_report 13:16:41 INFO - PROCESS | 27445 | __start_cc_report 13:16:41 INFO - PROCESS | 27445 | _x_x_mozilla_cycle_collect,1039 13:16:41 INFO - PROCESS | 27445 | __end_cc_report 13:16:41 INFO - PROCESS | 27445 | __startTimestamp1469737001550__endTimestamp 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | ------- Summary: start ------- 13:16:41 INFO - PROCESS | 27445 | Number of tests: 6 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#0] dojo.html Cycles:165 Average:5190.06 Median:5349.87 stddev:583.74 (10.9%) stddev-sans-first:558.18 13:16:41 INFO - PROCESS | 27445 | Values: 2938.7 2959.2 2975.7 2996.4 3015.9 5026.7 5099.7 5115.9 5188.9 5200.0 5219.0 5228.3 5255.6 5296.9 5306.6 4714.7 4730.4 4808.8 4809.2 4962.3 4867.8 4888.9 4918.5 4933.3 4938.3 4663.4 4710.0 4733.5 4785.8 4843.5 4730.1 4737.5 4742.1 4818.1 4844.0 4725.1 4770.0 4773.5 4779.4 4815.0 5016.2 5179.4 5255.1 5295.0 5295.9 5536.6 5607.7 5610.1 5613.4 5614.2 5600.2 5605.9 5625.6 5635.9 5653.7 4998.1 5175.6 5230.7 5264.4 5267.1 5758.7 5763.6 5796.1 5817.3 5818.2 5542.2 5577.5 5587.9 5590.9 5591.8 5387.9 5467.0 5488.2 5613.6 5675.0 5506.3 5513.5 5514.9 5546.4 5554.9 5497.3 5524.2 5538.1 5543.4 5543.6 4183.4 4235.9 4271.6 4292.4 4330.0 3845.3 3854.1 3878.7 3912.8 3938.6 5286.8 5322.8 5334.9 5335.8 5338.8 5343.4 5522.9 5651.7 5655.5 5689.2 5275.7 5326.7 5332.9 5353.1 5355.8 4832.2 4839.0 4839.4 4841.9 4881.2 5613.2 5741.7 5856.6 5862.3 5867.6 5547.8 5588.4 5595.2 5638.4 5643.7 5788.3 5801.5 5803.8 5807.8 5834.1 5310.6 5385.3 5490.6 5495.7 5509.4 5349.9 5519.5 5544.5 5571.7 5613.7 5353.4 5379.5 5390.9 5391.4 5395.4 5249.5 5334.0 5356.8 5383.1 5427.9 5402.2 5446.7 5450.7 5498.2 5499.0 5462.9 5466.6 5513.8 5518.9 5530.4 5141.6 5180.5 5326.0 5331.9 5338.5 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#1] ext.html Cycles:180 Average:60591.26 Median:42533.76 stddev:119587.61 (281.2%) stddev-sans-first:119838.24 13:16:41 INFO - PROCESS | 27445 | Values: 591.9 601.9 631.9 645.1 654.6 31354.8 43403.8 44245.6 44260.6 44290.6 46477.3 46920.0 47143.5 47159.0 47169.3 8986.9 9128.8 9133.0 9134.0 9147.0 8916.5 9021.5 9025.5 9032.2 9034.0 9037.4 9087.5 9087.8 9089.5 9096.2 9003.0 9014.1 9051.6 9053.9 9060.0 8858.1 8921.5 8930.2 8934.3 8935.5 43560.6 43750.1 43940.3 43985.8 43991.6 3371.0 3607.3 3651.7 3727.9 4054.1 30470.7 30472.2 30478.0 30512.4 30828.7 4194.7 4210.9 4405.5 4427.1 4565.0 371594.0 373381.0 374493.0 374538.0 377292.0 64365.0 64759.7 64875.4 64876.0 64961.4 66023.3 66168.3 66193.7 66268.0 66276.0 15096.5 15234.6 15261.2 15285.6 15297.8 11879.0 11885.8 11887.6 11890.5 11896.2 18398.7 19683.3 19726.5 19783.0 19834.8 6079.5 6884.8 7036.4 7259.6 7282.9 984.4 1079.4 1111.8 1121.7 1142.3 31982.7 33185.8 33324.2 33423.7 33451.5 1079.2 1079.7 1104.7 1104.9 1112.8 16531.3 17228.3 17387.2 17501.1 17559.6 565413.0 568787.0 569339.0 569423.0 570767.0 41295.0 41300.4 41343.4 41420.6 41459.0 1247.5 1338.1 1355.0 1379.2 1395.0 32679.3 33742.8 34232.7 34530.8 34657.7 50607.5 51336.5 51381.5 51403.7 51456.7 380135.0 380610.0 381841.0 383434.0 383938.0 27977.2 28340.1 28438.6 30108.5 30134.0 49530.0 49635.0 49750.3 50627.2 50649.5 41728.4 42544.4 43722.0 44051.6 44117.8 43308.4 43679.0 43680.3 43984.0 44227.6 40628.0 41640.0 42523.1 42647.4 42816.6 36197.0 37914.0 38229.2 38820.2 39003.4 28289.0 28348.9 28661.7 28742.6 28861.7 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#2] jquery.html Cycles:180 Average:29486.01 Median:400.74 stddev:85930.39 (21442.7%) stddev-sans-first:86143.64 13:16:41 INFO - PROCESS | 27445 | Values: 370.2 392.4 397.7 403.8 420.9 14023.2 17869.6 19482.3 19760.9 19804.7 18187.5 18721.7 18778.3 18979.9 18982.1 5343.2 5642.3 5843.3 5848.8 5849.1 5562.9 5694.2 5708.4 5719.2 5721.4 5592.1 5627.4 5645.7 5673.3 5762.7 5706.7 5767.5 5771.5 5780.0 5827.1 5514.1 5652.6 5653.3 5655.7 5658.2 13145.9 14029.6 22263.9 22305.3 22439.7 2194.4 2262.8 2348.3 2539.9 2657.8 9353.6 9858.7 10078.5 10168.4 10204.2 1807.6 1813.9 1890.6 1916.5 1921.2 81734.0 83545.0 84973.6 85434.2 85803.1 10540.2 10764.3 10949.2 11136.2 11182.3 15034.3 15195.5 15232.5 15236.0 15239.8 7606.1 7745.3 7890.6 8036.4 8090.8 7436.5 7506.2 7585.9 7738.6 7739.2 4648.3 4679.7 4695.8 4717.9 4758.6 1889.2 1925.3 2000.9 2017.5 2040.9 923.1 981.6 984.6 1034.3 1036.9 18415.8 19123.2 19598.7 19784.0 19992.5 947.8 966.6 1007.4 1018.9 1028.9 10448.8 10876.8 10906.6 10946.3 10982.9 499002.0 504634.0 531122.0 536286.0 537096.0 54380.5 75820.6 95813.5 96346.5 97983.0 966.7 976.6 986.5 992.5 1047.2 17080.6 17145.2 17821.6 17928.6 18208.3 40393.6 43075.6 43645.8 44219.8 45053.8 58412.4 59295.7 59750.0 60771.0 61184.1 7598.0 7660.3 7790.9 7847.0 7893.9 11667.7 11776.9 12014.7 12157.6 12167.3 10467.5 10480.8 10600.4 10615.5 10853.1 10015.2 10085.3 10231.5 10412.0 10545.8 10480.5 10714.4 10724.4 10830.2 11429.1 7835.3 8142.7 8233.5 8256.3 8298.0 8585.0 11013.5 11417.1 11616.0 11831.9 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#3] mootools.html Cycles:180 Average:5812.70 Median:5017.20 stddev:3343.24 (66.6%) stddev-sans-first:3335.73 13:16:41 INFO - PROCESS | 27445 | Values: 1340.7 1465.2 1525.4 1650.8 1774.7 8416.3 8657.7 8763.4 8932.3 8944.8 8845.6 8928.6 8929.7 8933.4 8938.6 2294.9 2314.7 2320.1 2322.5 2345.3 2332.2 2377.7 2401.9 2405.1 2405.7 2242.8 2249.2 2278.5 2336.4 2371.1 2161.5 2189.4 2210.7 2211.9 2216.4 2249.3 2258.6 2260.1 2261.6 2262.3 8617.7 8707.8 8711.1 8742.3 8748.2 5052.6 5157.3 5175.8 5216.2 5221.8 3314.9 3325.7 3338.7 3408.6 3415.9 1082.1 1085.4 1095.4 1099.8 1109.0 12189.6 12318.3 12340.1 12341.4 12347.1 4349.0 4426.2 4531.0 4563.0 4569.0 9636.0 9638.9 9645.6 9653.7 9657.3 5206.1 5211.0 5212.4 5214.3 5214.6 4207.5 4568.7 4722.9 4747.1 4878.1 3795.3 3870.7 3954.9 3963.3 4037.7 1152.3 1164.2 1168.6 1174.8 1194.1 810.4 937.3 947.0 949.8 966.4 5839.2 5915.4 6178.5 6193.6 6491.6 866.8 914.7 934.0 963.1 973.8 3870.9 3874.5 3946.3 3950.0 4049.0 10734.3 11157.7 11176.8 11180.8 11184.0 11039.1 11046.7 11053.8 11063.6 11138.2 7953.3 8256.7 8283.5 8438.9 8444.3 6261.4 6299.4 6354.4 6356.4 6391.1 10139.6 10321.0 10390.6 10420.5 10493.7 10535.7 10615.7 10652.1 10670.4 10671.7 7112.4 7677.2 7799.1 7968.5 8146.1 8702.8 8766.0 8841.9 8851.1 8851.6 7608.0 7721.5 7761.5 7837.0 7994.1 7486.3 7502.8 7581.5 7615.6 7731.3 6857.3 6956.3 6963.1 6969.4 6970.4 5009.4 5024.9 5031.7 5033.9 5293.1 5169.1 5259.6 5294.6 5347.1 5434.5 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#4] prototype.html Cycles:180 Average:4583.30 Median:5229.49 stddev:1346.26 (25.7%) stddev-sans-first:1311.35 13:16:41 INFO - PROCESS | 27445 | Values: 314.1 322.0 322.2 323.6 327.3 5211.3 5268.5 5278.0 5283.7 5320.7 5247.7 5247.9 5267.9 5268.1 5271.5 3946.8 4024.9 4053.7 4054.9 4064.5 4044.8 4098.1 4107.3 4125.6 4134.9 4060.4 4081.8 4086.4 4086.8 4102.3 4085.6 4088.4 4107.5 4126.6 4135.7 3446.4 3508.7 3519.6 3573.4 3670.4 5055.0 5092.3 5097.9 5107.2 5160.4 4672.1 4683.2 4684.7 4695.8 4706.6 5250.9 5293.3 5341.3 5363.9 5379.3 3935.7 3943.4 3945.6 3954.0 3973.7 5404.2 5459.9 5649.3 5696.4 5718.4 4061.5 4063.0 4074.5 4083.8 4089.7 4141.8 4147.3 4158.0 4173.4 4176.6 4411.5 4699.4 4716.7 4733.4 4745.3 5484.3 5485.6 5486.8 5492.9 5569.7 1375.7 1394.7 1400.7 1405.3 1408.0 815.9 868.2 874.3 885.9 888.8 4726.3 4729.5 4731.5 4731.6 4744.3 4978.3 4991.3 5023.3 5062.8 5069.4 4707.5 4727.4 4793.7 4832.9 4928.7 2941.3 2966.2 2985.6 2986.5 3000.1 5805.0 5822.1 5839.3 5852.5 5865.9 5519.6 5715.9 5740.0 5742.6 5762.1 5820.4 5834.1 5835.6 5843.5 5849.9 5371.9 5503.2 5566.6 5606.2 5650.4 5565.8 5579.9 5582.9 5586.0 5587.7 5575.4 5707.9 5799.5 5822.6 5911.2 4041.2 4054.6 4058.9 4074.8 4084.4 5665.6 5672.9 5683.7 5695.0 5716.7 5304.5 5471.3 5535.1 5535.9 5539.4 5477.5 5510.9 5532.3 5540.7 5545.4 5324.7 5465.1 5502.1 5513.0 5524.6 5539.2 5544.5 5545.4 5547.4 5550.0 5368.5 5404.8 5423.4 5428.2 5462.0 13:16:41 INFO - PROCESS | 27445 | 13:16:41 INFO - PROCESS | 27445 | [#5] yui.html Cycles:180 Average:19865.88 Median:23343.57 stddev:28397.09 (121.6%) stddev-sans-first:28440.40 13:16:41 INFO - PROCESS | 27445 | Values: 731.0 762.9 784.8 828.4 860.6 14622.5 15806.7 15824.3 15842.5 15866.6 14842.9 15050.3 15053.7 15060.6 15167.5 641.7 761.8 785.8 793.0 801.7 790.1 798.5 800.5 801.4 801.5 850.9 852.3 852.5 852.7 853.6 674.5 834.5 849.8 850.5 861.3 618.6 619.5 619.8 620.1 620.2 14908.1 15006.5 15023.4 15026.5 15027.8 15578.8 15630.5 15782.5 15809.7 15861.0 12368.3 12414.4 12484.3 12605.0 12662.3 4003.1 4087.7 4163.5 4206.5 4208.6 74573.6 77878.0 78623.0 78845.6 78990.2 11809.8 11885.4 11930.6 12006.9 12359.3 22750.0 22799.7 22840.0 22840.1 22883.0 8269.2 8388.0 8488.8 8615.1 8662.2 4707.8 4763.1 4891.4 4943.1 4956.5 3425.5 3483.4 3505.9 3520.3 3524.5 607.3 608.2 621.1 623.6 626.3 573.4 587.1 699.9 747.3 751.8 8813.7 9140.0 9146.1 9239.9 9289.5 541.0 627.2 681.3 682.5 684.0 3901.6 4125.6 4147.4 4163.0 4258.6 105226.0 109592.0 111138.4 112446.0 113593.4 92355.0 95282.5 95474.5 96159.5 96405.5 51137.5 53373.7 63930.0 85257.0 85721.0 7663.2 7745.5 7891.5 7975.8 7998.5 36686.6 42428.6 50405.2 50498.2 53570.0 68980.0 71089.6 77940.0 78057.0 78325.6 11499.4 11534.9 12552.7 12583.1 12831.7 12871.4 13383.5 13430.4 13587.0 14478.5 12364.4 12455.1 12481.4 13227.0 13470.5 12174.3 12338.1 12916.7 13644.9 13826.3 11424.3 11705.5 11935.3 12179.2 12182.5 10364.4 10680.0 10721.5 10939.6 11132.9 10504.9 10944.3 10944.3 10969.1 11014.8 13:16:41 INFO - PROCESS | 27445 | -------- Summary: end -------- 13:16:41 INFO - PROCESS | 27445 | 13:16:42 INFO - TEST-INFO | 27445: exit 0 13:16:42 INFO - TEST-OK | dromaeo_css | took 1114809ms 13:16:42 INFO - TEST-START | kraken 13:16:42 INFO - operating with platform_type : linux_ 13:16:42 INFO - Initialising browser for kraken test... 13:16:42 INFO - TEST-INFO | started process 27639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbbmcD/profile http://localhost:33916/getInfo.html) 13:16:45 INFO - PROCESS | 27639 | JavaScript error: , line 0: uncaught exception: undefined 13:16:46 INFO - PROCESS | 27639 | __metrics Screen width/height:1600/1200 13:16:46 INFO - PROCESS | 27639 | colorDepth:24 13:16:46 INFO - PROCESS | 27639 | Browser inner width/height: 1024/697 13:16:46 INFO - PROCESS | 27639 | __metrics 13:16:47 INFO - PROCESS | 27639 | 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:16:47 INFO - PROCESS | 27639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:48 INFO - PROCESS | 27639 | console.error: PushService: 13:16:48 INFO - PROCESS | 27639 | stateChangeProcessEnqueue: Error transitioning state 13:16:48 INFO - PROCESS | 27639 | UnknownError 13:16:48 INFO - TEST-INFO | 27639: exit 0 13:16:48 INFO - Browser initialized. 13:16:48 INFO - Running cycle 1/1 for kraken test... 13:16:48 INFO - TEST-INFO | started process 27718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbbmcD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:00 INFO - PROCESS | 27718 | RSS: Main: 158257152 13:17:00 INFO - PROCESS | 27718 | 13:17:03 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33916/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:03 INFO - PROCESS | 27718 | RSS: Main: 214634496 13:17:03 INFO - PROCESS | 27718 | 13:17:06 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33916/tests/kraken/driver.html?testName=audio-dft) 13:17:07 INFO - PROCESS | 27718 | RSS: Main: 192839680 13:17:07 INFO - PROCESS | 27718 | 13:17:10 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33916/tests/kraken/driver.html?testName=audio-fft) 13:17:10 INFO - PROCESS | 27718 | RSS: Main: 269996032 13:17:10 INFO - PROCESS | 27718 | 13:17:12 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33916/tests/kraken/driver.html?testName=audio-oscillator) 13:17:13 INFO - PROCESS | 27718 | RSS: Main: 180838400 13:17:13 INFO - PROCESS | 27718 | 13:17:15 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:16 INFO - PROCESS | 27718 | RSS: Main: 185712640 13:17:16 INFO - PROCESS | 27718 | 13:17:19 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33916/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:19 INFO - PROCESS | 27718 | RSS: Main: 220327936 13:17:19 INFO - PROCESS | 27718 | 13:17:23 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33916/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:23 INFO - PROCESS | 27718 | RSS: Main: 220864512 13:17:23 INFO - PROCESS | 27718 | 13:17:26 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33916/tests/kraken/driver.html?testName=json-parse-financial) 13:17:27 INFO - PROCESS | 27718 | RSS: Main: 221806592 13:17:27 INFO - PROCESS | 27718 | 13:17:28 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:29 INFO - PROCESS | 27718 | RSS: Main: 185470976 13:17:29 INFO - PROCESS | 27718 | 13:17:30 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:31 INFO - PROCESS | 27718 | RSS: Main: 191700992 13:17:31 INFO - PROCESS | 27718 | 13:17:33 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:34 INFO - PROCESS | 27718 | RSS: Main: 195887104 13:17:34 INFO - PROCESS | 27718 | 13:17:36 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:17:37 INFO - PROCESS | 27718 | RSS: Main: 189079552 13:17:37 INFO - PROCESS | 27718 | 13:17:40 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:40 INFO - PROCESS | 27718 | RSS: Main: 193581056 13:17:40 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | Cycle 1(1): loaded http://localhost:33916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33916/tests/kraken/driver.html?testName=ai-astar) 13:17:42 INFO - PROCESS | 27718 | RSS: Main: 244727808 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | __start_tp_report 13:17:42 INFO - PROCESS | 27718 | _x_x_mozilla_page_load 13:17:42 INFO - PROCESS | 27718 | _x_x_mozilla_page_load_details 13:17:42 INFO - PROCESS | 27718 | |i|pagename|runs| 13:17:42 INFO - PROCESS | 27718 | |0;ai-astar;102;111;110;112;112;110;111;110;109;109 13:17:42 INFO - PROCESS | 27718 | |1;audio-beat-detection;145;119;120;190;118;119;145;121;157;117 13:17:42 INFO - PROCESS | 27718 | |2;audio-dft;162;162;161;160;162;162;161;161;162;163 13:17:42 INFO - PROCESS | 27718 | |3;audio-fft;74;75;74;123;76;76;74;75;105;84 13:17:42 INFO - PROCESS | 27718 | |4;audio-oscillator;84;84;112;84;83;83;122;84;83;131 13:17:42 INFO - PROCESS | 27718 | |5;imaging-gaussian-blur;117;117;118;117;117;117;116;116;116;117 13:17:42 INFO - PROCESS | 27718 | |6;imaging-darkroom;147;146;146;146;146;145;146;145;146;145 13:17:42 INFO - PROCESS | 27718 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 13:17:42 INFO - PROCESS | 27718 | |8;json-parse-financial;51;53;52;52;53;53;52;52;52;51 13:17:42 INFO - PROCESS | 27718 | |9;json-stringify-tinderbox;62;63;62;61;62;62;62;62;67;63 13:17:42 INFO - PROCESS | 27718 | |10;stanford-crypto-aes;76;76;75;75;85;75;75;80;80;79 13:17:42 INFO - PROCESS | 27718 | |11;stanford-crypto-ccm;123;118;120;122;135;120;127;119;156;127 13:17:42 INFO - PROCESS | 27718 | |12;stanford-crypto-pbkdf2;156;154;153;156;153;158;155;156;154;159 13:17:42 INFO - PROCESS | 27718 | |13;stanford-crypto-sha256-iterative;63;63;70;65;66;62;61;61;62;65 13:17:42 INFO - PROCESS | 27718 | __end_tp_report 13:17:42 INFO - PROCESS | 27718 | __start_cc_report 13:17:42 INFO - PROCESS | 27718 | _x_x_mozilla_cycle_collect,1706 13:17:42 INFO - PROCESS | 27718 | __end_cc_report 13:17:42 INFO - PROCESS | 27718 | __startTimestamp1469737062537__endTimestamp 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | ------- Summary: start ------- 13:17:42 INFO - PROCESS | 27718 | Number of tests: 14 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.88 (2.6%) stddev-sans-first:1.13 13:17:42 INFO - PROCESS | 27718 | Values: 102.0 111.0 110.0 112.0 112.0 110.0 111.0 110.0 109.0 109.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:133.00 stddev:24.16 (18.2%) stddev-sans-first:25.36 13:17:42 INFO - PROCESS | 27718 | Values: 145.0 119.0 120.0 190.0 118.0 119.0 145.0 121.0 157.0 117.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 13:17:42 INFO - PROCESS | 27718 | Values: 162.0 162.0 161.0 160.0 162.0 162.0 161.0 161.0 162.0 163.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:16.83 (22.4%) stddev-sans-first:17.49 13:17:42 INFO - PROCESS | 27718 | Values: 74.0 75.0 74.0 123.0 76.0 76.0 74.0 75.0 105.0 84.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.50 stddev:18.94 (22.7%) stddev-sans-first:19.67 13:17:42 INFO - PROCESS | 27718 | Values: 84.0 84.0 112.0 84.0 83.0 83.0 122.0 84.0 83.0 131.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 13:17:42 INFO - PROCESS | 27718 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 13:17:42 INFO - PROCESS | 27718 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:17:42 INFO - PROCESS | 27718 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 13:17:42 INFO - PROCESS | 27718 | Values: 51.0 53.0 52.0 52.0 53.0 53.0 52.0 52.0 52.0 51.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 13:17:42 INFO - PROCESS | 27718 | Values: 62.0 63.0 62.0 61.0 62.0 62.0 62.0 62.0 67.0 63.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:3.34 (4.3%) stddev-sans-first:3.49 13:17:42 INFO - PROCESS | 27718 | Values: 76.0 76.0 75.0 75.0 85.0 75.0 75.0 80.0 80.0 79.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:11.49 (9.2%) stddev-sans-first:12.11 13:17:42 INFO - PROCESS | 27718 | Values: 123.0 118.0 120.0 122.0 135.0 120.0 127.0 119.0 156.0 127.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:156.00 stddev:2.01 (1.3%) stddev-sans-first:2.12 13:17:42 INFO - PROCESS | 27718 | Values: 156.0 154.0 153.0 156.0 153.0 158.0 155.0 156.0 154.0 159.0 13:17:42 INFO - PROCESS | 27718 | 13:17:42 INFO - PROCESS | 27718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:2.78 (4.3%) stddev-sans-first:2.93 13:17:42 INFO - PROCESS | 27718 | Values: 63.0 63.0 70.0 65.0 66.0 62.0 61.0 61.0 62.0 65.0 13:17:42 INFO - PROCESS | 27718 | -------- Summary: end -------- 13:17:42 INFO - PROCESS | 27718 | 13:17:43 INFO - TEST-INFO | 27718: exit 0 13:17:43 INFO - TEST-OK | kraken | took 61160ms 13:17:43 INFO - SUITE-END | took 1175s 13:17:43 INFO - Completed test suite (00:19:36) 13:17:43 INFO - javascript benchmark 13:17:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.7355138037587, 2959.1862237884584, 2975.7470614997733, 2996.4007198560294, 3015.894443694471, 5026.698398096117, 5099.745012749357, 5115.9488405115935, 5188.8702782430455, 5200.0, 5218.973905130469, 5228.29418028566, 5255.632105752589, 5296.920546191801, 5306.602004849642, 4714.693544919569, 4730.432348118231, 4808.759562021903, 4809.206480930642, 4962.330085438473, 4867.847864852651, 4888.853334399956, 4918.508149185089, 4933.260010998343, 4938.259261110827, 4663.417072865892, 4709.952900471003, 4733.479317275097, 4785.808567657289, 4843.491433399495, 4730.124926888537, 4737.478877323491, 4742.075295317414, 4818.132736107499, 4843.9515604843855, 4725.054989002179, 4770.045990801819, 4773.474917759044, 4779.426468823729, 4814.988852341013, 5016.222485514714, 5179.352580927384, 5255.1329030709885, 5294.973525132388, 5295.867603309909, 5536.612437129403, 5607.719614019324, 5610.074337734269, 5613.4386561343945, 5614.242077319551, 5600.1599760035915, 5605.859853503654, 5625.634333768292, 5635.8591035224445, 5653.689047102408, 4998.075356059141, 5175.560077393464, 5230.660007099526, 5264.42091369949, 5267.051930652481, 5758.74085666146, 5763.567732420085, 5796.072628379439, 5817.331006934257, 5818.2436283282905, 5542.224088627595, 5577.470140336662, 5587.8882422352135, 5590.86022849432, 5591.832245032656, 5387.892242155135, 5467.043267428184, 5488.231647569263, 5613.578981576398, 5675.035244008528, 5506.284183056177, 5513.476219759116, 5514.944850551443, 5546.445355464502, 5554.888902221933, 5497.312835895513, 5524.1989911463415, 5538.086215774352, 5543.445655434424, 5543.556515478752, 4183.372494125905, 4235.936460953027, 4271.636910862611, 4292.441982542312, 4329.956700433018, 3845.250176215667, 3854.113553882623, 3878.7478813877005, 3912.765234085964, 3938.5667576566557, 5286.81496147633, 5322.840314790485, 5334.866628334323, 5335.759890804923, 5338.759755810997, 5343.385510666323, 5522.91715624266, 5651.717414129359, 5655.5475561954945, 5689.203511508392, 5275.736213189325, 5326.707031113326, 5332.946670533245, 5353.063213937546, 5355.758990845421, 4832.1543729847135, 4839.032193561302, 4839.370881785416, 4841.903161936812, 4881.243407271879, 5613.158026296007, 5741.655500669973, 5856.648601083949, 5862.325832529314, 5867.559933004956, 5547.7780888764, 5588.41321661236, 5595.188697638901, 5638.436156384329, 5643.717814109196, 5788.305403351625, 5801.477866991991, 5803.7678492861505, 5807.767689292381, 5834.124881267844, 5310.575153987595, 5385.272988146707, 5490.560755139659, 5495.725213739217, 5509.393966663744, 5349.866253343697, 5519.530839878656, 5544.500994910478, 5571.7492712828835, 5613.747381367766, 5353.411124776194, 5379.462053794589, 5390.946090539044, 5391.353037635509, 5395.406505284494, 5249.47505249472, 5333.973330133324, 5356.785728570813, 5383.138697808332, 5427.945720542902, 5402.162664786964, 5446.700431476307, 5450.672959622435, 5498.202760599771, 5499.010178167968, 5462.91805622908, 5466.590005749665, 5513.807016754395, 5518.889622207453, 5530.364008139116, 5141.640085194001, 5180.48195180494, 5326.0, 5331.920021199763, 5338.519533242027], "value": 5150.78853015659, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.8727473593177, 601.8916595012896, 631.8988961766119, 645.0839807473387, 654.6464908949167, 31354.84322578387, 43403.78298108509, 44245.55754442463, 44260.55739442605, 44290.557094429045, 46477.30284045742, 46920.0, 47143.52856471434, 47159.0, 47169.29246061303, 8986.865197022034, 9128.817423651522, 9132.954335228314, 9134.040925702806, 9147.0, 8916.465012099296, 9021.503817290046, 9025.503597302146, 9032.187103160713, 9033.954830225839, 9037.412568183046, 9087.500187489686, 9087.772805679844, 9089.54552272387, 9096.226820720247, 9003.0, 9014.143656352637, 9051.59267832949, 9053.909460905372, 9060.0, 8858.11418858109, 8921.509316987564, 8930.240929520998, 8934.329925255566, 8935.463872167691, 43560.56439435628, 43750.12499749987, 43940.340894886605, 43985.78007109944, 43991.56008439939, 3371.0, 3607.2965771674535, 3651.7443778935485, 3727.9440808387894, 4054.1486287879284, 30470.695293047007, 30472.238194045105, 30478.0, 30512.389752205054, 30828.691713082808, 4194.706370554062, 4210.873673789792, 4405.537418571068, 4427.070315233805, 4564.977175114136, 371594.0, 373381.0, 374493.0, 374538.0, 377291.99999999726, 64365.0, 64759.67620161869, 64875.351246486935, 64876.0, 64961.35038649647, 66023.33976660269, 66168.33831661718, 66193.6690316555, 66268.0, 66276.0, 15096.471623493344, 15234.619134521725, 15261.160636165117, 15285.6178595536, 15297.847021529866, 11879.0, 11885.821712674317, 11887.583934562423, 11890.464929078213, 11896.167268291136, 18398.681126603933, 19683.311084112273, 19726.506837328896, 19783.0, 19834.801651983584, 6079.452849243589, 6884.759033433906, 7036.437085033185, 7259.637018149071, 7282.854342913112, 984.389678399397, 1079.4063265204106, 1111.8348756147184, 1121.6578943422335, 1142.2917790969486, 31982.680173198434, 33185.83407082949, 33324.166895827315, 33423.66576334254, 33451.49822752661, 1079.2121751121567, 1079.7408621930838, 1104.729341311384, 1104.8895110488886, 1112.7663190729875, 16531.33874645025, 17228.310867565157, 17387.217575209146, 17501.08880706341, 17559.561010974572, 565413.0, 568787.0, 569339.0, 569423.0, 570767.0, 41295.0, 41300.38049429261, 41343.379849302284, 41420.58579414227, 41459.0, 1247.476060054761, 1338.1435881036145, 1355.0, 1379.2345248387242, 1395.0, 32679.34641307113, 33742.831285843415, 34232.657673422946, 34530.82734586311, 34657.65342346645, 50607.49392506028, 51336.48663513317, 51381.48618513917, 51403.74298128486, 51456.74271628618, 380135.0, 380610.0, 381841.0, 383434.0, 383938.0, 27977.20227977186, 28340.10106926889, 28438.573421398283, 30108.548371774003, 30134.0, 49530.0, 49635.0, 49750.25374619456, 50627.24059139042, 50649.49350506448, 41728.37407438952, 42544.36183457312, 43721.97197322349, 44051.559484404745, 44117.77941110402, 43308.35037474504, 43679.0, 43680.344794828736, 43984.0, 44227.557724422346, 40628.0, 41640.0, 42523.14953700847, 42647.360289596305, 42816.57183428126, 36197.0, 37914.0, 38229.235415292096, 38820.2235955285, 39003.41494877636, 28289.0, 28348.85825570859, 28661.713382865906, 28742.568861466676, 28861.711382885904], "value": 20267.16343437142, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.1948262528999, 392.4055056589266, 397.6699339548175, 403.81828177320205, 420.8505980376966, 14023.228722420263, 17869.642607147867, 19482.318118865842, 19760.90119549404, 19804.702929456034, 18187.54531136719, 18721.719174212398, 18778.342758003473, 18979.905100474512, 18982.145803438845, 5343.1985202219785, 5642.322921249445, 5843.328017278003, 5848.795292164775, 5849.064149736043, 5562.9443705562835, 5694.202811606378, 5708.372079071299, 5719.170720245562, 5721.427857214266, 5592.133219351007, 5627.352854421732, 5645.745941432645, 5673.319201695802, 5762.7406766695385, 5706.686132262724, 5767.509761670263, 5771.480566748992, 5780.046292361776, 5827.096799996008, 5514.117741161435, 5652.576056795716, 5653.321601407857, 5655.688937108457, 5658.207850900877, 13145.868541314656, 14029.579112626638, 22263.888680556494, 22305.330840074825, 22439.663405048937, 2194.418479103023, 2262.7963483286417, 2348.283773449097, 2539.885705143273, 2657.7740892024203, 9353.625854965792, 9858.729805289606, 10078.546465409001, 10168.44073575953, 10204.183665306758, 1807.6384723055442, 1813.8730288879783, 1890.6124244529838, 1916.5208697825544, 1921.1738952250528, 81734.0, 83545.0, 84973.57513212456, 85434.16526677851, 85803.14196858014, 10540.156787456985, 10764.300320479144, 10949.233553651167, 11136.220464567565, 11182.273152245078, 15034.323455444532, 15195.468158614396, 15232.543023709306, 15236.0, 15239.771403428736, 7606.125295591078, 7745.264199901, 7890.64492097857, 8036.357091432671, 8090.83818323642, 7436.479446438806, 7506.249375062559, 7585.937968684389, 7738.574378409242, 7739.226077392215, 4648.3259927310355, 4679.672422930362, 4695.765211739399, 4717.905641887143, 4758.595519380822, 1889.215975370206, 1925.3165126379934, 2000.899955002244, 2017.465371676507, 2040.9285675001602, 923.1414784250711, 981.6367943860818, 984.5717113055844, 1034.3483605328595, 1036.9170466362823, 18415.81584184168, 19123.2350705973, 19598.70601940972, 19784.0, 19992.50018749543, 947.7914858731068, 966.5505539923969, 1007.4056306779036, 1018.908298253146, 1028.8559601655775, 10448.837498445853, 10876.782464350827, 10906.61826836057, 10946.288491248044, 10982.890171098186, 499002.0, 504634.0, 531122.0, 536286.0, 537096.0, 54380.45619543833, 75820.62089689517, 95813.52093239629, 96346.51826740822, 97983.0, 966.6761634852263, 976.5751897924425, 986.5018165826211, 992.5483904823288, 1047.225053460449, 17080.57298567546, 17145.228464718868, 17821.643567128845, 17928.641427171122, 18208.271669133617, 40393.59606403898, 43075.56924430841, 43645.78177109221, 44219.77890110529, 45053.774731126134, 58412.4158758407, 59295.703521482115, 59750.0, 60771.0, 61184.082238765564, 7598.0, 7660.34887034586, 7790.9220907790195, 7847.0, 7893.921060789318, 11667.708307292047, 11776.88223117792, 12014.699632509257, 12157.635270941886, 12167.33079680626, 10467.528961196916, 10480.842787358044, 10600.363978161335, 10615.469226538797, 10853.131749460183, 10015.248856335658, 10085.344452610558, 10231.539580719034, 10412.0, 10545.789084218426, 10480.475976201007, 10714.357138571711, 10724.356538607708, 10830.241883068426, 11429.142814289127, 7835.255650713173, 8142.674293028213, 8233.547154906299, 8256.339492840438, 8297.95851020741, 8584.957075214585, 11013.504392302206, 11417.1437142213, 11616.0, 11831.881681183078], "value": 8984.30261099475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.7318536292744, 1465.2161093814811, 1525.3669727063268, 1650.7523871419285, 1774.6894293498642, 8416.326693864492, 8657.69698060568, 8763.430377025497, 8932.33007524435, 8944.821103577924, 8845.557722113901, 8928.598213080411, 8929.73210803677, 8933.374663773538, 8938.597763100659, 2294.919677811277, 2314.687517185184, 2320.1183550250967, 2322.500662357593, 2345.2846881701075, 2332.1604222479896, 2377.7146742390937, 2401.939951501209, 2405.050005247926, 2405.651180578815, 2242.7981481666648, 2249.156566287642, 2278.5329007553496, 2336.380859072347, 2371.122684606698, 2161.5352699169753, 2189.3541405285478, 2210.7015552900393, 2211.9336419907427, 2216.445888527868, 2249.3139592424304, 2258.6160352740076, 2260.050778672945, 2261.570301642699, 2262.2534563593977, 8617.69838055665, 8707.782305442352, 8711.085336039689, 8742.344324175649, 8748.21266086049, 5052.595792336641, 5157.252198431244, 5175.792968281265, 5216.165413533854, 5221.843344699665, 3314.9226104519234, 3325.7173140283103, 3338.6661333866664, 3408.5909690837257, 3415.9146021349416, 1082.0532034469838, 1085.3596378136938, 1095.3920574081383, 1099.8185299425586, 1109.035139428694, 12189.634310970685, 12318.322492262922, 12340.13619046667, 12341.382930853422, 12347.073969452327, 4348.978255108705, 4426.203283409017, 4530.954690453053, 4563.0, 4568.954310456919, 9636.0, 9638.855417168748, 9645.565949532147, 9653.71038868835, 9657.275704322063, 5206.062908676475, 5211.035958347642, 5212.400573934046, 5214.270002199619, 5214.556762675139, 4207.5161356444405, 4568.74871882043, 4722.905541889212, 4747.098051370229, 4878.097551952829, 3795.259924314732, 3870.651641352292, 3954.940675889864, 3963.326234540135, 4037.7173597848455, 1152.2567943676281, 1164.173436859822, 1168.6201984355118, 1174.8472698549133, 1194.1282863509687, 810.4124509730399, 937.2736129499692, 946.9810603788023, 949.7937619223685, 966.4249771386014, 5839.240898683144, 5915.37888521699, 6178.505719542426, 6193.628382297076, 6491.642959637265, 866.8049688820091, 914.6825396825396, 933.9719808405758, 963.0946909904667, 973.756560859785, 3870.903227419337, 3874.496315479026, 3946.2896678597554, 3949.960500395017, 4049.0484736086996, 10734.302270352402, 11157.72105697364, 11176.832347514794, 11180.776384472265, 11184.049355804686, 11039.061679757311, 11046.723831904106, 11053.834192487118, 11063.557457701601, 11138.164637652208, 7953.323967462715, 8256.711015114563, 8283.544405057659, 8438.873416898752, 8444.282236010007, 6261.405166509175, 6299.401556852092, 6354.3963323484195, 6356.396142366468, 6391.105245265573, 10139.645112421325, 10321.0, 10390.58437662485, 10420.531076101744, 10493.737656558342, 10535.683929482127, 10615.734606634587, 10652.147828173882, 10670.413127278074, 10671.733206669895, 7112.35988761014, 7677.232276772278, 7799.06411230656, 7968.521888686697, 8146.063202731525, 8702.782430439289, 8765.956170219108, 8841.867371989296, 8851.070637582961, 8851.601677924638, 7608.0, 7721.53670779755, 7761.534307941542, 7837.0, 7994.120646728739, 7486.288802563748, 7502.849943001219, 7581.50720203185, 7615.581143037186, 7731.304182623591, 6857.27998560164, 6956.2695916928, 6963.059986901703, 6969.4424446045205, 6970.407515361251, 5009.4489606144025, 5024.949750502448, 5031.679091799395, 5033.899322013466, 5293.126634105483, 5169.147090729987, 5259.579233661374, 5294.629375943647, 5347.144456886879, 5434.456554344692], "value": 4616.237840241762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.13612565445027, 322.0499526397129, 322.19612067890614, 323.6359096016981, 327.31754292300553, 5211.2704221408985, 5268.4731526847345, 5278.049951008817, 5283.656562323446, 5320.654157479771, 5247.711375874325, 5247.947520524794, 5267.920981185276, 5268.0517506848755, 5271.499207575283, 3946.78292693901, 4024.859129930453, 4053.736507127042, 4054.878353649395, 4064.4919385076864, 4044.7977601119974, 4098.139390727936, 4107.322291821861, 4125.566815484376, 4134.891205485209, 4060.4112403701447, 4081.7755023473696, 4086.427900093974, 4086.8160932758096, 4102.282100632392, 4085.611866872642, 4088.4480595119726, 4107.466029416157, 4126.649234815044, 4135.731177473484, 3446.3968805459194, 3508.6842184203288, 3519.6480351964597, 3573.356795776759, 3670.376036073874, 5055.0, 5092.26162206478, 5097.923531147036, 5107.157319042391, 5160.380754309469, 4672.135654903854, 4683.2038553446, 4684.742339171345, 4695.826043489128, 4706.599939005188, 5250.947490525123, 5293.258943747878, 5341.252224688546, 5363.892722145574, 5379.327584051994, 3935.704822138351, 3943.369060950234, 3945.565987741375, 3954.0, 3973.7417067890497, 5404.189371594253, 5459.890802183934, 5649.322081350223, 5696.430356964312, 5718.42815718429, 4061.4923134608175, 4063.0, 4074.490688663917, 4083.8366465341055, 4089.6932730045364, 4141.81361838718, 4147.253494370982, 4158.043649960466, 4173.353130264813, 4176.644985176234, 4411.514733379326, 4699.355225671056, 4716.669833111718, 4733.360996265529, 4745.2882067690125, 5484.287042684426, 5485.588580856452, 5486.780528778804, 5492.901419716073, 5569.693666848281, 1375.7386096641806, 1394.6513371657086, 1400.6778440958637, 1405.2692599848021, 1407.9648008799657, 815.9265666090081, 868.1795703060548, 874.3398733955822, 885.880406145175, 888.7644774134859, 4726.338312636165, 4729.456112547033, 4731.455882573479, 4731.556875153111, 4744.312074749142, 4978.303037574742, 4991.301217829507, 5023.346964894614, 5062.797877761449, 5069.417017043013, 4707.529247075334, 4727.409073865767, 4793.736344501086, 4832.903341933212, 4928.654994150375, 2941.279386550309, 2966.2139533023765, 2985.552167174941, 2986.4922963096324, 3000.129962310949, 5804.970975145182, 5822.0684690449325, 5839.328477225088, 5852.473277405054, 5865.853353666193, 5519.558435325164, 5715.885682286331, 5739.962313378691, 5742.59801813869, 5762.078067509262, 5820.447057529528, 5834.124881267759, 5835.591508594358, 5843.5325173985975, 5849.883002339844, 5371.865703357291, 5503.2020357048805, 5566.582506311962, 5606.24315717373, 5650.378458369494, 5565.805196818092, 5579.916301255404, 5582.944170558242, 5586.0, 5587.70903929387, 5575.414581468887, 5707.916610437078, 5799.536037117105, 5822.621529600562, 5911.201987731773, 4041.171559830169, 4054.553999060042, 4058.939115913323, 4074.775887326107, 4084.36692312692, 5665.603407761417, 5672.914906276492, 5683.65898046102, 5694.971525142348, 5716.657000579979, 5304.549113325256, 5471.2887324647545, 5535.142052981794, 5535.8892822144135, 5539.362973258127, 5477.452254774491, 5510.9448905510435, 5532.336119665666, 5540.695261760642, 5545.3622833373065, 5324.707141107277, 5465.098258787415, 5502.119660854244, 5512.972435137799, 5524.640898341595, 5539.224508568885, 5544.528715059265, 5545.390007099297, 5547.4175211603815, 5549.972250138723, 5368.489993450616, 5404.83785486436, 5423.376311724202, 5428.240046393429, 5461.972690136524], "value": 4148.492298716704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.9561426314425, 762.8664983627865, 784.8194915169511, 828.3704384667651, 860.5525126933994, 14622.48821291255, 15806.683866322695, 15824.287907044181, 15842.524724258275, 15866.603334916634, 14842.851571484282, 15050.322735476902, 15053.698926021472, 15060.623484412896, 15167.469138580153, 641.6919878458343, 761.794315534808, 785.8114052627371, 792.9643166057541, 801.7073768074669, 790.1426951757351, 798.4690181029608, 800.4796882026671, 801.4429971170039, 801.4590151647644, 850.8723691446271, 852.2500199824177, 852.4757274276337, 852.7484392104313, 853.607340623314, 674.4671709349633, 834.4993004197494, 849.8087930215682, 850.5407080176698, 861.3152543727689, 618.5639124417276, 619.4796371048341, 619.804761500126, 620.0915658560231, 620.2464006232449, 14908.105513669214, 15006.474773382988, 15023.399064037425, 15026.474073407488, 15027.774583381259, 15578.844211557966, 15630.531084067496, 15782.526524204291, 15809.683806323808, 15861.0, 12368.319742414164, 12414.441350139265, 12484.250944943333, 12605.0, 12662.303573303465, 4003.0592810689463, 4087.6934229932576, 4163.500379954395, 4206.495220573551, 4208.642265407444, 74573.62713186453, 77878.0, 78623.0, 78845.60577197078, 78990.21009789943, 11809.822852657217, 11885.40572971348, 11930.582429615095, 12006.939965300118, 12359.32023738685, 22749.976251068743, 22799.658005129935, 22840.0, 22840.086396543953, 22883.0, 8269.21442462965, 8388.0, 8488.830223395498, 8615.052344242129, 8662.177093176138, 4707.7881495332795, 4763.071201115818, 4891.388576427947, 4943.060818444484, 4956.4547899731, 3425.469052296898, 3483.372992861259, 3505.9123521912156, 3520.2959408118477, 3524.4713293005743, 607.3167686352853, 608.2002167150272, 621.1149112514648, 623.6414061914327, 626.317314127594, 573.3607028163567, 587.0938360097433, 699.912510936133, 747.2527472527472, 751.7744676596999, 8813.691520796741, 9139.954300228455, 9146.131117543822, 9239.90760092404, 9289.489078100634, 541.0261529247417, 627.209715758148, 681.3391010719594, 682.5392859819602, 683.993160068393, 3901.5903330150495, 4125.566815484331, 4147.3778933160265, 4163.0, 4258.574142585779, 105226.0, 109592.0, 111138.44430777794, 112446.0, 113593.43203284097, 92355.0, 95282.52358738301, 95474.52262738642, 96159.51920240495, 96405.5179724111, 51137.48862511327, 53373.7331313341, 63929.99999999907, 85257.0, 85721.0, 7663.195364486649, 7745.457817952914, 7891.487053341514, 7975.80060498469, 7998.520273749375, 36686.63313366832, 42428.57571424246, 50405.24392134047, 50498.2425263614, 53570.0, 68980.0, 71089.64455177692, 77940.0, 78057.0, 78325.60837195777, 11499.425028748696, 11534.94232528832, 12552.686182845502, 12583.112533120106, 12831.679208019874, 12871.420786064462, 13383.464661413824, 13430.4102576848, 13587.0, 14478.493252736525, 12364.381780910739, 12455.128141030042, 12481.438335274754, 13227.0, 13470.461181552628, 12174.269543827399, 12338.136330456782, 12916.741665166832, 13644.93177534106, 13826.30868456553, 11424.257423267461, 11705.531778728755, 11935.343556104497, 12179.208351457128, 12182.451789669663, 10364.429956352473, 10680.0, 10721.517531711248, 10939.562417503528, 11132.88867111351, 10504.894951050392, 10944.288621239593, 10944.343339399662, 10969.122470202205, 11014.779704406028], "value": 7326.675250092767, "unit": "score"}], "name": "dromaeo_css", "value": 7132.041642471674, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 112.0, 112.0, 110.0, 111.0, 110.0, 109.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 120.0, 190.0, 118.0, 119.0, 145.0, 121.0, 157.0, 117.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 123.0, 76.0, 76.0, 74.0, 75.0, 105.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 83.0, 83.0, 122.0, 84.0, 83.0, 131.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 67.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 85.0, 75.0, 75.0, 80.0, 80.0, 79.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 118.0, 120.0, 122.0, 135.0, 120.0, 127.0, 119.0, 156.0, 127.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 153.0, 156.0, 153.0, 158.0, 155.0, 156.0, 154.0, 159.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 70.0, 65.0, 66.0, 62.0, 61.0, 61.0, 62.0, 65.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1480.8, "alertThreshold": 2.0}]} 13:17:43 INFO - Return code: 0 13:17:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:17:43 INFO - # TBPL SUCCESS # 13:17:43 INFO - Running post-action listener: _resource_record_post_action 13:17:43 INFO - [mozharness: 2016-07-28 20:17:43.851965Z] Finished run-tests step (success) 13:17:43 INFO - Running post-run listener: _resource_record_post_run 13:17:43 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 562384896; Read time: 0; Write time: 1092116 13:17:43 INFO - TinderboxPrint: CPU usage
13.1% 13:17:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:17:43 INFO - TinderboxPrint: I/O write bytes / time
562,384,896 / 1,092,116 13:17:43 INFO - TinderboxPrint: CPU idle
8,280.9 (86.9%) 13:17:43 INFO - TinderboxPrint: CPU user
1,194.2 (12.5%) 13:17:43 INFO - TinderboxPrint: Swap in / out
0 / 0 13:17:43 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 267427840; Read time: 0; Write time: 627848 13:17:43 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294957056; Read time: 0; Write time: 464268 13:17:44 INFO - Running post-run listener: _upload_blobber_files 13:17:44 INFO - Blob upload gear active. 13:17:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:44 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:17:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:17:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:17:44 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:48 INFO - (blobuploader) - INFO - Done attempting. 13:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:49 INFO - (blobuploader) - INFO - Done attempting. 13:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:49 INFO - (blobuploader) - INFO - Done attempting. 13:17:49 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:49 INFO - Return code: 0 13:17:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afe659e2a9e2257733009b3ecfa9fd1d62655cf243cda234320e064445112827a80fb0065a953604210cbfab6ed0eba827e6f4839872004fe1d3cb9e7d9b9f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61b71f69a0e7af4cb2240bdab4b79d99b3b25c19bd1f986e28c8f73f2c58b3fcb374c686e407b3743874490e89f4078a09d0fd30b02c7fe9eaf556be4a6bce8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4fefd77d73a392058c057c20da0d22d889ab2737b8345a6f0ee1941a1452d246eb512db6387aac1552ef5ba5de9dccc838c866675447c015fecb99ee8363d2"} 13:17:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:49 INFO - Contents: 13:17:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afe659e2a9e2257733009b3ecfa9fd1d62655cf243cda234320e064445112827a80fb0065a953604210cbfab6ed0eba827e6f4839872004fe1d3cb9e7d9b9f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61b71f69a0e7af4cb2240bdab4b79d99b3b25c19bd1f986e28c8f73f2c58b3fcb374c686e407b3743874490e89f4078a09d0fd30b02c7fe9eaf556be4a6bce8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4fefd77d73a392058c057c20da0d22d889ab2737b8345a6f0ee1941a1452d246eb512db6387aac1552ef5ba5de9dccc838c866675447c015fecb99ee8363d2"} 13:17:49 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:49 INFO - Copying logs to upload dir... 13:17:49 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.206690 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-28 13:17:49.731879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:17:49.735995) ========= 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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 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/sha512/afe659e2a9e2257733009b3ecfa9fd1d62655cf243cda234320e064445112827a80fb0065a953604210cbfab6ed0eba827e6f4839872004fe1d3cb9e7d9b9f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61b71f69a0e7af4cb2240bdab4b79d99b3b25c19bd1f986e28c8f73f2c58b3fcb374c686e407b3743874490e89f4078a09d0fd30b02c7fe9eaf556be4a6bce8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4fefd77d73a392058c057c20da0d22d889ab2737b8345a6f0ee1941a1452d246eb512db6387aac1552ef5ba5de9dccc838c866675447c015fecb99ee8363d2"} build_url:https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/MiZSlYTRR6W-yqzpg94SLw/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/sha512/afe659e2a9e2257733009b3ecfa9fd1d62655cf243cda234320e064445112827a80fb0065a953604210cbfab6ed0eba827e6f4839872004fe1d3cb9e7d9b9f48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d61b71f69a0e7af4cb2240bdab4b79d99b3b25c19bd1f986e28c8f73f2c58b3fcb374c686e407b3743874490e89f4078a09d0fd30b02c7fe9eaf556be4a6bce8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ce4fefd77d73a392058c057c20da0d22d889ab2737b8345a6f0ee1941a1452d246eb512db6387aac1552ef5ba5de9dccc838c866675447c015fecb99ee8363d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-28 13:17:49.762893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:17:49.763359) ========= 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=745a4373a2a16df560f216e000000264-1469735608.405056-1343629016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-28 13:17:49.845444) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:17:49.845885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-28 13:17:49.846273) ========= ========= Total master_lag: 0.19 =========