builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1470291854.87 results: success (0) buildid: 20160803203014 builduid: 630ae9772a694b2eaeb6705697d1e800 revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:14.868889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:14.869427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:14.869703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.059255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.059663) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 23:24:15-- 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% 51.0M=0s 2016-08-03 23:24:15 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.179161) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.179505) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019048 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.230138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.230565) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 03e541a38d87381782c7fccea38aaa32cdd491df --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 03e541a38d87381782c7fccea38aaa32cdd491df --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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 23:24:15,461 truncating revision to first 12 chars 2016-08-03 23:24:15,462 Setting DEBUG logging. 2016-08-03 23:24:15,462 attempt 1/10 2016-08-03 23:24:15,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/03e541a38d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 23:24:15,811 unpacking tar archive at: fx-team-03e541a38d87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.922841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.923331) ========= script_repo_revision: 03e541a38d87381782c7fccea38aaa32cdd491df ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.923939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.924377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 23:24:15.947760) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 23:24:15.948365) ========= /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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:24:16 INFO - MultiFileLogger online at 20160803 23:24:16 in /builds/slave/test 23:24:16 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 23:24:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:24:16 INFO - {'append_to_log': False, 23:24:16 INFO - 'base_work_dir': '/builds/slave/test', 23:24:16 INFO - 'blob_upload_branch': 'Fx-Team', 23:24:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:24:16 INFO - 'branch': 'Fx-Team', 23:24:16 INFO - 'buildbot_json_path': 'buildprops.json', 23:24:16 INFO - 'config_files': ('talos/linux_config.py',), 23:24:16 INFO - 'default_actions': ('clobber', 23:24:16 INFO - 'read-buildbot-config', 23:24:16 INFO - 'download-and-extract', 23:24:16 INFO - 'populate-webroot', 23:24:16 INFO - 'create-virtualenv', 23:24:16 INFO - 'install', 23:24:16 INFO - 'run-tests'), 23:24:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:24:16 INFO - 'download_minidump_stackwalk': True, 23:24:16 INFO - 'download_symbols': 'ondemand', 23:24:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:24:16 INFO - 'tooltool.py': '/tools/tooltool.py', 23:24:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:24:16 INFO - '/tools/misc-python/virtualenv.py')}, 23:24:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:24:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:24:16 INFO - 'installer_path': 'installer.exe', 23:24:16 INFO - 'log_level': 'info', 23:24:16 INFO - 'log_name': 'talos', 23:24:16 INFO - 'log_to_console': True, 23:24:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:24:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:24:16 INFO - 'opt_config_files': (), 23:24:16 INFO - 'pip_index': False, 23:24:16 INFO - 'sps_profile': False, 23:24:16 INFO - 'sps_profile_interval': 0, 23:24:16 INFO - 'suite': 'dromaeojs', 23:24:16 INFO - 'system_bits': '32', 23:24:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:24:16 INFO - 'title': 'talos-linux64-ix-011', 23:24:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:24:16 INFO - 'use_talos_json': True, 23:24:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:24:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:24:16 INFO - 'work_dir': 'build'} 23:24:16 INFO - [mozharness: 2016-08-04 06:24:16.277926Z] Running clobber step. 23:24:16 INFO - Running pre-action listener: _resource_record_pre_action 23:24:16 INFO - Running main action method: clobber 23:24:16 INFO - rmtree: /builds/slave/test/build 23:24:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:24:17 INFO - Running post-action listener: _resource_record_post_action 23:24:17 INFO - [mozharness: 2016-08-04 06:24:17.255129Z] Finished clobber step (success) 23:24:17 INFO - [mozharness: 2016-08-04 06:24:17.255230Z] Running read-buildbot-config step. 23:24:17 INFO - Running pre-action listener: _resource_record_pre_action 23:24:17 INFO - Running main action method: read_buildbot_config 23:24:17 INFO - Using buildbot properties: 23:24:17 INFO - { 23:24:17 INFO - "project": "", 23:24:17 INFO - "product": "firefox", 23:24:17 INFO - "script_repo_revision": "production", 23:24:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:24:17 INFO - "repository": "", 23:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:24:17 INFO - "buildid": "20160803203014", 23:24:17 INFO - "pgo_build": "True", 23:24:17 INFO - "basedir": "/builds/slave/test", 23:24:17 INFO - "buildnumber": 953, 23:24:17 INFO - "slavename": "talos-linux64-ix-011", 23:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:24:17 INFO - "platform": "ubuntu64_hw", 23:24:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:24:17 INFO - "branch": "fx-team", 23:24:17 INFO - "repo_path": "integration/fx-team", 23:24:17 INFO - "revision": "03e541a38d87381782c7fccea38aaa32cdd491df", 23:24:17 INFO - "stage_platform": "linux64-pgo", 23:24:17 INFO - "builduid": "630ae9772a694b2eaeb6705697d1e800", 23:24:17 INFO - "slavebuilddir": "test" 23:24:17 INFO - } 23:24:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:24:17 INFO - Running post-action listener: _resource_record_post_action 23:24:17 INFO - [mozharness: 2016-08-04 06:24:17.257741Z] Finished read-buildbot-config step (success) 23:24:17 INFO - [mozharness: 2016-08-04 06:24:17.257831Z] Running download-and-extract step. 23:24:17 INFO - Running pre-action listener: _resource_record_pre_action 23:24:17 INFO - Running main action method: download_and_extract 23:24:17 INFO - mkdir: /builds/slave/test/build/tests 23:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:17 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:24:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:24:19 INFO - Downloaded 1361 bytes. 23:24:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:24:19 INFO - Using the following test package requirements: 23:24:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:24:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:24:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'jsshell-linux-x86_64.zip'], 23:24:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:24:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:24:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:24:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:24:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:24:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:24:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:24:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:24: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')]} 23:24:19 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:21 INFO - Downloaded 21813316 bytes. 23:24:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:24:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:24:22 INFO - Return code: 0 23:24:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:22 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:24:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:24:24 INFO - Downloaded 21813316 bytes. 23:24:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:24:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:24:25 INFO - Return code: 0 23:24: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')]} 23:24:25 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:24:27 INFO - Downloaded 14413723 bytes. 23:24:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:24:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:24:27 INFO - Return code: 0 23:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:27 INFO - https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:24:30 INFO - Downloaded 59348740 bytes. 23:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:30 INFO - mkdir: /builds/slave/test/properties 23:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 23:24:30 INFO - Contents: 23:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:24:31 INFO - Running post-action listener: _resource_record_post_action 23:24:31 INFO - Running post-action listener: set_extra_try_arguments 23:24:31 INFO - [mozharness: 2016-08-04 06:24:31.096898Z] Finished download-and-extract step (success) 23:24:31 INFO - [mozharness: 2016-08-04 06:24:31.097131Z] Running populate-webroot step. 23:24:31 INFO - Running pre-action listener: _resource_record_pre_action 23:24:31 INFO - Running main action method: populate_webroot 23:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:31 INFO - '--tppagecycles', 23:24:31 INFO - '7'], 23:24:31 INFO - 'tests': ['tsvgm']}}, 23:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['damp', 'tps']}, 23:24:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'tests': ['damp', 'tps']}, 23:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['dromaeo_dom']}, 23:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['basic_compositor_video']}, 23:24:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['a11yr', 23:24:31 INFO - 'ts_paint', 23:24:31 INFO - 'tpaint', 23:24:31 INFO - 'sessionrestore', 23:24:31 INFO - 'sessionrestore_no_auto_restore', 23:24:31 INFO - 'tabpaint']}, 23:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['tsvgx', 23:24:31 INFO - 'tsvgr_opacity', 23:24:31 INFO - 'tart', 23:24:31 INFO - 'tscrollx', 23:24:31 INFO - 'cart']}, 23:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:31 INFO - 'tsvgr_opacity', 23:24:31 INFO - 'tart', 23:24:31 INFO - 'tscrollx', 23:24:31 INFO - 'cart']}, 23:24:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'talos_options': ['--disable-e10s'], 23:24:31 INFO - 'tests': ['tp5o']}, 23:24:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'tests': ['tp5o']}, 23:24:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'talos_options': ['--disable-e10s', 23:24:31 INFO - '--xperf_path', 23:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:31 INFO - 'tests': ['tp5n']}, 23:24:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:24:31 INFO - 'talos_options': ['--xperf_path', 23:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:31 INFO - 'tests': ['tp5n']}}, 23:24:31 INFO - 'talos.zip': {'path': '', 23:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:31 INFO - Running post-action listener: _resource_record_post_action 23:24:31 INFO - [mozharness: 2016-08-04 06:24:31.118167Z] Finished populate-webroot step (success) 23:24:31 INFO - [mozharness: 2016-08-04 06:24:31.118255Z] Running create-virtualenv step. 23:24:31 INFO - Running pre-action listener: _resource_record_pre_action 23:24:31 INFO - Running main action method: create_virtualenv 23:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:31 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 23:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:31 INFO - Using real prefix '/usr' 23:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:31 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:33 INFO - Installing pip.................done. 23:24:33 INFO - Return code: 0 23:24:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:33 INFO - Using env: {'DISPLAY': ':0', 23:24:33 INFO - 'HOME': '/home/cltbld', 23:24:33 INFO - 'LANG': 'en_US.UTF-8', 23:24:33 INFO - 'LANGUAGE': 'en_US:en', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MAIL': '/var/mail/cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SHLVL': '1', 23:24:33 INFO - 'TERM': 'linux', 23:24:33 INFO - 'TMOUT': '86400', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - '_': '/tools/buildbot/bin/python'} 23:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:24:33 INFO - Cleaning up... 23:24:33 INFO - Return code: 0 23:24:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:33 INFO - Using env: {'DISPLAY': ':0', 23:24:33 INFO - 'HOME': '/home/cltbld', 23:24:33 INFO - 'LANG': 'en_US.UTF-8', 23:24:33 INFO - 'LANGUAGE': 'en_US:en', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MAIL': '/var/mail/cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SHLVL': '1', 23:24:33 INFO - 'TERM': 'linux', 23:24:33 INFO - 'TMOUT': '86400', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - '_': '/tools/buildbot/bin/python'} 23:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:34 INFO - Downloading/unpacking psutil>=3.1.1 23:24:34 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 23:24:34 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 23:24:34 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 23:24:34 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 23:24:34 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 23:24:34 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 23:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:36 INFO - Installing collected packages: psutil 23:24:36 INFO - Running setup.py install for psutil 23:24:36 INFO - building 'psutil._psutil_linux' extension 23:24:36 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 23:24:36 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 23:24:36 INFO - building 'psutil._psutil_posix' extension 23:24:36 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 23:24:36 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 23:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:36 INFO - Successfully installed psutil 23:24:36 INFO - Cleaning up... 23:24:36 INFO - Return code: 0 23:24:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:24:36 INFO - Using env: {'DISPLAY': ':0', 23:24:36 INFO - 'HOME': '/home/cltbld', 23:24:36 INFO - 'LANG': 'en_US.UTF-8', 23:24:36 INFO - 'LANGUAGE': 'en_US:en', 23:24:36 INFO - 'LOGNAME': 'cltbld', 23:24:36 INFO - 'MAIL': '/var/mail/cltbld', 23:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:36 INFO - 'MOZ_NO_REMOTE': '1', 23:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:36 INFO - 'NO_EM_RESTART': '1', 23:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:36 INFO - 'PWD': '/builds/slave/test', 23:24:36 INFO - 'SHELL': '/bin/bash', 23:24:36 INFO - 'SHLVL': '1', 23:24:36 INFO - 'TERM': 'linux', 23:24:36 INFO - 'TMOUT': '86400', 23:24:36 INFO - 'USER': 'cltbld', 23:24:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:36 INFO - '_': '/tools/buildbot/bin/python'} 23:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:38 INFO - Installing collected packages: mozsystemmonitor 23:24:38 INFO - Running setup.py install for mozsystemmonitor 23:24:38 INFO - Successfully installed mozsystemmonitor 23:24:38 INFO - Cleaning up... 23:24:39 INFO - Return code: 0 23:24:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24:39 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')]} 23:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:39 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')]} 23:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:39 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 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:39 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 23:24:39 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 23:24:39 INFO - Using env: {'DISPLAY': ':0', 23:24:39 INFO - 'HOME': '/home/cltbld', 23:24:39 INFO - 'LANG': 'en_US.UTF-8', 23:24:39 INFO - 'LANGUAGE': 'en_US:en', 23:24:39 INFO - 'LOGNAME': 'cltbld', 23:24:39 INFO - 'MAIL': '/var/mail/cltbld', 23:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:39 INFO - 'MOZ_NO_REMOTE': '1', 23:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:39 INFO - 'NO_EM_RESTART': '1', 23:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:39 INFO - 'PWD': '/builds/slave/test', 23:24:39 INFO - 'SHELL': '/bin/bash', 23:24:39 INFO - 'SHLVL': '1', 23:24:39 INFO - 'TERM': 'linux', 23:24:39 INFO - 'TMOUT': '86400', 23:24:39 INFO - 'USER': 'cltbld', 23:24:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:39 INFO - '_': '/tools/buildbot/bin/python'} 23:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:39 INFO - Downloading/unpacking jsonschema==2.5.1 23:24:39 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 23:24:39 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 23:24:39 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 23:24:39 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 23:24:39 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 23:24:39 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 23:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:41 INFO - warning: no files found matching '*.txt' 23:24:41 INFO - no previously-included directories found matching 'build' 23:24:41 INFO - no previously-included directories found matching 'dist' 23:24:41 INFO - no previously-included directories found matching '.git*' 23:24:41 INFO - Installing collected packages: jsonschema, functools32 23:24:41 INFO - Running setup.py install for functools32 23:24:41 INFO - warning: no files found matching '*.txt' 23:24:41 INFO - no previously-included directories found matching 'build' 23:24:41 INFO - no previously-included directories found matching 'dist' 23:24:41 INFO - no previously-included directories found matching '.git*' 23:24:41 INFO - Successfully installed jsonschema functools32 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:24:41 INFO - Cleaning up... 23:24:41 INFO - Return code: 0 23:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:24:41 INFO - Using env: {'DISPLAY': ':0', 23:24:41 INFO - 'HOME': '/home/cltbld', 23:24:41 INFO - 'LANG': 'en_US.UTF-8', 23:24:41 INFO - 'LANGUAGE': 'en_US:en', 23:24:41 INFO - 'LOGNAME': 'cltbld', 23:24:41 INFO - 'MAIL': '/var/mail/cltbld', 23:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:41 INFO - 'MOZ_NO_REMOTE': '1', 23:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:41 INFO - 'NO_EM_RESTART': '1', 23:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:41 INFO - 'PWD': '/builds/slave/test', 23:24:41 INFO - 'SHELL': '/bin/bash', 23:24:41 INFO - 'SHLVL': '1', 23:24:41 INFO - 'TERM': 'linux', 23:24:41 INFO - 'TMOUT': '86400', 23:24:41 INFO - 'USER': 'cltbld', 23:24:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:41 INFO - '_': '/tools/buildbot/bin/python'} 23:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:41 INFO - Downloading/unpacking blobuploader==1.2.4 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:43 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:44 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 23:24:44 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 23:24:44 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 23:24:44 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 23:24:44 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 23:24:44 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 23:24:44 INFO - Downloading docopt-0.6.1.tar.gz 23:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:44 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:44 INFO - Running setup.py install for blobuploader 23:24:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:44 INFO - Running setup.py install for requests 23:24:45 INFO - Running setup.py install for docopt 23:24:45 INFO - Successfully installed blobuploader requests docopt 23:24:45 INFO - Cleaning up... 23:24:45 INFO - Return code: 0 23:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:45 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 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:45 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 23:24:45 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 23:24:45 INFO - Using env: {'DISPLAY': ':0', 23:24:45 INFO - 'HOME': '/home/cltbld', 23:24:45 INFO - 'LANG': 'en_US.UTF-8', 23:24:45 INFO - 'LANGUAGE': 'en_US:en', 23:24:45 INFO - 'LOGNAME': 'cltbld', 23:24:45 INFO - 'MAIL': '/var/mail/cltbld', 23:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:45 INFO - 'MOZ_NO_REMOTE': '1', 23:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:45 INFO - 'NO_EM_RESTART': '1', 23:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:45 INFO - 'PWD': '/builds/slave/test', 23:24:45 INFO - 'SHELL': '/bin/bash', 23:24:45 INFO - 'SHLVL': '1', 23:24:45 INFO - 'TERM': 'linux', 23:24:45 INFO - 'TMOUT': '86400', 23:24:45 INFO - 'USER': 'cltbld', 23:24:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:45 INFO - '_': '/tools/buildbot/bin/python'} 23:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:45 INFO - Running setup.py (path:/tmp/pip-Ljtilc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:45 INFO - Running setup.py (path:/tmp/pip-nJsscv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:45 INFO - Running setup.py (path:/tmp/pip-_YWtZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:45 INFO - Running setup.py (path:/tmp/pip-qxR9PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:45 INFO - Running setup.py (path:/tmp/pip-Uv5GoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:45 INFO - Running setup.py (path:/tmp/pip-BhHMYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:45 INFO - Running setup.py (path:/tmp/pip-0aVFZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:45 INFO - Running setup.py (path:/tmp/pip-9jSl2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:46 INFO - Running setup.py (path:/tmp/pip-k383st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:46 INFO - Running setup.py (path:/tmp/pip-q1PAU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:46 INFO - Running setup.py (path:/tmp/pip-nqDo8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:46 INFO - Running setup.py (path:/tmp/pip-p4VhKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:46 INFO - Running setup.py (path:/tmp/pip-DVAFxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:46 INFO - Running setup.py (path:/tmp/pip-lE6D9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:46 INFO - Running setup.py (path:/tmp/pip-WvLi0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:46 INFO - Running setup.py (path:/tmp/pip-AyAeGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:46 INFO - Running setup.py (path:/tmp/pip-klQoVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:46 INFO - Running setup.py install for manifestparser 23:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:46 INFO - Running setup.py install for mozcrash 23:24:46 INFO - Running setup.py install for mozdebug 23:24:47 INFO - Running setup.py install for mozdevice 23:24:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozfile 23:24:47 INFO - Running setup.py install for mozhttpd 23:24:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozinfo 23:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozInstall 23:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozleak 23:24:47 INFO - Running setup.py install for mozlog 23:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for moznetwork 23:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:47 INFO - Running setup.py install for mozprocess 23:24:47 INFO - Running setup.py install for mozprofile 23:24:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Running setup.py install for mozrunner 23:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Running setup.py install for mozscreenshot 23:24:48 INFO - Running setup.py install for moztest 23:24:48 INFO - Running setup.py install for mozversion 23:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:48 INFO - Cleaning up... 23:24:48 INFO - Return code: 0 23:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:48 INFO - Using env: {'DISPLAY': ':0', 23:24:48 INFO - 'HOME': '/home/cltbld', 23:24:48 INFO - 'LANG': 'en_US.UTF-8', 23:24:48 INFO - 'LANGUAGE': 'en_US:en', 23:24:48 INFO - 'LOGNAME': 'cltbld', 23:24:48 INFO - 'MAIL': '/var/mail/cltbld', 23:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:48 INFO - 'MOZ_NO_REMOTE': '1', 23:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:48 INFO - 'NO_EM_RESTART': '1', 23:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:48 INFO - 'PWD': '/builds/slave/test', 23:24:48 INFO - 'SHELL': '/bin/bash', 23:24:48 INFO - 'SHLVL': '1', 23:24:48 INFO - 'TERM': 'linux', 23:24:48 INFO - 'TMOUT': '86400', 23:24:48 INFO - 'USER': 'cltbld', 23:24:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:48 INFO - '_': '/tools/buildbot/bin/python'} 23:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:48 INFO - Running setup.py (path:/tmp/pip-tSGPxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:48 INFO - Running setup.py (path:/tmp/pip-Ngh71h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:48 INFO - Running setup.py (path:/tmp/pip-Dg5lo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:48 INFO - Running setup.py (path:/tmp/pip-1RDBFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:49 INFO - Running setup.py (path:/tmp/pip-12VR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:49 INFO - Running setup.py (path:/tmp/pip-4_zmLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:49 INFO - Running setup.py (path:/tmp/pip-M1zFY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:49 INFO - Running setup.py (path:/tmp/pip-SuRNBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:49 INFO - Running setup.py (path:/tmp/pip-sxMGog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:49 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)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:49 INFO - Running setup.py (path:/tmp/pip-UnRZqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:49 INFO - Running setup.py (path:/tmp/pip-MlsdN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:49 INFO - Running setup.py (path:/tmp/pip-Z6_aSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 INFO - Running setup.py (path:/tmp/pip-X69lyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 INFO - Running setup.py (path:/tmp/pip-v87qu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 INFO - Running setup.py (path:/tmp/pip-oIot6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:49 INFO - Running setup.py (path:/tmp/pip-QBZOQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:49 INFO - Running setup.py (path:/tmp/pip-eUFJOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:51 INFO - Downloading blessings-1.6.tar.gz 23:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:51 INFO - Installing collected packages: blessings 23:24:51 INFO - Running setup.py install for blessings 23:24:52 INFO - Successfully installed blessings 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:52 INFO - Reading from file tmpfile_stdout 23:24:52 INFO - Current package versions: 23:24:52 INFO - argparse == 1.2.1 23:24:52 INFO - blessings == 1.6 23:24:52 INFO - blobuploader == 1.2.4 23:24:52 INFO - docopt == 0.6.1 23:24:52 INFO - functools32 == 3.2.3-2 23:24:52 INFO - jsonschema == 2.5.1 23:24:52 INFO - manifestparser == 1.1 23:24:52 INFO - mozInstall == 1.12 23:24:52 INFO - mozcrash == 0.17 23:24:52 INFO - mozdebug == 0.1 23:24:52 INFO - mozdevice == 0.48 23:24:52 INFO - mozfile == 1.2 23:24:52 INFO - mozhttpd == 0.7 23:24:52 INFO - mozinfo == 0.9 23:24:52 INFO - mozleak == 0.1 23:24:52 INFO - mozlog == 3.3 23:24:52 INFO - moznetwork == 0.27 23:24:52 INFO - mozprocess == 0.23 23:24:52 INFO - mozprofile == 0.28 23:24:52 INFO - mozrunner == 6.12 23:24:52 INFO - mozscreenshot == 0.1 23:24:52 INFO - mozsystemmonitor == 0.3 23:24:52 INFO - moztest == 0.7 23:24:52 INFO - mozversion == 1.4 23:24:52 INFO - psutil == 3.1.1 23:24:52 INFO - requests == 1.2.3 23:24:52 INFO - wsgiref == 0.1.2 23:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 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 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:52 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 23:24:52 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 23:24:52 INFO - Using env: {'DISPLAY': ':0', 23:24:52 INFO - 'HOME': '/home/cltbld', 23:24:52 INFO - 'LANG': 'en_US.UTF-8', 23:24:52 INFO - 'LANGUAGE': 'en_US:en', 23:24:52 INFO - 'LOGNAME': 'cltbld', 23:24:52 INFO - 'MAIL': '/var/mail/cltbld', 23:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:52 INFO - 'MOZ_NO_REMOTE': '1', 23:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:52 INFO - 'NO_EM_RESTART': '1', 23:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:52 INFO - 'PWD': '/builds/slave/test', 23:24:52 INFO - 'SHELL': '/bin/bash', 23:24:52 INFO - 'SHLVL': '1', 23:24:52 INFO - 'TERM': 'linux', 23:24:52 INFO - 'TMOUT': '86400', 23:24:52 INFO - 'USER': 'cltbld', 23:24:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:52 INFO - '_': '/tools/buildbot/bin/python'} 23:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1018030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12d9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', '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 23:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:52 INFO - Using env: {'DISPLAY': ':0', 23:24:52 INFO - 'HOME': '/home/cltbld', 23:24:52 INFO - 'LANG': 'en_US.UTF-8', 23:24:52 INFO - 'LANGUAGE': 'en_US:en', 23:24:52 INFO - 'LOGNAME': 'cltbld', 23:24:52 INFO - 'MAIL': '/var/mail/cltbld', 23:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:52 INFO - 'MOZ_NO_REMOTE': '1', 23:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:52 INFO - 'NO_EM_RESTART': '1', 23:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:52 INFO - 'PWD': '/builds/slave/test', 23:24:52 INFO - 'SHELL': '/bin/bash', 23:24:52 INFO - 'SHLVL': '1', 23:24:52 INFO - 'TERM': 'linux', 23:24:52 INFO - 'TMOUT': '86400', 23:24:52 INFO - 'USER': 'cltbld', 23:24:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:52 INFO - '_': '/tools/buildbot/bin/python'} 23:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:52 INFO - Cleaning up... 23:24:52 INFO - Return code: 0 23:24:52 INFO - Running post-action listener: _resource_record_post_action 23:24:52 INFO - Running post-action listener: _start_resource_monitoring 23:24:52 INFO - Starting resource monitoring. 23:24:52 INFO - [mozharness: 2016-08-04 06:24:52.785764Z] Finished create-virtualenv step (success) 23:24:52 INFO - [mozharness: 2016-08-04 06:24:52.786198Z] Running install step. 23:24:52 INFO - Running pre-action listener: _resource_record_pre_action 23:24:52 INFO - Running main action method: install 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:52 INFO - Reading from file tmpfile_stdout 23:24:52 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:53 INFO - Reading from file tmpfile_stdout 23:24:53 INFO - Output received: 23:24:53 INFO - Usage: mozinstall [options] installer 23:24:53 INFO - Options: 23:24:53 INFO - -h, --help show this help message and exit 23:24:53 INFO - -d DEST, --destination=DEST 23:24:53 INFO - Directory to install application into. [default: 23:24:53 INFO - "/builds/slave/test"] 23:24:53 INFO - --app=APP Application being installed. [default: firefox] 23:24:53 INFO - mkdir: /builds/slave/test/build/application 23:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:25:09 INFO - Reading from file tmpfile_stdout 23:25:09 INFO - Output received: 23:25:09 INFO - /builds/slave/test/build/application/firefox/firefox 23:25:09 INFO - Running post-action listener: _resource_record_post_action 23:25:09 INFO - [mozharness: 2016-08-04 06:25:09.935968Z] Finished install step (success) 23:25:09 INFO - [mozharness: 2016-08-04 06:25:09.936306Z] Running run-tests step. 23:25:09 INFO - Running pre-action listener: _resource_record_pre_action 23:25:09 INFO - Running main action method: run_tests 23:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:25:09 INFO - Python 2.7.3 23:25:09 INFO - Return code: 0 23:25:09 INFO - grabbing minidump binary from tooltool 23:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:25:09 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 0x12d73b0>, '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 0x12d82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:25:09 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 23:25:09 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 23:25:09 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 23:25:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:25:10 INFO - Return code: 0 23:25:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:25:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:25:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:25:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:25:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:25:10 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/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 23:25:10 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/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 23:25:10 INFO - Using env: {'DISPLAY': ':0', 23:25:10 INFO - 'HOME': '/home/cltbld', 23:25:10 INFO - 'LANG': 'en_US.UTF-8', 23:25:10 INFO - 'LANGUAGE': 'en_US:en', 23:25:10 INFO - 'LOGNAME': 'cltbld', 23:25:10 INFO - 'MAIL': '/var/mail/cltbld', 23:25:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:25:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:25:10 INFO - 'MOZ_NO_REMOTE': '1', 23:25:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:25:10 INFO - 'NO_EM_RESTART': '1', 23:25:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:25:10 INFO - 'PWD': '/builds/slave/test', 23:25:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:25:10 INFO - 'SHELL': '/bin/bash', 23:25:10 INFO - 'SHLVL': '1', 23:25:10 INFO - 'TERM': 'linux', 23:25:10 INFO - 'TMOUT': '86400', 23:25:10 INFO - 'USER': 'cltbld', 23:25:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573', 23:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:25:10 INFO - '_': '/tools/buildbot/bin/python'} 23:25:10 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/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 23:25:10 INFO - mozversion application_buildid: 20160803203014 23:25:10 INFO - mozversion application_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 23:25:10 INFO - mozversion application_display_name: Nightly 23:25:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:25:10 INFO - mozversion application_name: Firefox 23:25:10 INFO - mozversion application_remotingname: firefox 23:25:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:25:10 INFO - mozversion application_vendor: Mozilla 23:25:10 INFO - mozversion application_version: 51.0a1 23:25:10 INFO - mozversion platform_buildid: 20160803203014 23:25:10 INFO - mozversion platform_changeset: 03e541a38d87381782c7fccea38aaa32cdd491df 23:25:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:25:10 INFO - mozversion platform_version: 51.0a1 23:25:10 INFO - using testdate: 1470291910 23:25:10 INFO - actual date: 1470291910 23:25:10 INFO - starting webserver on 'localhost:53047' 23:25:10 INFO - SUITE-START | Running 2 tests 23:25:10 INFO - TEST-START | dromaeo_css 23:25:10 INFO - operating with platform_type : linux_ 23:25:10 INFO - Initialising browser for dromaeo_css test... 23:25:10 INFO - TEST-INFO | started process 4685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUsUga/profile http://localhost:53047/getInfo.html) 23:25:15 INFO - PROCESS | 4685 | __metrics Screen width/height:1600/1200 23:25:15 INFO - PROCESS | 4685 | colorDepth:24 23:25:15 INFO - PROCESS | 4685 | Browser inner width/height: 1024/697 23:25:15 INFO - PROCESS | 4685 | __metrics 23:25:16 INFO - PROCESS | 4685 | 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" 23:25:16 INFO - PROCESS | 4685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:25:17 INFO - TEST-INFO | 4685: exit 0 23:25:17 INFO - Browser initialized. 23:25:17 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:17 INFO - TEST-INFO | started process 4764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYUsUga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:28 INFO - PROCESS | 4764 | RSS: Main: 155971584 23:25:28 INFO - PROCESS | 4764 | 23:26:19 INFO - PROCESS | 4764 | 1470291979993 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] 23:28:30 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53047/tests/dromaeo/cssquery-ext.html) 23:28:31 INFO - PROCESS | 4764 | RSS: Main: 275652608 23:28:31 INFO - PROCESS | 4764 | 23:31:33 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-ext.html (next: http://localhost:53047/tests/dromaeo/cssquery-jquery.html) 23:31:34 INFO - PROCESS | 4764 | RSS: Main: 247107584 23:31:34 INFO - PROCESS | 4764 | 23:34:36 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53047/tests/dromaeo/cssquery-mootools.html) 23:34:37 INFO - PROCESS | 4764 | RSS: Main: 184537088 23:34:37 INFO - PROCESS | 4764 | 23:37:39 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53047/tests/dromaeo/cssquery-prototype.html) 23:37:39 INFO - PROCESS | 4764 | RSS: Main: 185393152 23:37:39 INFO - PROCESS | 4764 | 23:40:42 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53047/tests/dromaeo/cssquery-yui.html) 23:40:43 INFO - PROCESS | 4764 | RSS: Main: 184872960 23:40:43 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | Cycle 1(1): loaded http://localhost:53047/tests/dromaeo/cssquery-yui.html (next: http://localhost:53047/tests/dromaeo/cssquery-dojo.html) 23:43:46 INFO - PROCESS | 4764 | RSS: Main: 273244160 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | __start_tp_report 23:43:46 INFO - PROCESS | 4764 | _x_x_mozilla_page_load 23:43:46 INFO - PROCESS | 4764 | _x_x_mozilla_page_load_details 23:43:46 INFO - PROCESS | 4764 | |i|pagename|runs| 23:43:46 INFO - PROCESS | 4764 | |0;dojo.html;2967.376850861319;2970.049584133077;2987.1486626311507;2996.430678171148;3002.414529166812;5035.647504674675;5062.822801201959;5078.263651770496;5124.795008199677;5143.639945203838;5164.354455693038;5241;5305.549028332587;5330.840074797753;5348.491893270133;4686.90626187476;4704.529547045294;4734.384530011093;4747.335373047776;4840.056189043138;4735.5974742146955;4758.904821903559;4771.069641419925;4813.614910807145;4819.638527110464;4621.537846215385;4654.650901182391;4654.860354189363;4673.158831410345;4687.109449204657;4712.198926182523;4712.3167140764735;4712.976435117803;4715.834945776881;4715.976420117911;4670.9766451167525;4677.789499472532;4685.484596694361;4687.742174180418;4697.67116301859;5039.571636410909;5124.590032797404;5124.743762811844;5138.691678499302;5198.454162312978;5522.696251706155;5589.552835773128;5592.384837667853;5595.412481689405;5603.215549823028;5584;5630.211770352154;5631.746571404296;5637.689927054011;5644.294463192101;5100.642954993152;5124.615653825941;5126.282320475062;5161.66449180802;5202.3497062867145;5628.690422026828;5641.097424412074;5648.74580643872;5659.773609055674;5662.886742265132;5325.866853328698;5427.43011983744;5438.265834112423;5443.455654434525;5459.481349271813;5492.533134683516;5529.060059789765;5535.972320138373;5590.468905453975;5615.410381909923;5546.4453554644215;5579.330480342385;5580;5581.6930068845795;5621.775128994795;5339.332583427072;5568.248286481273;5570.637908535932;5583.609147359727;5584.246126772915;4228.090960443519;4279.893002674958;4280.079782846703;4284;4309.612134907873;3844.2119365530557;3847.576766555677;3861.1505468796818;3883.980580097081;3888;5107.87230319245;5222.060029194706;5233.476652334736;5237.6071794615555;5279.049771041173;5474.151506516497;5504.944950550524;5525.11598144295;5579.358373786985;5668.319801623831;5261.579073674096;5266.578673706094;5268;5268.57851371897;5272.314599102169;4648.279516674853;4765.976170119127;4770.236762118045;4772.236442169236;4806.279058141306;5699.487046165865;5726.112452569859;5738.942610573924;5761.769529218785;5811.418858114239;5450.972745136249;5453.64551304164;5454.781808727766;5486.835394938158;5494.890102197854;5621.578381621313;5698.173764803997;5711.400302968294;5712.257406537124;5717.599768016199;5367.704776237344;5442.5645948323245;5456.990456765511;5486.231927530069;5526.585506086979;5497.5601951842955;5530.308711411074;5542.473465020817;5546.389897111395;5562;5248.921266180934;5424.294841670558;5432.402435731988;5440.347158341025;5484.533814625802;5348.304720386325;5370;5399.622026458111;5425.077736784677;5463.289772329572;5375.5162035417;5381.973090134525;5385.111456609616;5390.946090539044;5393;5238.188080847474;5348;5492.945070549244;5499.752511136929;5514.91727624078;5306.54894333986;5318;5326.254324394666;5362.356517217959;5371.5971302153275 23:43:46 INFO - PROCESS | 4764 | |1;ext.html;590.7991282963792;612.2713970375253;614.192337076744;630.9558330916836;632.3202557250956;32527.67472325276;43802.780986095066;44623.107537849224;44780.3282950756;44826.103477930425;41724;45892.08215835681;45894;45907.54092459074;46028;8095.473794203387;8952.328575356858;9090.54547272637;9110.407823491485;10767.892321076768;10977.451127443595;11083.667489975314;11092.944535277313;11101.83347249792;11121.05471034959;11029.779404411907;11080.279781814197;11085.83371249432;11085.944570277177;11087.390193539351;11017.944910275437;11086.279391839505;11094.278871873383;11103.222774405835;11104.55581776728;10800.621978230723;10837.18721095921;10849.457527123612;10863;10894.61868834587;42979.35530967038;43306.56693433057;43327.35008974868;43331.56668433338;43348.566514335085;3625.3836847735947;3752.699784017272;3784.8506294793747;3789.829457674411;4090.795460226977;33275.83362083174;33428.66571334304;34064.148396290046;34136.82931585326;34884;4011.919761604752;4045.939310910339;4162.6253637172495;4183.372494125875;4219.6202341789385;351608;353219;354800;355738;356486;58730.41269587335;58884.7055764727;59161;59433.405665943654;59449;62745.68627156926;62874.37125628685;62909.68545157245;62912.596118272195;62913.37086629167;17081.914590426968;17321.133943302786;17321.91339043322;17327.306907723803;17341.393051243147;13241.867581324255;13291.069625126149;13347.132436391603;13349.932005439541;13356.73286534264;16348.346066157459;18336.266549338143;18524.351647692267;18546.721799173025;18636.906815465834;6145.446909778141;6421.2615549211505;6475;6487.286398496161;6574.638394888231;978.3005151316843;1001.5927621691535;1065.2862582070031;1092.766008128746;1098.4672433869566;31965.680343196735;32489.02532924016;32507.674923250466;32585.837070814494;33156;1019.9133073688671;1144.227646338718;1166.9241499302518;1180.8663682864374;1232.0472051797822;17384.913075434542;18129.274829006692;18473.353432629792;19222.61554768925;19241.4227573173;541489;547443;549021;550451;551953;58589;58696.706516467144;58710.11934820981;58728.70635646794;58787.70606146942;1277.7380636969585;1397.2524699285834;1398.3078376203844;1418.4538952503153;1439.7696368580978;31289.84355078301;33411.164720882174;34080;34096.31807363888;34352;50797;52033.47966520438;52054.73972630112;52056.219156713436;52073.479265206865;513566;518663;518983;519424;519477;44392;45430.54569454395;46208.53791462177;48491.27263090986;50431.49568504268;48873.266900995804;49137;49613;49759;50203.74898125486;37141.62858371382;40942.0109878098;42553.72189260583;42900.78549607232;43072.35391469068;41824.16351673011;42381;42858.134025829706;46347.53652463432;46555;43147.56852431435;43375.78312108419;43903.34144987891;44240.77879610581;44261.557384425745;35487.290254195286;38100.6921966042;38416.61583384242;38504;38618.22763544769;28327.008554700486;28727.712722872504;29873.402531949672;30698.846505767327;30809.8459507701 23:43:46 INFO - PROCESS | 4764 | |2;jquery.html;369.9001269657191;384.75183506638217;389.12835249042155;398.1797497155859;413.9130782535667;14711.264436778158;14737.557873263806;19121.904390478045;20123.798762012375;20218.09018594163;16081.83918160818;16191.595210119753;16195.676086478263;16242.918785406056;18926.242950282005;1657.4861792844197;1659.5270347950836;1659.6514731906254;1659.7178479658487;1866.9159887805013;4188.183304255671;6114.2357205349335;6346.492280617563;6381.202349706286;6471.0940468334475;6207.534434917399;6378.872422551546;6405.967970160166;6410.423061924426;6415.807525774234;6406.807795766134;6468.644224567647;6474.38493343134;6480.416762491375;6482.416582507597;4962.503749625044;5199.220116982483;5225.6603320784025;5289.2859463972645;5686.715664216773;13030.283334416603;13159.671008224776;13199.208047517084;13240.86759132406;13241.470341186341;2323.546908352872;2361.0437772702085;2425.8787060647073;2760.6135141080063;2840.24733445635;9985.65050223246;10851;12551.121421500498;14263.358148883326;15166.090034597959;1861.2554978008905;1899;1942.669746143159;1954.7361106250617;1958.637652034378;73994;77975.61012194959;78441;79299.6035019827;81475;10816.026557609854;10966.38047583181;11354.772904542027;11442.313461192354;11484.59803906876;15575.299111540007;15580.376784928703;15581.376744930076;15588.142652154014;15608.843911560965;7913.485623434458;8138.186181381933;8148.67405303793;8157.67369305233;8227.506349619041;7327.194008659043;7362.116546014512;7678.308952194329;7800.336971357385;8051.2351326623875;4364.738115713004;4444.73331600105;4524.47968483622;4567.2920697291975;4904.239842824368;1884.3310624728024;1904.3239649924078;1947.4060411574605;1990.9303174389117;2022.9393118206478;921.7050543826045;959.4770849886828;992.0625009366224;1051.8579991701022;1068.5512084924194;19941.601167976558;19991.300304489272;20346.491337716674;20418.285360012327;20692.793072069086;977.6627063663025;984.3700031979539;1001.1390204424189;1019.8011387779312;1084.5011294804478;10617.575296988189;11257.380844053656;11351.375674337825;11411.25826821254;11413.885861141449;477285;483707;483755;495322;496259;89461.55269223612;90073;91326;91446.54276728707;93137.534312328;988.081084591337;990.6384169777979;1010.3432768700403;1013.9594416223416;1019.0319196763105;17422.825771742122;17806.19872105784;18068.186931587847;18230.544236394195;18441.170147343135;39992.4001139989;40134.19731605293;40402.191956160124;41248.38127428151;41742.582574173866;55912;56389.180540973604;56708.71645641745;57514.7124264376;57606.13590796225;7972.960135199519;8217.465864719014;8263;8441.32469402434;9011.954940225258;12354.567590134302;12750.298733569743;13075.411606477921;13189.604311870658;13517;10867.510962006887;11698.94150529242;11708.356040417859;11760.647180584596;12317.260964342167;11263.380514071805;11311.490982905625;11347.829782553103;11499.94250028778;11616.186866919235;11405.201635885409;11682.357470339213;11828.23116497425;12068.818967715666;12394.442250098587;7561.546307221364;7707.34487568563;8270.917290827256;8471.576421178794;8588.699395521127;11393.772124557629;12016.939915300367;12103.636890893287;12160.331181784733;12308.81536776967 23:43:46 INFO - PROCESS | 4764 | |3;mootools.html;1371.7050834070674;1482.770170623553;1546.404634215827;1677.4548271811657;1819.6542656895197;8511.616977236024;8906.86639700405;8936.865947010792;9102.81794364114;9114.088591140882;8940.374173807835;9038.231750301216;9051.72844814655;9052;9063.27493800496;2374.430136767172;2398.5442765874513;2401.855888646678;2403.2189538400003;2404.8677322747244;2350.247920665388;2388.8088952883727;2395.3412811476896;2395.4969456414174;2396.5686176488225;2343.1798870395396;2366.7692799744123;2367.550165468564;2371.739108698042;2380.33350661815;2267.0818318581;2281.4638559938485;2292.1289909834322;2295.6671282664006;2330.906763729449;2281.0989659084735;2285.565742508918;2288.39357570244;2292.6904867842964;2293.9885300573555;8987.056359082333;9047.547622618842;9067.501287429188;9088.363814532986;9115.81768364629;5095.719735414551;5273.077211487975;5273.630845840793;5290.338707661543;5299;3314.0886256279473;3319.3859136059905;3357.2110554019787;3368.292658541709;3373.308471763283;1161.0827446317398;1175.4122938530734;1194.1700518139896;1208.7582483503247;1224.5897624295872;12257.203281786655;12301.93849030758;12324.75350492994;12328.383580820922;12345.629631111082;4140.91718165635;4276.166147601188;4371.191329604034;4425.734455932655;4429;9736.123748862636;9760.023997600183;9761.365511241747;9774.609015639437;9777;4964.67729597575;4974.054929563371;4975.701457912537;4975.850724478271;4977.552020318189;4262.722923009995;4675.4155730533685;4686.835960741358;4824.662273640812;4866.805327786919;3559.0924314299687;3663.157473781045;3695.6489133532273;3733.8879833605033;3758.2671379080816;1147.2485521983115;1153.4982282707049;1161.4599211366756;1161.9128565357632;1169.2925779903037;937.0910217089412;994.3288280410694;1011.3375738891039;1016.4714348538719;1034.3121823986965;6218.440340369389;6255.40573645503;6274.560780745395;6451.1936007999;6557.9344206557325;454.8658145846983;457.78941686823765;464.0857510703908;471.50491983417277;473.9928901066487;4209.284421648327;4226.957730422657;4244.745315281031;4275.87172384829;4362.694611377173;11238.38188899602;11357.148213883991;11420.94289528547;11547.711307217387;11598.594049208237;11450.770984580427;11520.423978801027;11531.538738450536;11538.711532211593;11546.422678866023;8360.372972027;8537.957310213533;8605.870911936327;8616.095309992486;8618.482891026559;5960.105984102419;5985.850353741192;6082.817515474543;6136.2636483622255;6260.561760676709;10344.741381465223;10601.787964240826;10616.1507079435;10626.893731062899;10684.465776710978;10869.945650271698;10918.18113641496;10929.071028962628;10944.78110437771;10949.890501095206;6947.40947019509;7226.530275532074;7353;7677.270659287359;7758.534487930742;8615;8757.562121893752;8764.956175219084;8765.780855478664;8783.165599268059;7604.505707129019;7658.3838914987255;7719.3052625264;7943.920560794318;7947.125816160334;7538.924610753822;7639.312461878458;7680.308772210527;7725.381969442319;7745.961270193839;7131.714731410685;7197.784066478014;7208.639568021683;7229.024081748897;7229.132504099542;5078.314427552233;5125.5899528036925;5191.636585439134;5206.635535512478;5449.591280654046;5082.567981721595;5119.206522988943;5131.230315452712;5202.531772140374;5272.947270527399 23:43:46 INFO - PROCESS | 4764 | |4;prototype.html;308.4725120044723;315.25914101860633;317.3731879537913;324.654243230959;325.6352884769059;5160.277561141444;5205.219217117425;5208.4531124231935;5216.5565926896215;5225.8693532661655;5112.258722485238;5115.846524604259;5138.820141295056;5148.253503242027;5157.845264642057;3856.2287542491545;3880.9223815523674;3951.209758048402;3962.3065963456424;3998.960010399888;3983.6215559521943;3985.9601403986026;3987.9601203987877;3990.521137463494;3991.2017596480673;3950.3606003508507;3959;3974.403839424095;3981.8850721797944;3982.7610343379347;3847.269018886431;3862.7875466849314;3984.442178095069;3996.360582306846;4017.7790221537803;3547.450145227494;3550.840212190458;3558.3417067842533;3559.804210768407;3567.661072198137;5036.093503169428;5037.370328708911;5046.419661738911;5056.974715126437;5069.417017043051;4392.780360981938;4539.954600453986;4567.1550763108935;4573.131105090022;4589.47221069578;5310.256564081032;5310.6813591184655;5316.255724198615;5332.786688532454;5352.090144675414;3880.5149356330458;3895.3183192941406;3898.9530496489288;3899.083715326896;3900.590438003997;5346.866328341784;5524.58565607581;5539.335279766414;5548.611597188198;5583.4137415571595;3912.295786758354;3925;3927.4501569780255;3931.2923673739;3939.6454319111417;3982.203559288154;3985.8206380712936;3991.3214753491975;3994.380870965005;3996.0609256824623;4450.866474005785;4530.614897733663;4560.1335746208115;4565.447747765776;4569.977150114228;5405;5411.404745477994;5421.322334708161;5430.185472179205;5432.91850622241;1331.2345401394043;1338.9732205355838;1340.1088276296155;1346.8181795457683;1347.413874964374;814.9225823546753;873.3624454148508;873.554487211514;881.8633111867671;882.6513527156866;5086.3896332440345;5178.585713142939;5220.7128607926925;5290.391604965478;5318.840434786963;5546.7781288748;5555.583331250173;5561.860953476195;5585.776568937197;5590.86022849432;5106.846794596168;5326.227696983916;5327.680339179662;5328.227407025959;5331.653442526223;2903.840288784095;2940.7942743475073;2944.366961103373;2955.989926849763;2956.684275497383;5810.709464526757;5826.184334193216;5830;5834.183214349994;5838.12428135783;5421.972890135524;5680.346760122557;5682.772689092472;5722.084466485342;5740.598158128891;5767.538596912321;5836.941630583725;5844.26946631671;5867.154430101397;5880.735366908414;5454.9271276914515;5551.666899986014;5591.356993945748;5592.3848376677715;5592.944070559405;5491.945080549143;5496.203050557567;5504.990678402274;5515.834524964257;5515.862103447446;5819.709014549171;5831.82504524848;5842.970785146217;5849.011336145731;5853.595137166964;3711.4432835073876;3876.7092468064443;3905.2775236581324;3952.26883026641;3977.463042489227;5520.834374968757;5523.7790488380015;5545;5551.861203469784;5557;5404.648697834628;5406.702631355313;5411.431799660979;5416.702081385404;5449.509544141047;5154.917467331902;5350.411454740053;5382.757775900172;5451.64564303319;5454.400015998316;5376.30108085962;5388.892222155613;5392.838214853561;5393.460653934575;5396.059147764399;5217.817131549676;5297.735113244245;5436.592255580768;5454.290942177491;5498.945010549844;5299.125644268806;5300.045991721528;5325.414204437587;5331.386890507486;5336.839894803162 23:43:46 INFO - PROCESS | 4764 | |5;yui.html;736.4550232827709;761.9085709714835;769.449843361996;769.4806005945989;804.6459557794568;16604.501864944057;17543.12284385782;17549.21028553715;17550.561235969108;17576;15708.450204242854;15856.207189640501;15888.205589720526;15889.046657200575;15889.52331430056;665.0987911380083;791.8574656561846;800.503687713617;821.6302663801283;826.7850358906668;822.6709316273509;822.8889099971517;825.0305890578576;825.2655136928139;825.451075035101;864.5547543015352;870.6299822575412;871.2768402226169;871.8299931513358;871.860502319629;692.3457332820461;709.2092317066459;712.6045045000022;824.2169938558394;862.7886167888876;627.109504503606;630.2562975688686;630.3255516597243;630.9652969086699;631.7536160897254;15894.205289735582;15914.204289785464;15925.362985480568;15974.76037859433;15988.360465581363;14965.551033469013;15006.62483437912;15095.32071056805;15155.104427485468;15226.086434813946;13904.165750055028;14028.298585070808;14124.364403601863;14239.64400889986;14240.572782816533;4407.559244075599;4412.152054746869;4455.933161002587;4504.8873778155485;4594.19601569724;67975.66012169956;79316;79680;79688.60155699242;81076.59461702712;11600.76798464026;12098.395080245953;12239.082068844873;12293.999999999822;12370.690732731753;21698.132074716836;21721.891390542947;21737.13051477923;21738.456538586346;21742.565148697253;8269.545175015432;8422.536760478233;8651.134886511425;8686.652533898574;8868.955655221811;4608.516105808909;4723.173444647173;4787.4494433140635;4884.169691152512;4914.557689807934;3553.893383198508;3695.667389934919;3699.2786406650443;3700.648438398348;3708.942951258932;656.9671516424255;658.8418779492984;660.9966950165218;669.608279156689;677.7289084366195;616.6097386607385;646.440828683195;690.2407351912856;732.1945859554447;734.2400615363074;9680;10178.796424071625;10416.218783591261;10470.790584188273;10630.30902991303;609.0620444515397;657.4641667041346;747.8766003609344;749.9025126733599;780.0872978615034;4832.516748325139;5210.244514545369;5211.609129315317;5247.370315562081;5260.947390526122;124567;127561;128873.35563322123;129539.35230323789;132421.33789330992;101818;106863;108383.45808270908;112292;112795;57170;75272.62363688256;96802;98102.5094874521;100171.49914250527;9559.569819358006;9571.521423928914;9585.233181345615;9615.5672994714;9683.612655493702;54846.72576637091;55428;55560.72219638876;56191.71904140453;56844.73664475264;78142;79968;82971;84405.57797210975;85334.02661813614;11484.425778711198;11975.940120299343;12328.568500102454;12438.689032774253;12781.87218127844;13990.16059036461;14047.929760351133;14254.928725356307;14363.56909292723;14479.506927587381;12136.783568478864;12684.048696347627;12799.936000319938;12896.613101606967;12926.289054102115;12596.181248218836;12609.558665446666;12640.367981601066;12732.363381830686;13216.603501894959;12885.117753803786;13062.80405793933;13145.408456619283;13149.53976610814;13583.52457663977;10240.846387304346;10265.332753371007;10385.896141038493;10426.270161088954;10517.684469465928;10056.698299050748;11498.597549085742;11583.594574189863;12028.879711202775;12182.756344872876 23:43:46 INFO - PROCESS | 4764 | __end_tp_report 23:43:46 INFO - PROCESS | 4764 | __start_cc_report 23:43:46 INFO - PROCESS | 4764 | _x_x_mozilla_cycle_collect,1072 23:43:46 INFO - PROCESS | 4764 | __end_cc_report 23:43:46 INFO - PROCESS | 4764 | __startTimestamp1470293026284__endTimestamp 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | ------- Summary: start ------- 23:43:46 INFO - PROCESS | 4764 | Number of tests: 6 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#0] dojo.html Cycles:165 Average:5148.83 Median:5348.30 stddev:578.90 (10.8%) stddev-sans-first:554.80 23:43:46 INFO - PROCESS | 4764 | Values: 2967.4 2970.0 2987.1 2996.4 3002.4 5035.6 5062.8 5078.3 5124.8 5143.6 5164.4 5241.0 5305.5 5330.8 5348.5 4686.9 4704.5 4734.4 4747.3 4840.1 4735.6 4758.9 4771.1 4813.6 4819.6 4621.5 4654.7 4654.9 4673.2 4687.1 4712.2 4712.3 4713.0 4715.8 4716.0 4671.0 4677.8 4685.5 4687.7 4697.7 5039.6 5124.6 5124.7 5138.7 5198.5 5522.7 5589.6 5592.4 5595.4 5603.2 5584.0 5630.2 5631.7 5637.7 5644.3 5100.6 5124.6 5126.3 5161.7 5202.3 5628.7 5641.1 5648.7 5659.8 5662.9 5325.9 5427.4 5438.3 5443.5 5459.5 5492.5 5529.1 5536.0 5590.5 5615.4 5546.4 5579.3 5580.0 5581.7 5621.8 5339.3 5568.2 5570.6 5583.6 5584.2 4228.1 4279.9 4280.1 4284.0 4309.6 3844.2 3847.6 3861.2 3884.0 3888.0 5107.9 5222.1 5233.5 5237.6 5279.0 5474.2 5504.9 5525.1 5579.4 5668.3 5261.6 5266.6 5268.0 5268.6 5272.3 4648.3 4766.0 4770.2 4772.2 4806.3 5699.5 5726.1 5738.9 5761.8 5811.4 5451.0 5453.6 5454.8 5486.8 5494.9 5621.6 5698.2 5711.4 5712.3 5717.6 5367.7 5442.6 5457.0 5486.2 5526.6 5497.6 5530.3 5542.5 5546.4 5562.0 5248.9 5424.3 5432.4 5440.3 5484.5 5348.3 5370.0 5399.6 5425.1 5463.3 5375.5 5382.0 5385.1 5390.9 5393.0 5238.2 5348.0 5492.9 5499.8 5514.9 5306.5 5318.0 5326.3 5362.4 5371.6 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#1] ext.html Cycles:180 Average:64319.42 Median:21315.07 stddev:127541.93 (598.4%) stddev-sans-first:127809.96 23:43:46 INFO - PROCESS | 4764 | Values: 590.8 612.3 614.2 631.0 632.3 32527.7 43802.8 44623.1 44780.3 44826.1 41724.0 45892.1 45894.0 45907.5 46028.0 8095.5 8952.3 9090.5 9110.4 10767.9 10977.5 11083.7 11092.9 11101.8 11121.1 11029.8 11080.3 11085.8 11085.9 11087.4 11017.9 11086.3 11094.3 11103.2 11104.6 10800.6 10837.2 10849.5 10863.0 10894.6 42979.4 43306.6 43327.4 43331.6 43348.6 3625.4 3752.7 3784.9 3789.8 4090.8 33275.8 33428.7 34064.1 34136.8 34884.0 4011.9 4045.9 4162.6 4183.4 4219.6 351608.0 353219.0 354800.0 355738.0 356486.0 58730.4 58884.7 59161.0 59433.4 59449.0 62745.7 62874.4 62909.7 62912.6 62913.4 17081.9 17321.1 17321.9 17327.3 17341.4 13241.9 13291.1 13347.1 13349.9 13356.7 16348.3 18336.3 18524.4 18546.7 18636.9 6145.4 6421.3 6475.0 6487.3 6574.6 978.3 1001.6 1065.3 1092.8 1098.5 31965.7 32489.0 32507.7 32585.8 33156.0 1019.9 1144.2 1166.9 1180.9 1232.0 17384.9 18129.3 18473.4 19222.6 19241.4 541489.0 547443.0 549021.0 550451.0 551953.0 58589.0 58696.7 58710.1 58728.7 58787.7 1277.7 1397.3 1398.3 1418.5 1439.8 31289.8 33411.2 34080.0 34096.3 34352.0 50797.0 52033.5 52054.7 52056.2 52073.5 513566.0 518663.0 518983.0 519424.0 519477.0 44392.0 45430.5 46208.5 48491.3 50431.5 48873.3 49137.0 49613.0 49759.0 50203.7 37141.6 40942.0 42553.7 42900.8 43072.4 41824.2 42381.0 42858.1 46347.5 46555.0 43147.6 43375.8 43903.3 44240.8 44261.6 35487.3 38100.7 38416.6 38504.0 38618.2 28327.0 28727.7 29873.4 30698.8 30809.8 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#2] jquery.html Cycles:180 Average:28414.62 Median:20555.54 stddev:80338.82 (390.8%) stddev-sans-first:80536.59 23:43:46 INFO - PROCESS | 4764 | Values: 369.9 384.8 389.1 398.2 413.9 14711.3 14737.6 19121.9 20123.8 20218.1 16081.8 16191.6 16195.7 16242.9 18926.2 1657.5 1659.5 1659.7 1659.7 1866.9 4188.2 6114.2 6346.5 6381.2 6471.1 6207.5 6378.9 6406.0 6410.4 6415.8 6406.8 6468.6 6474.4 6480.4 6482.4 4962.5 5199.2 5225.7 5289.3 5686.7 13030.3 13159.7 13199.2 13240.9 13241.5 2323.5 2361.0 2425.9 2760.6 2840.2 9985.7 10851.0 12551.1 14263.4 15166.1 1861.3 1899.0 1942.7 1954.7 1958.6 73994.0 77975.6 78441.0 79299.6 81475.0 10816.0 10966.4 11354.8 11442.3 11484.6 15575.3 15580.4 15581.4 15588.1 15608.8 7913.5 8138.2 8148.7 8157.7 8227.5 7327.2 7362.1 7678.3 7800.3 8051.2 4364.7 4444.7 4524.5 4567.3 4904.2 1884.3 1904.3 1947.4 1990.9 2022.9 921.7 959.5 992.1 1051.9 1068.6 19941.6 19991.3 20346.5 20418.3 20692.8 977.7 984.4 1001.1 1019.8 1084.5 10617.6 11257.4 11351.4 11411.3 11413.9 477285.0 483707.0 483755.0 495322.0 496259.0 89461.6 90073.0 91326.0 91446.5 93137.5 988.1 990.6 1010.3 1014.0 1019.0 17422.8 17806.2 18068.2 18230.5 18441.2 39992.4 40134.2 40402.2 41248.4 41742.6 55912.0 56389.2 56708.7 57514.7 57606.1 7973.0 8217.5 8263.0 8441.3 9012.0 12354.6 12750.3 13075.4 13189.6 13517.0 10867.5 11698.9 11708.4 11760.6 12317.3 11263.4 11311.5 11347.8 11499.9 11616.2 11405.2 11682.4 11828.2 12068.8 12394.4 7561.5 7707.3 8270.9 8471.6 8588.7 11393.8 12016.9 12103.6 12160.3 12308.8 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#3] mootools.html Cycles:180 Average:5868.88 Median:460.94 stddev:3428.34 (743.8%) stddev-sans-first:3421.30 23:43:46 INFO - PROCESS | 4764 | Values: 1371.7 1482.8 1546.4 1677.5 1819.7 8511.6 8906.9 8936.9 9102.8 9114.1 8940.4 9038.2 9051.7 9052.0 9063.3 2374.4 2398.5 2401.9 2403.2 2404.9 2350.2 2388.8 2395.3 2395.5 2396.6 2343.2 2366.8 2367.6 2371.7 2380.3 2267.1 2281.5 2292.1 2295.7 2330.9 2281.1 2285.6 2288.4 2292.7 2294.0 8987.1 9047.5 9067.5 9088.4 9115.8 5095.7 5273.1 5273.6 5290.3 5299.0 3314.1 3319.4 3357.2 3368.3 3373.3 1161.1 1175.4 1194.2 1208.8 1224.6 12257.2 12301.9 12324.8 12328.4 12345.6 4140.9 4276.2 4371.2 4425.7 4429.0 9736.1 9760.0 9761.4 9774.6 9777.0 4964.7 4974.1 4975.7 4975.9 4977.6 4262.7 4675.4 4686.8 4824.7 4866.8 3559.1 3663.2 3695.6 3733.9 3758.3 1147.2 1153.5 1161.5 1161.9 1169.3 937.1 994.3 1011.3 1016.5 1034.3 6218.4 6255.4 6274.6 6451.2 6557.9 454.9 457.8 464.1 471.5 474.0 4209.3 4227.0 4244.7 4275.9 4362.7 11238.4 11357.1 11420.9 11547.7 11598.6 11450.8 11520.4 11531.5 11538.7 11546.4 8360.4 8538.0 8605.9 8616.1 8618.5 5960.1 5985.9 6082.8 6136.3 6260.6 10344.7 10601.8 10616.2 10626.9 10684.5 10869.9 10918.2 10929.1 10944.8 10949.9 6947.4 7226.5 7353.0 7677.3 7758.5 8615.0 8757.6 8765.0 8765.8 8783.2 7604.5 7658.4 7719.3 7943.9 7947.1 7538.9 7639.3 7680.3 7725.4 7746.0 7131.7 7197.8 7208.6 7229.0 7229.1 5078.3 5125.6 5191.6 5206.6 5449.6 5082.6 5119.2 5131.2 5202.5 5272.9 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#4] prototype.html Cycles:180 Average:4554.17 Median:5258.13 stddev:1359.98 (25.9%) stddev-sans-first:1325.93 23:43:46 INFO - PROCESS | 4764 | Values: 308.5 315.3 317.4 324.7 325.6 5160.3 5205.2 5208.5 5216.6 5225.9 5112.3 5115.8 5138.8 5148.3 5157.8 3856.2 3880.9 3951.2 3962.3 3999.0 3983.6 3986.0 3988.0 3990.5 3991.2 3950.4 3959.0 3974.4 3981.9 3982.8 3847.3 3862.8 3984.4 3996.4 4017.8 3547.5 3550.8 3558.3 3559.8 3567.7 5036.1 5037.4 5046.4 5057.0 5069.4 4392.8 4540.0 4567.2 4573.1 4589.5 5310.3 5310.7 5316.3 5332.8 5352.1 3880.5 3895.3 3899.0 3899.1 3900.6 5346.9 5524.6 5539.3 5548.6 5583.4 3912.3 3925.0 3927.5 3931.3 3939.6 3982.2 3985.8 3991.3 3994.4 3996.1 4450.9 4530.6 4560.1 4565.4 4570.0 5405.0 5411.4 5421.3 5430.2 5432.9 1331.2 1339.0 1340.1 1346.8 1347.4 814.9 873.4 873.6 881.9 882.7 5086.4 5178.6 5220.7 5290.4 5318.8 5546.8 5555.6 5561.9 5585.8 5590.9 5106.8 5326.2 5327.7 5328.2 5331.7 2903.8 2940.8 2944.4 2956.0 2956.7 5810.7 5826.2 5830.0 5834.2 5838.1 5422.0 5680.3 5682.8 5722.1 5740.6 5767.5 5836.9 5844.3 5867.2 5880.7 5454.9 5551.7 5591.4 5592.4 5592.9 5491.9 5496.2 5505.0 5515.8 5515.9 5819.7 5831.8 5843.0 5849.0 5853.6 3711.4 3876.7 3905.3 3952.3 3977.5 5520.8 5523.8 5545.0 5551.9 5557.0 5404.6 5406.7 5411.4 5416.7 5449.5 5154.9 5350.4 5382.8 5451.6 5454.4 5376.3 5388.9 5392.8 5393.5 5396.1 5217.8 5297.7 5436.6 5454.3 5498.9 5299.1 5300.0 5325.4 5331.4 5336.8 23:43:46 INFO - PROCESS | 4764 | 23:43:46 INFO - PROCESS | 4764 | [#5] yui.html Cycles:180 Average:21953.34 Median:4409.86 stddev:32479.21 (736.5%) stddev-sans-first:32531.25 23:43:46 INFO - PROCESS | 4764 | Values: 736.5 761.9 769.4 769.5 804.6 16604.5 17543.1 17549.2 17550.6 17576.0 15708.5 15856.2 15888.2 15889.0 15889.5 665.1 791.9 800.5 821.6 826.8 822.7 822.9 825.0 825.3 825.5 864.6 870.6 871.3 871.8 871.9 692.3 709.2 712.6 824.2 862.8 627.1 630.3 630.3 631.0 631.8 15894.2 15914.2 15925.4 15974.8 15988.4 14965.6 15006.6 15095.3 15155.1 15226.1 13904.2 14028.3 14124.4 14239.6 14240.6 4407.6 4412.2 4455.9 4504.9 4594.2 67975.7 79316.0 79680.0 79688.6 81076.6 11600.8 12098.4 12239.1 12294.0 12370.7 21698.1 21721.9 21737.1 21738.5 21742.6 8269.5 8422.5 8651.1 8686.7 8869.0 4608.5 4723.2 4787.4 4884.2 4914.6 3553.9 3695.7 3699.3 3700.6 3708.9 657.0 658.8 661.0 669.6 677.7 616.6 646.4 690.2 732.2 734.2 9680.0 10178.8 10416.2 10470.8 10630.3 609.1 657.5 747.9 749.9 780.1 4832.5 5210.2 5211.6 5247.4 5260.9 124567.0 127561.0 128873.4 129539.4 132421.3 101818.0 106863.0 108383.5 112292.0 112795.0 57170.0 75272.6 96802.0 98102.5 100171.5 9559.6 9571.5 9585.2 9615.6 9683.6 54846.7 55428.0 55560.7 56191.7 56844.7 78142.0 79968.0 82971.0 84405.6 85334.0 11484.4 11975.9 12328.6 12438.7 12781.9 13990.2 14047.9 14254.9 14363.6 14479.5 12136.8 12684.0 12799.9 12896.6 12926.3 12596.2 12609.6 12640.4 12732.4 13216.6 12885.1 13062.8 13145.4 13149.5 13583.5 10240.8 10265.3 10385.9 10426.3 10517.7 10056.7 11498.6 11583.6 12028.9 12182.8 23:43:46 INFO - PROCESS | 4764 | -------- Summary: end -------- 23:43:46 INFO - PROCESS | 4764 | 23:43:47 INFO - TEST-INFO | 4764: exit 0 23:43:47 INFO - TEST-OK | dromaeo_css | took 1116885ms 23:43:47 INFO - TEST-START | kraken 23:43:47 INFO - operating with platform_type : linux_ 23:43:47 INFO - Initialising browser for kraken test... 23:43:47 INFO - TEST-INFO | started process 4950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbYhPqT/profile http://localhost:53047/getInfo.html) 23:43:51 INFO - PROCESS | 4950 | __metrics Screen width/height:1600/1200 23:43:51 INFO - PROCESS | 4950 | colorDepth:24 23:43:51 INFO - PROCESS | 4950 | Browser inner width/height: 1024/697 23:43:51 INFO - PROCESS | 4950 | __metrics 23:43:52 INFO - PROCESS | 4950 | 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" 23:43:52 INFO - PROCESS | 4950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:43:53 INFO - PROCESS | 4950 | console.error: PushService: 23:43:53 INFO - PROCESS | 4950 | stateChangeProcessEnqueue: Error transitioning state 23:43:53 INFO - PROCESS | 4950 | UnknownError 23:43:53 INFO - TEST-INFO | 4950: exit 0 23:43:53 INFO - Browser initialized. 23:43:53 INFO - Running cycle 1/1 for kraken test... 23:43:53 INFO - TEST-INFO | started process 5030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbYhPqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:44:05 INFO - PROCESS | 5030 | RSS: Main: 156184576 23:44:05 INFO - PROCESS | 5030 | 23:44:07 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-beat-detection) 23:44:08 INFO - PROCESS | 5030 | RSS: Main: 213483520 23:44:08 INFO - PROCESS | 5030 | 23:44:11 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-dft) 23:44:11 INFO - PROCESS | 5030 | RSS: Main: 190636032 23:44:11 INFO - PROCESS | 5030 | 23:44:15 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-fft) 23:44:15 INFO - PROCESS | 5030 | RSS: Main: 269991936 23:44:15 INFO - PROCESS | 5030 | 23:44:17 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53047/tests/kraken/driver.html?testName=audio-oscillator) 23:44:18 INFO - PROCESS | 5030 | RSS: Main: 179589120 23:44:18 INFO - PROCESS | 5030 | 23:44:20 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:21 INFO - PROCESS | 5030 | RSS: Main: 184406016 23:44:21 INFO - PROCESS | 5030 | 23:44:24 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:24 INFO - PROCESS | 5030 | RSS: Main: 220704768 23:44:24 INFO - PROCESS | 5030 | 23:44:28 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53047/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:28 INFO - PROCESS | 5030 | RSS: Main: 219713536 23:44:28 INFO - PROCESS | 5030 | 23:44:31 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53047/tests/kraken/driver.html?testName=json-parse-financial) 23:44:32 INFO - PROCESS | 5030 | RSS: Main: 220278784 23:44:32 INFO - PROCESS | 5030 | 23:44:33 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:34 INFO - PROCESS | 5030 | RSS: Main: 183939072 23:44:34 INFO - PROCESS | 5030 | 23:44:35 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:36 INFO - PROCESS | 5030 | RSS: Main: 189353984 23:44:36 INFO - PROCESS | 5030 | 23:44:38 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:39 INFO - PROCESS | 5030 | RSS: Main: 194445312 23:44:39 INFO - PROCESS | 5030 | 23:44:41 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:42 INFO - PROCESS | 5030 | RSS: Main: 189489152 23:44:42 INFO - PROCESS | 5030 | 23:44:45 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:45 INFO - PROCESS | 5030 | RSS: Main: 192126976 23:44:45 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | Cycle 1(1): loaded http://localhost:53047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53047/tests/kraken/driver.html?testName=ai-astar) 23:44:47 INFO - PROCESS | 5030 | RSS: Main: 243478528 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | __start_tp_report 23:44:47 INFO - PROCESS | 5030 | _x_x_mozilla_page_load 23:44:47 INFO - PROCESS | 5030 | _x_x_mozilla_page_load_details 23:44:47 INFO - PROCESS | 5030 | |i|pagename|runs| 23:44:47 INFO - PROCESS | 5030 | |0;ai-astar;104;110;110;110;111;111;110;112;110;111 23:44:47 INFO - PROCESS | 5030 | |1;audio-beat-detection;147;122;119;191;119;118;142;118;153;117 23:44:47 INFO - PROCESS | 5030 | |2;audio-dft;161;161;159;163;160;161;160;161;160;162 23:44:47 INFO - PROCESS | 5030 | |3;audio-fft;74;75;75;124;75;77;75;75;108;75 23:44:47 INFO - PROCESS | 5030 | |4;audio-oscillator;84;84;109;85;84;84;121;85;84;132 23:44:47 INFO - PROCESS | 5030 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;116 23:44:47 INFO - PROCESS | 5030 | |6;imaging-darkroom;150;149;149;149;149;148;148;149;148;146 23:44:47 INFO - PROCESS | 5030 | |7;imaging-desaturate;95;95;94;95;95;95;95;94;95;95 23:44:47 INFO - PROCESS | 5030 | |8;json-parse-financial;51;53;49;50;49;51;49;48;50;49 23:44:47 INFO - PROCESS | 5030 | |9;json-stringify-tinderbox;59;58;59;59;59;58;60;59;59;60 23:44:47 INFO - PROCESS | 5030 | |10;stanford-crypto-aes;85;78;75;76;86;77;77;75;75;75 23:44:47 INFO - PROCESS | 5030 | |11;stanford-crypto-ccm;123;123;129;120;120;118;121;122;167;124 23:44:47 INFO - PROCESS | 5030 | |12;stanford-crypto-pbkdf2;159;159;159;162;162;161;162;159;161;160 23:44:47 INFO - PROCESS | 5030 | |13;stanford-crypto-sha256-iterative;63;64;64;64;63;64;63;63;62;65 23:44:47 INFO - PROCESS | 5030 | __end_tp_report 23:44:47 INFO - PROCESS | 5030 | __start_cc_report 23:44:47 INFO - PROCESS | 5030 | _x_x_mozilla_cycle_collect,1637 23:44:47 INFO - PROCESS | 5030 | __end_cc_report 23:44:47 INFO - PROCESS | 5030 | __startTimestamp1470293087524__endTimestamp 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | ------- Summary: start ------- 23:44:47 INFO - PROCESS | 5030 | Number of tests: 14 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.18 (2.0%) stddev-sans-first:0.73 23:44:47 INFO - PROCESS | 5030 | Values: 104.0 110.0 110.0 110.0 111.0 111.0 110.0 112.0 110.0 111.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:132.00 stddev:24.12 (18.3%) stddev-sans-first:25.16 23:44:47 INFO - PROCESS | 5030 | Values: 147.0 122.0 119.0 191.0 119.0 118.0 142.0 118.0 153.0 117.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 23:44:47 INFO - PROCESS | 5030 | Values: 161.0 161.0 159.0 163.0 160.0 161.0 160.0 161.0 160.0 162.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:17.66 (23.5%) stddev-sans-first:18.41 23:44:47 INFO - PROCESS | 5030 | Values: 74.0 75.0 75.0 124.0 75.0 77.0 75.0 75.0 108.0 75.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:84.00 stddev:18.40 (21.9%) stddev-sans-first:19.06 23:44:47 INFO - PROCESS | 5030 | Values: 84.0 84.0 109.0 85.0 84.0 84.0 121.0 85.0 84.0 132.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 23:44:47 INFO - PROCESS | 5030 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 23:44:47 INFO - PROCESS | 5030 | Values: 150.0 149.0 149.0 149.0 149.0 148.0 148.0 149.0 148.0 146.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:44:47 INFO - PROCESS | 5030 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:1.45 (2.9%) stddev-sans-first:1.48 23:44:47 INFO - PROCESS | 5030 | Values: 51.0 53.0 49.0 50.0 49.0 51.0 49.0 48.0 50.0 49.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 23:44:47 INFO - PROCESS | 5030 | Values: 59.0 58.0 59.0 59.0 59.0 58.0 60.0 59.0 59.0 60.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:4.15 (5.4%) stddev-sans-first:3.52 23:44:47 INFO - PROCESS | 5030 | Values: 85.0 78.0 75.0 76.0 86.0 77.0 77.0 75.0 75.0 75.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:123.00 stddev:14.47 (11.8%) stddev-sans-first:15.28 23:44:47 INFO - PROCESS | 5030 | Values: 123.0 123.0 129.0 120.0 120.0 118.0 121.0 122.0 167.0 124.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.33 23:44:47 INFO - PROCESS | 5030 | Values: 159.0 159.0 159.0 162.0 162.0 161.0 162.0 159.0 161.0 160.0 23:44:47 INFO - PROCESS | 5030 | 23:44:47 INFO - PROCESS | 5030 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 23:44:47 INFO - PROCESS | 5030 | Values: 63.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 62.0 65.0 23:44:47 INFO - PROCESS | 5030 | -------- Summary: end -------- 23:44:47 INFO - PROCESS | 5030 | 23:44:48 INFO - TEST-INFO | 5030: exit 0 23:44:48 INFO - TEST-OK | kraken | took 61522ms 23:44:48 INFO - SUITE-END | took 1178s 23:44:48 INFO - Completed test suite (00:19:38) 23:44:48 INFO - javascript benchmark 23:44:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2967.376850861319, 2970.049584133077, 2987.1486626311507, 2996.430678171148, 3002.414529166812, 5035.647504674675, 5062.822801201959, 5078.263651770496, 5124.795008199677, 5143.639945203838, 5164.354455693038, 5241.0, 5305.549028332587, 5330.840074797753, 5348.491893270133, 4686.90626187476, 4704.529547045294, 4734.384530011093, 4747.335373047776, 4840.056189043138, 4735.5974742146955, 4758.904821903559, 4771.069641419925, 4813.614910807145, 4819.638527110464, 4621.537846215385, 4654.650901182391, 4654.860354189363, 4673.158831410345, 4687.109449204657, 4712.198926182523, 4712.3167140764735, 4712.976435117803, 4715.834945776881, 4715.976420117911, 4670.9766451167525, 4677.789499472532, 4685.484596694361, 4687.742174180418, 4697.67116301859, 5039.571636410909, 5124.590032797404, 5124.743762811844, 5138.691678499302, 5198.454162312978, 5522.696251706155, 5589.552835773128, 5592.384837667853, 5595.412481689405, 5603.215549823028, 5584.0, 5630.211770352154, 5631.746571404296, 5637.689927054011, 5644.294463192101, 5100.642954993152, 5124.615653825941, 5126.282320475062, 5161.66449180802, 5202.3497062867145, 5628.690422026828, 5641.097424412074, 5648.74580643872, 5659.773609055674, 5662.886742265132, 5325.866853328698, 5427.43011983744, 5438.265834112423, 5443.455654434525, 5459.481349271813, 5492.533134683516, 5529.060059789765, 5535.972320138373, 5590.468905453975, 5615.410381909923, 5546.4453554644215, 5579.330480342385, 5580.0, 5581.6930068845795, 5621.775128994795, 5339.332583427072, 5568.248286481273, 5570.637908535932, 5583.609147359727, 5584.246126772915, 4228.090960443519, 4279.893002674958, 4280.079782846703, 4284.0, 4309.612134907873, 3844.2119365530557, 3847.576766555677, 3861.1505468796818, 3883.980580097081, 3888.0, 5107.87230319245, 5222.060029194706, 5233.476652334736, 5237.6071794615555, 5279.049771041173, 5474.151506516497, 5504.944950550524, 5525.11598144295, 5579.358373786985, 5668.319801623831, 5261.579073674096, 5266.578673706094, 5268.0, 5268.57851371897, 5272.314599102169, 4648.279516674853, 4765.976170119127, 4770.236762118045, 4772.236442169236, 4806.279058141306, 5699.487046165865, 5726.112452569859, 5738.942610573924, 5761.769529218785, 5811.418858114239, 5450.972745136249, 5453.64551304164, 5454.781808727766, 5486.835394938158, 5494.890102197854, 5621.578381621313, 5698.173764803997, 5711.400302968294, 5712.257406537124, 5717.599768016199, 5367.704776237344, 5442.5645948323245, 5456.990456765511, 5486.231927530069, 5526.585506086979, 5497.5601951842955, 5530.308711411074, 5542.473465020817, 5546.389897111395, 5562.0, 5248.921266180934, 5424.294841670558, 5432.402435731988, 5440.347158341025, 5484.533814625802, 5348.304720386325, 5370.0, 5399.622026458111, 5425.077736784677, 5463.289772329572, 5375.5162035417, 5381.973090134525, 5385.111456609616, 5390.946090539044, 5393.0, 5238.188080847474, 5348.0, 5492.945070549244, 5499.752511136929, 5514.91727624078, 5306.54894333986, 5318.0, 5326.254324394666, 5362.356517217959, 5371.5971302153275], "value": 5110.069397291051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7991282963792, 612.2713970375253, 614.192337076744, 630.9558330916836, 632.3202557250956, 32527.67472325276, 43802.780986095066, 44623.107537849224, 44780.3282950756, 44826.103477930425, 41724.0, 45892.08215835681, 45894.0, 45907.54092459074, 46028.0, 8095.473794203387, 8952.328575356858, 9090.54547272637, 9110.407823491485, 10767.892321076768, 10977.451127443595, 11083.667489975314, 11092.944535277313, 11101.83347249792, 11121.05471034959, 11029.779404411907, 11080.279781814197, 11085.83371249432, 11085.944570277177, 11087.390193539351, 11017.944910275437, 11086.279391839505, 11094.278871873383, 11103.222774405835, 11104.55581776728, 10800.621978230723, 10837.18721095921, 10849.457527123612, 10863.0, 10894.61868834587, 42979.35530967038, 43306.56693433057, 43327.35008974868, 43331.56668433338, 43348.566514335085, 3625.3836847735947, 3752.699784017272, 3784.8506294793747, 3789.829457674411, 4090.795460226977, 33275.83362083174, 33428.66571334304, 34064.148396290046, 34136.82931585326, 34884.0, 4011.919761604752, 4045.939310910339, 4162.6253637172495, 4183.372494125875, 4219.6202341789385, 351608.0, 353219.0, 354800.0, 355738.0, 356486.0, 58730.41269587335, 58884.7055764727, 59161.0, 59433.405665943654, 59449.0, 62745.68627156926, 62874.37125628685, 62909.68545157245, 62912.596118272195, 62913.37086629167, 17081.914590426968, 17321.133943302786, 17321.91339043322, 17327.306907723803, 17341.393051243147, 13241.867581324255, 13291.069625126149, 13347.132436391603, 13349.932005439541, 13356.73286534264, 16348.346066157459, 18336.266549338143, 18524.351647692267, 18546.721799173025, 18636.906815465834, 6145.446909778141, 6421.2615549211505, 6475.0, 6487.286398496161, 6574.638394888231, 978.3005151316843, 1001.5927621691535, 1065.2862582070031, 1092.766008128746, 1098.4672433869566, 31965.680343196735, 32489.02532924016, 32507.674923250466, 32585.837070814494, 33156.0, 1019.9133073688671, 1144.227646338718, 1166.9241499302518, 1180.8663682864374, 1232.0472051797822, 17384.913075434542, 18129.274829006692, 18473.353432629792, 19222.61554768925, 19241.4227573173, 541489.0, 547443.0, 549021.0, 550451.0, 551953.0, 58589.0, 58696.706516467144, 58710.11934820981, 58728.70635646794, 58787.70606146942, 1277.7380636969585, 1397.2524699285834, 1398.3078376203844, 1418.4538952503153, 1439.7696368580978, 31289.84355078301, 33411.164720882174, 34080.0, 34096.31807363888, 34352.0, 50797.0, 52033.47966520438, 52054.73972630112, 52056.219156713436, 52073.479265206865, 513566.0, 518663.0, 518983.0, 519424.0, 519477.0, 44392.0, 45430.54569454395, 46208.53791462177, 48491.27263090986, 50431.49568504268, 48873.266900995804, 49137.0, 49613.0, 49759.0, 50203.74898125486, 37141.62858371382, 40942.0109878098, 42553.72189260583, 42900.78549607232, 43072.35391469068, 41824.16351673011, 42381.0, 42858.134025829706, 46347.53652463432, 46555.0, 43147.56852431435, 43375.78312108419, 43903.34144987891, 44240.77879610581, 44261.557384425745, 35487.290254195286, 38100.6921966042, 38416.61583384242, 38504.0, 38618.22763544769, 28327.008554700486, 28727.712722872504, 29873.402531949672, 30698.846505767327, 30809.8459507701], "value": 21396.39094861745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9001269657191, 384.75183506638217, 389.12835249042155, 398.1797497155859, 413.9130782535667, 14711.264436778158, 14737.557873263806, 19121.904390478045, 20123.798762012375, 20218.09018594163, 16081.83918160818, 16191.595210119753, 16195.676086478263, 16242.918785406056, 18926.242950282005, 1657.4861792844197, 1659.5270347950836, 1659.6514731906254, 1659.7178479658487, 1866.9159887805013, 4188.183304255671, 6114.2357205349335, 6346.492280617563, 6381.202349706286, 6471.0940468334475, 6207.534434917399, 6378.872422551546, 6405.967970160166, 6410.423061924426, 6415.807525774234, 6406.807795766134, 6468.644224567647, 6474.38493343134, 6480.416762491375, 6482.416582507597, 4962.503749625044, 5199.220116982483, 5225.6603320784025, 5289.2859463972645, 5686.715664216773, 13030.283334416603, 13159.671008224776, 13199.208047517084, 13240.86759132406, 13241.470341186341, 2323.546908352872, 2361.0437772702085, 2425.8787060647073, 2760.6135141080063, 2840.24733445635, 9985.65050223246, 10851.0, 12551.121421500498, 14263.358148883326, 15166.090034597959, 1861.2554978008905, 1899.0, 1942.669746143159, 1954.7361106250617, 1958.637652034378, 73994.0, 77975.61012194959, 78441.0, 79299.6035019827, 81475.0, 10816.026557609854, 10966.38047583181, 11354.772904542027, 11442.313461192354, 11484.59803906876, 15575.299111540007, 15580.376784928703, 15581.376744930076, 15588.142652154014, 15608.843911560965, 7913.485623434458, 8138.186181381933, 8148.67405303793, 8157.67369305233, 8227.506349619041, 7327.194008659043, 7362.116546014512, 7678.308952194329, 7800.336971357385, 8051.2351326623875, 4364.738115713004, 4444.73331600105, 4524.47968483622, 4567.2920697291975, 4904.239842824368, 1884.3310624728024, 1904.3239649924078, 1947.4060411574605, 1990.9303174389117, 2022.9393118206478, 921.7050543826045, 959.4770849886828, 992.0625009366224, 1051.8579991701022, 1068.5512084924194, 19941.601167976558, 19991.300304489272, 20346.491337716674, 20418.285360012327, 20692.793072069086, 977.6627063663025, 984.3700031979539, 1001.1390204424189, 1019.8011387779312, 1084.5011294804478, 10617.575296988189, 11257.380844053656, 11351.375674337825, 11411.25826821254, 11413.885861141449, 477285.0, 483707.0, 483755.0, 495322.0, 496259.0, 89461.55269223612, 90073.0, 91326.0, 91446.54276728707, 93137.534312328, 988.081084591337, 990.6384169777979, 1010.3432768700403, 1013.9594416223416, 1019.0319196763105, 17422.825771742122, 17806.19872105784, 18068.186931587847, 18230.544236394195, 18441.170147343135, 39992.4001139989, 40134.19731605293, 40402.191956160124, 41248.38127428151, 41742.582574173866, 55912.0, 56389.180540973604, 56708.71645641745, 57514.7124264376, 57606.13590796225, 7972.960135199519, 8217.465864719014, 8263.0, 8441.32469402434, 9011.954940225258, 12354.567590134302, 12750.298733569743, 13075.411606477921, 13189.604311870658, 13517.0, 10867.510962006887, 11698.94150529242, 11708.356040417859, 11760.647180584596, 12317.260964342167, 11263.380514071805, 11311.490982905625, 11347.829782553103, 11499.94250028778, 11616.186866919235, 11405.201635885409, 11682.357470339213, 11828.23116497425, 12068.818967715666, 12394.442250098587, 7561.546307221364, 7707.34487568563, 8270.917290827256, 8471.576421178794, 8588.699395521127, 11393.772124557629, 12016.939915300367, 12103.636890893287, 12160.331181784733, 12308.81536776967], "value": 8825.29468852238, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.7050834070674, 1482.770170623553, 1546.404634215827, 1677.4548271811657, 1819.6542656895197, 8511.616977236024, 8906.86639700405, 8936.865947010792, 9102.81794364114, 9114.088591140882, 8940.374173807835, 9038.231750301216, 9051.72844814655, 9052.0, 9063.27493800496, 2374.430136767172, 2398.5442765874513, 2401.855888646678, 2403.2189538400003, 2404.8677322747244, 2350.247920665388, 2388.8088952883727, 2395.3412811476896, 2395.4969456414174, 2396.5686176488225, 2343.1798870395396, 2366.7692799744123, 2367.550165468564, 2371.739108698042, 2380.33350661815, 2267.0818318581, 2281.4638559938485, 2292.1289909834322, 2295.6671282664006, 2330.906763729449, 2281.0989659084735, 2285.565742508918, 2288.39357570244, 2292.6904867842964, 2293.9885300573555, 8987.056359082333, 9047.547622618842, 9067.501287429188, 9088.363814532986, 9115.81768364629, 5095.719735414551, 5273.077211487975, 5273.630845840793, 5290.338707661543, 5299.0, 3314.0886256279473, 3319.3859136059905, 3357.2110554019787, 3368.292658541709, 3373.308471763283, 1161.0827446317398, 1175.4122938530734, 1194.1700518139896, 1208.7582483503247, 1224.5897624295872, 12257.203281786655, 12301.93849030758, 12324.75350492994, 12328.383580820922, 12345.629631111082, 4140.91718165635, 4276.166147601188, 4371.191329604034, 4425.734455932655, 4429.0, 9736.123748862636, 9760.023997600183, 9761.365511241747, 9774.609015639437, 9777.0, 4964.67729597575, 4974.054929563371, 4975.701457912537, 4975.850724478271, 4977.552020318189, 4262.722923009995, 4675.4155730533685, 4686.835960741358, 4824.662273640812, 4866.805327786919, 3559.0924314299687, 3663.157473781045, 3695.6489133532273, 3733.8879833605033, 3758.2671379080816, 1147.2485521983115, 1153.4982282707049, 1161.4599211366756, 1161.9128565357632, 1169.2925779903037, 937.0910217089412, 994.3288280410694, 1011.3375738891039, 1016.4714348538719, 1034.3121823986965, 6218.440340369389, 6255.40573645503, 6274.560780745395, 6451.1936007999, 6557.9344206557325, 454.8658145846983, 457.78941686823765, 464.0857510703908, 471.50491983417277, 473.9928901066487, 4209.284421648327, 4226.957730422657, 4244.745315281031, 4275.87172384829, 4362.694611377173, 11238.38188899602, 11357.148213883991, 11420.94289528547, 11547.711307217387, 11598.594049208237, 11450.770984580427, 11520.423978801027, 11531.538738450536, 11538.711532211593, 11546.422678866023, 8360.372972027, 8537.957310213533, 8605.870911936327, 8616.095309992486, 8618.482891026559, 5960.105984102419, 5985.850353741192, 6082.817515474543, 6136.2636483622255, 6260.561760676709, 10344.741381465223, 10601.787964240826, 10616.1507079435, 10626.893731062899, 10684.465776710978, 10869.945650271698, 10918.18113641496, 10929.071028962628, 10944.78110437771, 10949.890501095206, 6947.40947019509, 7226.530275532074, 7353.0, 7677.270659287359, 7758.534487930742, 8615.0, 8757.562121893752, 8764.956175219084, 8765.780855478664, 8783.165599268059, 7604.505707129019, 7658.3838914987255, 7719.3052625264, 7943.920560794318, 7947.125816160334, 7538.924610753822, 7639.312461878458, 7680.308772210527, 7725.381969442319, 7745.961270193839, 7131.714731410685, 7197.784066478014, 7208.639568021683, 7229.024081748897, 7229.132504099542, 5078.314427552233, 5125.5899528036925, 5191.636585439134, 5206.635535512478, 5449.591280654046, 5082.567981721595, 5119.206522988943, 5131.230315452712, 5202.531772140374, 5272.947270527399], "value": 4587.432614837854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.4725120044723, 315.25914101860633, 317.3731879537913, 324.654243230959, 325.6352884769059, 5160.277561141444, 5205.219217117425, 5208.4531124231935, 5216.5565926896215, 5225.8693532661655, 5112.258722485238, 5115.846524604259, 5138.820141295056, 5148.253503242027, 5157.845264642057, 3856.2287542491545, 3880.9223815523674, 3951.209758048402, 3962.3065963456424, 3998.960010399888, 3983.6215559521943, 3985.9601403986026, 3987.9601203987877, 3990.521137463494, 3991.2017596480673, 3950.3606003508507, 3959.0, 3974.403839424095, 3981.8850721797944, 3982.7610343379347, 3847.269018886431, 3862.7875466849314, 3984.442178095069, 3996.360582306846, 4017.7790221537803, 3547.450145227494, 3550.840212190458, 3558.3417067842533, 3559.804210768407, 3567.661072198137, 5036.093503169428, 5037.370328708911, 5046.419661738911, 5056.974715126437, 5069.417017043051, 4392.780360981938, 4539.954600453986, 4567.1550763108935, 4573.131105090022, 4589.47221069578, 5310.256564081032, 5310.6813591184655, 5316.255724198615, 5332.786688532454, 5352.090144675414, 3880.5149356330458, 3895.3183192941406, 3898.9530496489288, 3899.083715326896, 3900.590438003997, 5346.866328341784, 5524.58565607581, 5539.335279766414, 5548.611597188198, 5583.4137415571595, 3912.295786758354, 3925.0, 3927.4501569780255, 3931.2923673739, 3939.6454319111417, 3982.203559288154, 3985.8206380712936, 3991.3214753491975, 3994.380870965005, 3996.0609256824623, 4450.866474005785, 4530.614897733663, 4560.1335746208115, 4565.447747765776, 4569.977150114228, 5405.0, 5411.404745477994, 5421.322334708161, 5430.185472179205, 5432.91850622241, 1331.2345401394043, 1338.9732205355838, 1340.1088276296155, 1346.8181795457683, 1347.413874964374, 814.9225823546753, 873.3624454148508, 873.554487211514, 881.8633111867671, 882.6513527156866, 5086.3896332440345, 5178.585713142939, 5220.7128607926925, 5290.391604965478, 5318.840434786963, 5546.7781288748, 5555.583331250173, 5561.860953476195, 5585.776568937197, 5590.86022849432, 5106.846794596168, 5326.227696983916, 5327.680339179662, 5328.227407025959, 5331.653442526223, 2903.840288784095, 2940.7942743475073, 2944.366961103373, 2955.989926849763, 2956.684275497383, 5810.709464526757, 5826.184334193216, 5830.0, 5834.183214349994, 5838.12428135783, 5421.972890135524, 5680.346760122557, 5682.772689092472, 5722.084466485342, 5740.598158128891, 5767.538596912321, 5836.941630583725, 5844.26946631671, 5867.154430101397, 5880.735366908414, 5454.9271276914515, 5551.666899986014, 5591.356993945748, 5592.3848376677715, 5592.944070559405, 5491.945080549143, 5496.203050557567, 5504.990678402274, 5515.834524964257, 5515.862103447446, 5819.709014549171, 5831.82504524848, 5842.970785146217, 5849.011336145731, 5853.595137166964, 3711.4432835073876, 3876.7092468064443, 3905.2775236581324, 3952.26883026641, 3977.463042489227, 5520.834374968757, 5523.7790488380015, 5545.0, 5551.861203469784, 5557.0, 5404.648697834628, 5406.702631355313, 5411.431799660979, 5416.702081385404, 5449.509544141047, 5154.917467331902, 5350.411454740053, 5382.757775900172, 5451.64564303319, 5454.400015998316, 5376.30108085962, 5388.892222155613, 5392.838214853561, 5393.460653934575, 5396.059147764399, 5217.817131549676, 5297.735113244245, 5436.592255580768, 5454.290942177491, 5498.945010549844, 5299.125644268806, 5300.045991721528, 5325.414204437587, 5331.386890507486, 5336.839894803162], "value": 4114.03719036815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.4550232827709, 761.9085709714835, 769.449843361996, 769.4806005945989, 804.6459557794568, 16604.501864944057, 17543.12284385782, 17549.21028553715, 17550.561235969108, 17576.0, 15708.450204242854, 15856.207189640501, 15888.205589720526, 15889.046657200575, 15889.52331430056, 665.0987911380083, 791.8574656561846, 800.503687713617, 821.6302663801283, 826.7850358906668, 822.6709316273509, 822.8889099971517, 825.0305890578576, 825.2655136928139, 825.451075035101, 864.5547543015352, 870.6299822575412, 871.2768402226169, 871.8299931513358, 871.860502319629, 692.3457332820461, 709.2092317066459, 712.6045045000022, 824.2169938558394, 862.7886167888876, 627.109504503606, 630.2562975688686, 630.3255516597243, 630.9652969086699, 631.7536160897254, 15894.205289735582, 15914.204289785464, 15925.362985480568, 15974.76037859433, 15988.360465581363, 14965.551033469013, 15006.62483437912, 15095.32071056805, 15155.104427485468, 15226.086434813946, 13904.165750055028, 14028.298585070808, 14124.364403601863, 14239.64400889986, 14240.572782816533, 4407.559244075599, 4412.152054746869, 4455.933161002587, 4504.8873778155485, 4594.19601569724, 67975.66012169956, 79316.0, 79680.0, 79688.60155699242, 81076.59461702712, 11600.76798464026, 12098.395080245953, 12239.082068844873, 12293.999999999822, 12370.690732731753, 21698.132074716836, 21721.891390542947, 21737.13051477923, 21738.456538586346, 21742.565148697253, 8269.545175015432, 8422.536760478233, 8651.134886511425, 8686.652533898574, 8868.955655221811, 4608.516105808909, 4723.173444647173, 4787.4494433140635, 4884.169691152512, 4914.557689807934, 3553.893383198508, 3695.667389934919, 3699.2786406650443, 3700.648438398348, 3708.942951258932, 656.9671516424255, 658.8418779492984, 660.9966950165218, 669.608279156689, 677.7289084366195, 616.6097386607385, 646.440828683195, 690.2407351912856, 732.1945859554447, 734.2400615363074, 9680.0, 10178.796424071625, 10416.218783591261, 10470.790584188273, 10630.30902991303, 609.0620444515397, 657.4641667041346, 747.8766003609344, 749.9025126733599, 780.0872978615034, 4832.516748325139, 5210.244514545369, 5211.609129315317, 5247.370315562081, 5260.947390526122, 124567.0, 127561.0, 128873.35563322123, 129539.35230323789, 132421.33789330992, 101818.0, 106863.0, 108383.45808270908, 112292.0, 112795.0, 57170.0, 75272.62363688256, 96802.0, 98102.5094874521, 100171.49914250527, 9559.569819358006, 9571.521423928914, 9585.233181345615, 9615.5672994714, 9683.612655493702, 54846.72576637091, 55428.0, 55560.72219638876, 56191.71904140453, 56844.73664475264, 78142.0, 79968.0, 82971.0, 84405.57797210975, 85334.02661813614, 11484.425778711198, 11975.940120299343, 12328.568500102454, 12438.689032774253, 12781.87218127844, 13990.16059036461, 14047.929760351133, 14254.928725356307, 14363.56909292723, 14479.506927587381, 12136.783568478864, 12684.048696347627, 12799.936000319938, 12896.613101606967, 12926.289054102115, 12596.181248218836, 12609.558665446666, 12640.367981601066, 12732.363381830686, 13216.603501894959, 12885.117753803786, 13062.80405793933, 13145.408456619283, 13149.53976610814, 13583.52457663977, 10240.846387304346, 10265.332753371007, 10385.896141038493, 10426.270161088954, 10517.684469465928, 10056.698299050748, 11498.597549085742, 11583.594574189863, 12028.879711202775, 12182.756344872876], "value": 7754.1238818423535, "unit": "score"}], "name": "dromaeo_css", "value": 7216.381258630994, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 112.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 119.0, 191.0, 119.0, 118.0, 142.0, 118.0, 153.0, 117.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 163.0, 160.0, 161.0, 160.0, 161.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 124.0, 75.0, 77.0, 75.0, 75.0, 108.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 85.0, 84.0, 84.0, 121.0, 85.0, 84.0, 132.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 146.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 49.0, 50.0, 49.0, 51.0, 49.0, 48.0, 50.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 75.0, 76.0, 86.0, 77.0, 77.0, 75.0, 75.0, 75.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 123.0, 129.0, 120.0, 120.0, 118.0, 121.0, 122.0, 167.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 162.0, 162.0, 161.0, 162.0, 159.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 62.0, 65.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1481.2000000000003, "alertThreshold": 2.0}]} 23:44:48 INFO - Return code: 0 23:44:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:48 INFO - # TBPL SUCCESS # 23:44:48 INFO - Running post-action listener: _resource_record_post_action 23:44:48 INFO - [mozharness: 2016-08-04 06:44:48.802169Z] Finished run-tests step (success) 23:44:48 INFO - Running post-run listener: _resource_record_post_run 23:44:48 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554319872; Read time: 12; Write time: 716448 23:44:48 INFO - TinderboxPrint: CPU usage
13.0% 23:44:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:44:48 INFO - TinderboxPrint: I/O write bytes / time
554,319,872 / 716,448 23:44:48 INFO - TinderboxPrint: CPU idle
8,301.2 (87.0%) 23:44:48 INFO - TinderboxPrint: CPU user
1,186.0 (12.4%) 23:44:48 INFO - TinderboxPrint: Swap in / out
0 / 0 23:44:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264155136; Read time: 0; Write time: 362900 23:44:48 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289669120; Read time: 0; Write time: 353488 23:44:49 INFO - Running post-run listener: _upload_blobber_files 23:44:49 INFO - Blob upload gear active. 23:44:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:49 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 23:44:49 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'] 23:44:49 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 23:44:49 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:44:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:50 INFO - (blobuploader) - INFO - Done attempting. 23:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:51 INFO - (blobuploader) - INFO - Done attempting. 23:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:55 INFO - (blobuploader) - INFO - Done attempting. 23:44:55 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:55 INFO - Return code: 0 23:44:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9904c8ac183b141baafce14919519c839f0788c1d44829dd40b6518a2bf05b34185a5eb831e300a25d2671245c21a7ca50c04a00a670cb066f59208e9a57fa4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f41d20054593fc2d99b552a12e4b07d34bd8bcced0a6f01f3484ddbf852defc74661beb1671a8d1a79a974841ab3c61dbd143f851a5cdab481adf5b92cadf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce33fb038745ea73a6c4d532c5f98d366539f06773c83c2329992667dbc8ca1bb26abca0e09ad4dd01f3aa788e93fb713a6c969e80af1377f7563d02c7af68"} 23:44:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:55 INFO - Contents: 23:44:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9904c8ac183b141baafce14919519c839f0788c1d44829dd40b6518a2bf05b34185a5eb831e300a25d2671245c21a7ca50c04a00a670cb066f59208e9a57fa4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f41d20054593fc2d99b552a12e4b07d34bd8bcced0a6f01f3484ddbf852defc74661beb1671a8d1a79a974841ab3c61dbd143f851a5cdab481adf5b92cadf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce33fb038745ea73a6c4d532c5f98d366539f06773c83c2329992667dbc8ca1bb26abca0e09ad4dd01f3aa788e93fb713a6c969e80af1377f7563d02c7af68"} 23:44:55 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:55 INFO - Copying logs to upload dir... 23:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.205108 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-03 23:44:55.176514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 23:44:55.180683) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 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/9904c8ac183b141baafce14919519c839f0788c1d44829dd40b6518a2bf05b34185a5eb831e300a25d2671245c21a7ca50c04a00a670cb066f59208e9a57fa4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f41d20054593fc2d99b552a12e4b07d34bd8bcced0a6f01f3484ddbf852defc74661beb1671a8d1a79a974841ab3c61dbd143f851a5cdab481adf5b92cadf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce33fb038745ea73a6c4d532c5f98d366539f06773c83c2329992667dbc8ca1bb26abca0e09ad4dd01f3aa788e93fb713a6c969e80af1377f7563d02c7af68"} build_url:https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/Bv_WWYrHRVCAVAfPopjtAw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9904c8ac183b141baafce14919519c839f0788c1d44829dd40b6518a2bf05b34185a5eb831e300a25d2671245c21a7ca50c04a00a670cb066f59208e9a57fa4d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4f41d20054593fc2d99b552a12e4b07d34bd8bcced0a6f01f3484ddbf852defc74661beb1671a8d1a79a974841ab3c61dbd143f851a5cdab481adf5b92cadf7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcce33fb038745ea73a6c4d532c5f98d366539f06773c83c2329992667dbc8ca1bb26abca0e09ad4dd01f3aa788e93fb713a6c969e80af1377f7563d02c7af68"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 23:44:55.212175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:44:55.212666) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470285971.429418-723937573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 23:44:55.296945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 23:44:55.297275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 23:44:55.297599) ========= ========= Total master_lag: 0.19 =========