builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1463639237.8 results: success (0) buildid: 20160518203028 builduid: a7a0ccee54854a178af8d048424ec083 revision: eb54f97ddfd410d426df5989a8ddd962d97bee44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.798926) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.799399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.799737) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.848457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:17.848779) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 23:27:17-- 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% 221M=0s 2016-05-18 23:27:18 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.320153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:18.183649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:18.184114) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013872 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:18.233687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 23:27:18.234149) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb54f97ddfd410d426df5989a8ddd962d97bee44 --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 eb54f97ddfd410d426df5989a8ddd962d97bee44 --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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 23:27:18,183 truncating revision to first 12 chars 2016-05-18 23:27:18,183 Setting DEBUG logging. 2016-05-18 23:27:18,183 attempt 1/10 2016-05-18 23:27:18,183 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb54f97ddfd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 23:27:19,020 unpacking tar archive at: fx-team-eb54f97ddfd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.132197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 23:27:19.379774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.380207) ========= script_repo_revision: eb54f97ddfd410d426df5989a8ddd962d97bee44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.380685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.381048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 23:27:19.391510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-18 23:27:19.391863) ========= /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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:27:19 INFO - MultiFileLogger online at 20160518 23:27:19 in /builds/slave/test 23:27:19 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:27:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:27:19 INFO - {'append_to_log': False, 23:27:19 INFO - 'base_work_dir': '/builds/slave/test', 23:27:19 INFO - 'blob_upload_branch': 'Fx-Team', 23:27:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:27:19 INFO - 'branch': 'Fx-Team', 23:27:19 INFO - 'buildbot_json_path': 'buildprops.json', 23:27:19 INFO - 'config_files': ('talos/linux_config.py',), 23:27:19 INFO - 'default_actions': ('clobber', 23:27:19 INFO - 'read-buildbot-config', 23:27:19 INFO - 'download-and-extract', 23:27:19 INFO - 'populate-webroot', 23:27:19 INFO - 'create-virtualenv', 23:27:19 INFO - 'install', 23:27:19 INFO - 'run-tests'), 23:27:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:27:19 INFO - 'download_minidump_stackwalk': True, 23:27:19 INFO - 'download_symbols': 'ondemand', 23:27:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:27:19 INFO - 'tooltool.py': '/tools/tooltool.py', 23:27:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:27:19 INFO - '/tools/misc-python/virtualenv.py')}, 23:27:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:27:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:27:19 INFO - 'installer_path': 'installer.exe', 23:27:19 INFO - 'log_level': 'info', 23:27:19 INFO - 'log_name': 'talos', 23:27:19 INFO - 'log_to_console': True, 23:27:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:27:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:27:19 INFO - 'opt_config_files': (), 23:27:19 INFO - 'pip_index': False, 23:27:19 INFO - 'sps_profile': False, 23:27:19 INFO - 'sps_profile_interval': 0, 23:27:19 INFO - 'suite': 'dromaeojs', 23:27:19 INFO - 'system_bits': '32', 23:27:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:27:19 INFO - 'title': 'talos-linux64-ix-060', 23:27:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:27:19 INFO - 'use_talos_json': True, 23:27:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:27:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:27:19 INFO - 'work_dir': 'build'} 23:27:19 INFO - ##### 23:27:19 INFO - ##### Running clobber step. 23:27:19 INFO - ##### 23:27:19 INFO - Running pre-action listener: _resource_record_pre_action 23:27:19 INFO - Running main action method: clobber 23:27:19 INFO - rmtree: /builds/slave/test/build 23:27:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:27:20 INFO - Running post-action listener: _resource_record_post_action 23:27:20 INFO - ##### 23:27:20 INFO - ##### Finished clobber step (success) 23:27:20 INFO - ##### 23:27:20 INFO - ##### 23:27:20 INFO - ##### Running read-buildbot-config step. 23:27:20 INFO - ##### 23:27:20 INFO - Running pre-action listener: _resource_record_pre_action 23:27:20 INFO - Running main action method: read_buildbot_config 23:27:20 INFO - Using buildbot properties: 23:27:20 INFO - { 23:27:20 INFO - "project": "", 23:27:20 INFO - "product": "firefox", 23:27:20 INFO - "script_repo_revision": "production", 23:27:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:27:20 INFO - "repository": "", 23:27:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:27:20 INFO - "buildid": "20160518203028", 23:27:20 INFO - "pgo_build": "True", 23:27:20 INFO - "basedir": "/builds/slave/test", 23:27:20 INFO - "buildnumber": 106, 23:27:20 INFO - "slavename": "talos-linux64-ix-060", 23:27:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:27:20 INFO - "platform": "ubuntu64_hw", 23:27:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:27:20 INFO - "branch": "fx-team", 23:27:20 INFO - "repo_path": "integration/fx-team", 23:27:20 INFO - "revision": "eb54f97ddfd410d426df5989a8ddd962d97bee44", 23:27:20 INFO - "stage_platform": "linux64-pgo", 23:27:20 INFO - "builduid": "a7a0ccee54854a178af8d048424ec083", 23:27:20 INFO - "slavebuilddir": "test" 23:27:20 INFO - } 23:27:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:27:20 INFO - Running post-action listener: _resource_record_post_action 23:27:20 INFO - ##### 23:27:20 INFO - ##### Finished read-buildbot-config step (success) 23:27:20 INFO - ##### 23:27:20 INFO - ##### 23:27:20 INFO - ##### Running download-and-extract step. 23:27:20 INFO - ##### 23:27:20 INFO - Running pre-action listener: _resource_record_pre_action 23:27:20 INFO - Running main action method: download_and_extract 23:27:20 INFO - mkdir: /builds/slave/test/build/tests 23:27:20 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:27:20 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:27:21 INFO - Downloaded 1361 bytes. 23:27:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:27:21 INFO - Using the following test package requirements: 23:27:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:27:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:27:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:27:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'jsshell-linux-x86_64.zip'], 23:27:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:27:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:27:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:27:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:27:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:27:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:27:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:27:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:27:21 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:27:21 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:27:22 INFO - Downloaded 24386200 bytes. 23:27:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:27:24 INFO - Return code: 0 23:27:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:24 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:27:27 INFO - Downloaded 24386200 bytes. 23:27:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:27:29 INFO - Return code: 0 23:27:29 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:27:29 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:27:30 INFO - Downloaded 10840194 bytes. 23:27:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:27:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:27:30 INFO - Return code: 0 23:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:30 INFO - https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:27:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:27:31 INFO - Downloaded 58423860 bytes. 23:27:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:31 INFO - mkdir: /builds/slave/test/properties 23:27:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:27:31 INFO - Writing to file /builds/slave/test/properties/build_url 23:27:31 INFO - Contents: 23:27:31 INFO - build_url:https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:27:32 INFO - Running post-action listener: _resource_record_post_action 23:27:32 INFO - Running post-action listener: set_extra_try_arguments 23:27:32 INFO - ##### 23:27:32 INFO - ##### Finished download-and-extract step (success) 23:27:32 INFO - ##### 23:27:32 INFO - ##### 23:27:32 INFO - ##### Running populate-webroot step. 23:27:32 INFO - ##### 23:27:32 INFO - Running pre-action listener: _resource_record_pre_action 23:27:32 INFO - Running main action method: populate_webroot 23:27:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:27:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:27:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:27:32 INFO - '--tppagecycles', 23:27:32 INFO - '7'], 23:27:32 INFO - 'tests': ['tsvgm']}}, 23:27:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:27:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:27:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:27:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:27:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:27:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['damp', 'tps']}, 23:27:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'tests': ['damp', 'tps']}, 23:27:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['dromaeo_dom']}, 23:27:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:27:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'other-e10s': {'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['a11yr', 23:27:32 INFO - 'ts_paint', 23:27:32 INFO - 'tpaint', 23:27:32 INFO - 'sessionrestore', 23:27:32 INFO - 'sessionrestore_no_auto_restore', 23:27:32 INFO - 'tabpaint']}, 23:27:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['tsvgx', 23:27:32 INFO - 'tsvgr_opacity', 23:27:32 INFO - 'tart', 23:27:32 INFO - 'tscrollx', 23:27:32 INFO - 'cart']}, 23:27:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:27:32 INFO - 'tsvgr_opacity', 23:27:32 INFO - 'tart', 23:27:32 INFO - 'tscrollx', 23:27:32 INFO - 'cart']}, 23:27:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'talos_options': ['--disable-e10s'], 23:27:32 INFO - 'tests': ['tp5o']}, 23:27:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'tests': ['tp5o']}, 23:27:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'talos_options': ['--disable-e10s', 23:27:32 INFO - '--xperf_path', 23:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:32 INFO - 'tests': ['tp5n']}, 23:27:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:27:32 INFO - 'talos_options': ['--xperf_path', 23:27:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:27:32 INFO - 'tests': ['tp5n']}}, 23:27:32 INFO - 'talos.zip': {'path': '', 23:27:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:27:32 INFO - Running post-action listener: _resource_record_post_action 23:27:32 INFO - ##### 23:27:32 INFO - ##### Finished populate-webroot step (success) 23:27:32 INFO - ##### 23:27:32 INFO - ##### 23:27:32 INFO - ##### Running create-virtualenv step. 23:27:32 INFO - ##### 23:27:32 INFO - Running pre-action listener: _resource_record_pre_action 23:27:32 INFO - Running main action method: create_virtualenv 23:27:32 INFO - Creating virtualenv /builds/slave/test/build/venv 23:27:32 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:27:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:27:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:27:32 INFO - Using real prefix '/usr' 23:27:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:27:33 INFO - Installing distribute.............................................................................................................................................................................................done. 23:27:35 INFO - Installing pip.................done. 23:27:35 INFO - Return code: 0 23:27:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:27:35 INFO - Using env: {'DISPLAY': ':0', 23:27:35 INFO - 'HOME': '/home/cltbld', 23:27:35 INFO - 'LANG': 'en_US.UTF-8', 23:27:35 INFO - 'LANGUAGE': 'en_US:en', 23:27:35 INFO - 'LOGNAME': 'cltbld', 23:27:35 INFO - 'MAIL': '/var/mail/cltbld', 23:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:35 INFO - 'MOZ_NO_REMOTE': '1', 23:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:35 INFO - 'NO_EM_RESTART': '1', 23:27:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:35 INFO - 'PWD': '/builds/slave/test', 23:27:35 INFO - 'SHELL': '/bin/bash', 23:27:35 INFO - 'SHLVL': '1', 23:27:35 INFO - 'TERM': 'linux', 23:27:35 INFO - 'TMOUT': '86400', 23:27:35 INFO - 'USER': 'cltbld', 23:27:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:35 INFO - '_': '/tools/buildbot/bin/python'} 23:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:36 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:27:36 INFO - Cleaning up... 23:27:36 INFO - Return code: 0 23:27:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:27: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:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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', '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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:27: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 psutil>=3.1.1 23:27:36 INFO - Using env: {'DISPLAY': ':0', 23:27:36 INFO - 'HOME': '/home/cltbld', 23:27:36 INFO - 'LANG': 'en_US.UTF-8', 23:27:36 INFO - 'LANGUAGE': 'en_US:en', 23:27:36 INFO - 'LOGNAME': 'cltbld', 23:27:36 INFO - 'MAIL': '/var/mail/cltbld', 23:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:36 INFO - 'MOZ_NO_REMOTE': '1', 23:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:36 INFO - 'NO_EM_RESTART': '1', 23:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:36 INFO - 'PWD': '/builds/slave/test', 23:27:36 INFO - 'SHELL': '/bin/bash', 23:27:36 INFO - 'SHLVL': '1', 23:27:36 INFO - 'TERM': 'linux', 23:27:36 INFO - 'TMOUT': '86400', 23:27:36 INFO - 'USER': 'cltbld', 23:27:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:36 INFO - '_': '/tools/buildbot/bin/python'} 23:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:36 INFO - Downloading/unpacking psutil>=3.1.1 23:27: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:27: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:27: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:27: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:27: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:27: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:27:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:38 INFO - Installing collected packages: psutil 23:27:38 INFO - Running setup.py install for psutil 23:27:38 INFO - building 'psutil._psutil_linux' extension 23:27:38 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:27:39 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:27:39 INFO - building 'psutil._psutil_posix' extension 23:27:39 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:27:39 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:27:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:27:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:27:39 INFO - Successfully installed psutil 23:27:39 INFO - Cleaning up... 23:27:39 INFO - Return code: 0 23:27:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:27: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:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:27: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 mozsystemmonitor==0.3 23:27:39 INFO - Using env: {'DISPLAY': ':0', 23:27:39 INFO - 'HOME': '/home/cltbld', 23:27:39 INFO - 'LANG': 'en_US.UTF-8', 23:27:39 INFO - 'LANGUAGE': 'en_US:en', 23:27:39 INFO - 'LOGNAME': 'cltbld', 23:27:39 INFO - 'MAIL': '/var/mail/cltbld', 23:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:39 INFO - 'MOZ_NO_REMOTE': '1', 23:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:39 INFO - 'NO_EM_RESTART': '1', 23:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:39 INFO - 'PWD': '/builds/slave/test', 23:27:39 INFO - 'SHELL': '/bin/bash', 23:27:39 INFO - 'SHLVL': '1', 23:27:39 INFO - 'TERM': 'linux', 23:27:39 INFO - 'TMOUT': '86400', 23:27:39 INFO - 'USER': 'cltbld', 23:27:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:39 INFO - '_': '/tools/buildbot/bin/python'} 23:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:27: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:27: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:27: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:27: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:27: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:27: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:27:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:27:41 INFO - Installing collected packages: mozsystemmonitor 23:27:41 INFO - Running setup.py install for mozsystemmonitor 23:27:41 INFO - Successfully installed mozsystemmonitor 23:27:41 INFO - Cleaning up... 23:27:41 INFO - Return code: 0 23:27:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:27: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:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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:27: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:27:41 INFO - Using env: {'DISPLAY': ':0', 23:27:41 INFO - 'HOME': '/home/cltbld', 23:27:41 INFO - 'LANG': 'en_US.UTF-8', 23:27:41 INFO - 'LANGUAGE': 'en_US:en', 23:27:41 INFO - 'LOGNAME': 'cltbld', 23:27:41 INFO - 'MAIL': '/var/mail/cltbld', 23:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:41 INFO - 'MOZ_NO_REMOTE': '1', 23:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:41 INFO - 'NO_EM_RESTART': '1', 23:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:41 INFO - 'PWD': '/builds/slave/test', 23:27:41 INFO - 'SHELL': '/bin/bash', 23:27:41 INFO - 'SHLVL': '1', 23:27:41 INFO - 'TERM': 'linux', 23:27:41 INFO - 'TMOUT': '86400', 23:27:41 INFO - 'USER': 'cltbld', 23:27:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:41 INFO - '_': '/tools/buildbot/bin/python'} 23:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:42 INFO - Downloading/unpacking blobuploader==1.2.4 23:27:42 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:27:42 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:27:42 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:27:42 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:27:42 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:27:42 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:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 23:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:27:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:27: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:27: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:27: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:27: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:27: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:27: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:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:27:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:27: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:27: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:27: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:27: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:27: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:27: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:27:44 INFO - Downloading docopt-0.6.1.tar.gz 23:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:27:44 INFO - Installing collected packages: blobuploader, requests, docopt 23:27:44 INFO - Running setup.py install for blobuploader 23:27:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:27:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:27:44 INFO - Running setup.py install for requests 23:27:45 INFO - Running setup.py install for docopt 23:27:45 INFO - Successfully installed blobuploader requests docopt 23:27:45 INFO - Cleaning up... 23:27:45 INFO - Return code: 0 23:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27: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:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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:27: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:27:45 INFO - Using env: {'DISPLAY': ':0', 23:27:45 INFO - 'HOME': '/home/cltbld', 23:27:45 INFO - 'LANG': 'en_US.UTF-8', 23:27:45 INFO - 'LANGUAGE': 'en_US:en', 23:27:45 INFO - 'LOGNAME': 'cltbld', 23:27:45 INFO - 'MAIL': '/var/mail/cltbld', 23:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:45 INFO - 'MOZ_NO_REMOTE': '1', 23:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:45 INFO - 'NO_EM_RESTART': '1', 23:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:45 INFO - 'PWD': '/builds/slave/test', 23:27:45 INFO - 'SHELL': '/bin/bash', 23:27:45 INFO - 'SHLVL': '1', 23:27:45 INFO - 'TERM': 'linux', 23:27:45 INFO - 'TMOUT': '86400', 23:27:45 INFO - 'USER': 'cltbld', 23:27:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:45 INFO - '_': '/tools/buildbot/bin/python'} 23:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:45 INFO - Running setup.py (path:/tmp/pip-kjpyRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:45 INFO - Running setup.py (path:/tmp/pip-ZSembi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:45 INFO - Running setup.py (path:/tmp/pip-bUIPE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:45 INFO - Running setup.py (path:/tmp/pip-s6i5_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:45 INFO - Running setup.py (path:/tmp/pip-kkeudR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:45 INFO - Running setup.py (path:/tmp/pip-H0hRIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:46 INFO - Running setup.py (path:/tmp/pip-D2L_mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:46 INFO - Running setup.py (path:/tmp/pip-1436_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:46 INFO - Running setup.py (path:/tmp/pip-x3Q07U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:46 INFO - Running setup.py (path:/tmp/pip-vj_IRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:46 INFO - Running setup.py (path:/tmp/pip-k8RJiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:46 INFO - Running setup.py (path:/tmp/pip-70_Ixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:46 INFO - Running setup.py (path:/tmp/pip-qbTauM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:46 INFO - Running setup.py (path:/tmp/pip-lJqceg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:46 INFO - Running setup.py (path:/tmp/pip-0M3ymX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:46 INFO - Running setup.py (path:/tmp/pip-qTrUjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:46 INFO - Running setup.py (path:/tmp/pip-wHYVYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:27:46 INFO - Running setup.py install for manifestparser 23:27:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:27:46 INFO - Running setup.py install for mozcrash 23:27:46 INFO - Running setup.py install for mozdebug 23:27:47 INFO - Running setup.py install for mozdevice 23:27:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for mozfile 23:27:47 INFO - Running setup.py install for mozhttpd 23:27:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for mozinfo 23:27:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for mozInstall 23:27:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for mozleak 23:27:47 INFO - Running setup.py install for mozlog 23:27:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for moznetwork 23:27:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:27:47 INFO - Running setup.py install for mozprocess 23:27:48 INFO - Running setup.py install for mozprofile 23:27:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:27:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:27:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:27:48 INFO - Running setup.py install for mozrunner 23:27:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:27:48 INFO - Running setup.py install for mozscreenshot 23:27:48 INFO - Running setup.py install for moztest 23:27:48 INFO - Running setup.py install for mozversion 23:27:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:27:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:27:48 INFO - Cleaning up... 23:27:48 INFO - Return code: 0 23:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27: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:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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:27: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:27:48 INFO - Using env: {'DISPLAY': ':0', 23:27:48 INFO - 'HOME': '/home/cltbld', 23:27:48 INFO - 'LANG': 'en_US.UTF-8', 23:27:48 INFO - 'LANGUAGE': 'en_US:en', 23:27:48 INFO - 'LOGNAME': 'cltbld', 23:27:48 INFO - 'MAIL': '/var/mail/cltbld', 23:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:48 INFO - 'MOZ_NO_REMOTE': '1', 23:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:48 INFO - 'NO_EM_RESTART': '1', 23:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:48 INFO - 'PWD': '/builds/slave/test', 23:27:48 INFO - 'SHELL': '/bin/bash', 23:27:48 INFO - 'SHLVL': '1', 23:27:48 INFO - 'TERM': 'linux', 23:27:48 INFO - 'TMOUT': '86400', 23:27:48 INFO - 'USER': 'cltbld', 23:27:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:48 INFO - '_': '/tools/buildbot/bin/python'} 23:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:27:48 INFO - Running setup.py (path:/tmp/pip-1iCNPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:27: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:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:27:48 INFO - Running setup.py (path:/tmp/pip-yiIScd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:27: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:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:27:48 INFO - Running setup.py (path:/tmp/pip-FKxzXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:27: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:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:27:49 INFO - Running setup.py (path:/tmp/pip-10suKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:27:49 INFO - Running setup.py (path:/tmp/pip-CgEqXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:27:49 INFO - Running setup.py (path:/tmp/pip-CLVIno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:27:49 INFO - Running setup.py (path:/tmp/pip-kiyxok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:27:49 INFO - Running setup.py (path:/tmp/pip-YsT4y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:27:49 INFO - Running setup.py (path:/tmp/pip-XqMA2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:27:49 INFO - Running setup.py (path:/tmp/pip-zI96Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:27:49 INFO - Running setup.py (path:/tmp/pip-uYtZHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:27:49 INFO - Running setup.py (path:/tmp/pip-BH8ZPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:27:49 INFO - Running setup.py (path:/tmp/pip-nYC_XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:27:49 INFO - Running setup.py (path:/tmp/pip-4fMtUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:27:49 INFO - Running setup.py (path:/tmp/pip-MlptKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:27:49 INFO - Running setup.py (path:/tmp/pip-BUO5W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:27: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:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:27:49 INFO - Running setup.py (path:/tmp/pip-7cSgRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:27:50 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:27:50 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:27:50 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:27:50 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:27:50 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:27:50 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:27:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:27:51 INFO - Downloading blessings-1.6.tar.gz 23:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:27:52 INFO - Installing collected packages: blessings 23:27:52 INFO - Running setup.py install for blessings 23:27:52 INFO - Successfully installed blessings 23:27:52 INFO - Cleaning up... 23:27:52 INFO - Return code: 0 23:27:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:52 INFO - Reading from file tmpfile_stdout 23:27:52 INFO - Current package versions: 23:27:52 INFO - argparse == 1.2.1 23:27:52 INFO - blessings == 1.6 23:27:52 INFO - blobuploader == 1.2.4 23:27:52 INFO - docopt == 0.6.1 23:27:52 INFO - manifestparser == 1.1 23:27:52 INFO - mozInstall == 1.12 23:27:52 INFO - mozcrash == 0.17 23:27:52 INFO - mozdebug == 0.1 23:27:52 INFO - mozdevice == 0.48 23:27:52 INFO - mozfile == 1.2 23:27:52 INFO - mozhttpd == 0.7 23:27:52 INFO - mozinfo == 0.9 23:27:52 INFO - mozleak == 0.1 23:27:52 INFO - mozlog == 3.2 23:27:52 INFO - moznetwork == 0.27 23:27:52 INFO - mozprocess == 0.22 23:27:52 INFO - mozprofile == 0.28 23:27:52 INFO - mozrunner == 6.11 23:27:52 INFO - mozscreenshot == 0.1 23:27:52 INFO - mozsystemmonitor == 0.3 23:27:52 INFO - moztest == 0.7 23:27:52 INFO - mozversion == 1.4 23:27:52 INFO - psutil == 3.1.1 23:27:52 INFO - requests == 1.2.3 23:27:52 INFO - wsgiref == 0.1.2 23:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:27: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:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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:27: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:27:52 INFO - Using env: {'DISPLAY': ':0', 23:27:52 INFO - 'HOME': '/home/cltbld', 23:27:52 INFO - 'LANG': 'en_US.UTF-8', 23:27:52 INFO - 'LANGUAGE': 'en_US:en', 23:27:52 INFO - 'LOGNAME': 'cltbld', 23:27:52 INFO - 'MAIL': '/var/mail/cltbld', 23:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:52 INFO - 'MOZ_NO_REMOTE': '1', 23:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:52 INFO - 'NO_EM_RESTART': '1', 23:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:52 INFO - 'PWD': '/builds/slave/test', 23:27:52 INFO - 'SHELL': '/bin/bash', 23:27:52 INFO - 'SHLVL': '1', 23:27:52 INFO - 'TERM': 'linux', 23:27:52 INFO - 'TMOUT': '86400', 23:27:52 INFO - 'USER': 'cltbld', 23:27:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:52 INFO - '_': '/tools/buildbot/bin/python'} 23:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27: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:27: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:27: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:27: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:27: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:27: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:27: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:27: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:27: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:27: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:27: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:27:52 INFO - Cleaning up... 23:27:52 INFO - Return code: 0 23:27:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:27: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:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27: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 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27: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:27: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:27:52 INFO - Using env: {'DISPLAY': ':0', 23:27:52 INFO - 'HOME': '/home/cltbld', 23:27:52 INFO - 'LANG': 'en_US.UTF-8', 23:27:52 INFO - 'LANGUAGE': 'en_US:en', 23:27:52 INFO - 'LOGNAME': 'cltbld', 23:27:52 INFO - 'MAIL': '/var/mail/cltbld', 23:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:52 INFO - 'MOZ_NO_REMOTE': '1', 23:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:52 INFO - 'NO_EM_RESTART': '1', 23:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:52 INFO - 'PWD': '/builds/slave/test', 23:27:52 INFO - 'SHELL': '/bin/bash', 23:27:52 INFO - 'SHLVL': '1', 23:27:52 INFO - 'TERM': 'linux', 23:27:52 INFO - 'TMOUT': '86400', 23:27:52 INFO - 'USER': 'cltbld', 23:27:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:52 INFO - '_': '/tools/buildbot/bin/python'} 23:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:52 INFO - Downloading/unpacking jsonschema 23:27:52 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:27:52 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:27:52 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:27:52 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:27:52 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:27:52 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:27:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:27:54 INFO - Downloading/unpacking functools32 (from jsonschema) 23:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 INFO - Downloading functools32-3.2.3-2.tar.gz 23:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:27:54 INFO - warning: no files found matching '*.txt' 23:27:54 INFO - no previously-included directories found matching 'build' 23:27:54 INFO - no previously-included directories found matching 'dist' 23:27:54 INFO - no previously-included directories found matching '.git*' 23:27:55 INFO - Installing collected packages: jsonschema, functools32 23:27:55 INFO - Running setup.py install for functools32 23:27:55 INFO - warning: no files found matching '*.txt' 23:27:55 INFO - no previously-included directories found matching 'build' 23:27:55 INFO - no previously-included directories found matching 'dist' 23:27:55 INFO - no previously-included directories found matching '.git*' 23:27:55 INFO - Successfully installed jsonschema functools32 23:27:55 INFO - Cleaning up... 23:27:55 INFO - Return code: 0 23:27:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:27:55 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:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:55 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:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:27:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e64449f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', '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:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:27:55 INFO - Using env: {'DISPLAY': ':0', 23:27:55 INFO - 'HOME': '/home/cltbld', 23:27:55 INFO - 'LANG': 'en_US.UTF-8', 23:27:55 INFO - 'LANGUAGE': 'en_US:en', 23:27:55 INFO - 'LOGNAME': 'cltbld', 23:27:55 INFO - 'MAIL': '/var/mail/cltbld', 23:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:27:55 INFO - 'MOZ_NO_REMOTE': '1', 23:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:27:55 INFO - 'NO_EM_RESTART': '1', 23:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:27:55 INFO - 'PWD': '/builds/slave/test', 23:27:55 INFO - 'SHELL': '/bin/bash', 23:27:55 INFO - 'SHLVL': '1', 23:27:55 INFO - 'TERM': 'linux', 23:27:55 INFO - 'TMOUT': '86400', 23:27:55 INFO - 'USER': 'cltbld', 23:27:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:27:55 INFO - '_': '/tools/buildbot/bin/python'} 23:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:27:55 INFO - Downloading/unpacking flake8 23:27:55 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:27:55 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:27:55 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:27:55 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:27:55 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:27:55 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:27:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:27:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:27:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 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:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:27:58 INFO - no previously-included directories found matching 'docs/_build' 23:27:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:27:58 INFO - Running setup.py install for pep8 23:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:27:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:27:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:27:58 INFO - no previously-included directories found matching 'docs/_build' 23:27:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:27:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:27:58 INFO - Cleaning up... 23:27:58 INFO - Return code: 0 23:27:58 INFO - Running post-action listener: _resource_record_post_action 23:27:58 INFO - Running post-action listener: _start_resource_monitoring 23:27:58 INFO - Starting resource monitoring. 23:27:58 INFO - ##### 23:27:58 INFO - ##### Finished create-virtualenv step (success) 23:27:58 INFO - ##### 23:27:58 INFO - ##### 23:27:58 INFO - ##### Running install step. 23:27:58 INFO - ##### 23:27:58 INFO - Running pre-action listener: _resource_record_pre_action 23:27:58 INFO - Running main action method: install 23:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:27:58 INFO - Reading from file tmpfile_stdout 23:27:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:27:58 INFO - Reading from file tmpfile_stdout 23:27:58 INFO - Output received: 23:27:58 INFO - Usage: mozinstall [options] installer 23:27:58 INFO - Options: 23:27:58 INFO - -h, --help show this help message and exit 23:27:58 INFO - -d DEST, --destination=DEST 23:27:58 INFO - Directory to install application into. [default: 23:27:58 INFO - "/builds/slave/test"] 23:27:58 INFO - --app=APP Application being installed. [default: firefox] 23:27:58 INFO - mkdir: /builds/slave/test/build/application 23:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:28:15 INFO - Reading from file tmpfile_stdout 23:28:15 INFO - Output received: 23:28:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:28:15 INFO - Running post-action listener: _resource_record_post_action 23:28:15 INFO - ##### 23:28:15 INFO - ##### Finished install step (success) 23:28:15 INFO - ##### 23:28:15 INFO - ##### 23:28:15 INFO - ##### Running run-tests step. 23:28:15 INFO - ##### 23:28:15 INFO - Running pre-action listener: _resource_record_pre_action 23:28:15 INFO - Running main action method: run_tests 23:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:28:15 INFO - Python 2.7.3 23:28:15 INFO - Return code: 0 23:28:15 INFO - grabbing minidump binary from tooltool 23:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:28:15 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 0x29689c0>, '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 0x29698c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2969d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:28:15 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:28:15 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:28:15 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:28:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:28:15 INFO - Return code: 0 23:28:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:28:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:28:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:28:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:28:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:28:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:28:16 INFO - Return code: 0 23:28:16 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:28:16 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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:28:16 INFO - Using env: {'DISPLAY': ':0', 23:28:16 INFO - 'HOME': '/home/cltbld', 23:28:16 INFO - 'LANG': 'en_US.UTF-8', 23:28:16 INFO - 'LANGUAGE': 'en_US:en', 23:28:16 INFO - 'LOGNAME': 'cltbld', 23:28:16 INFO - 'MAIL': '/var/mail/cltbld', 23:28:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:28:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:28:16 INFO - 'MOZ_NO_REMOTE': '1', 23:28:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:28:16 INFO - 'NO_EM_RESTART': '1', 23:28:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:28:16 INFO - 'PWD': '/builds/slave/test', 23:28:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:28:16 INFO - 'SHELL': '/bin/bash', 23:28:16 INFO - 'SHLVL': '1', 23:28:16 INFO - 'TERM': 'linux', 23:28:16 INFO - 'TMOUT': '86400', 23:28:16 INFO - 'USER': 'cltbld', 23:28:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723', 23:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:28:16 INFO - '_': '/tools/buildbot/bin/python'} 23:28:16 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/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:28:16 INFO - mozversion application_buildid: 20160518203028 23:28:16 INFO - mozversion application_changeset: eb54f97ddfd410d426df5989a8ddd962d97bee44 23:28:16 INFO - mozversion application_display_name: Nightly 23:28:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:28:16 INFO - mozversion application_name: Firefox 23:28:16 INFO - mozversion application_remotingname: firefox 23:28:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:28:16 INFO - mozversion application_vendor: Mozilla 23:28:16 INFO - mozversion application_version: 49.0a1 23:28:16 INFO - mozversion platform_buildid: 20160518203028 23:28:16 INFO - mozversion platform_changeset: eb54f97ddfd410d426df5989a8ddd962d97bee44 23:28:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:28:16 INFO - mozversion platform_version: 49.0a1 23:28:16 INFO - using testdate: 1463639296 23:28:16 INFO - actual date: 1463639296 23:28:16 INFO - starting webserver on 'localhost:43443' 23:28:16 INFO - SUITE-START | Running 2 tests 23:28:16 INFO - TEST-START | dromaeo_css 23:28:16 INFO - operating with platform_type : linux_ 23:28:16 INFO - Initialising browser for dromaeo_css test... 23:28:16 INFO - TEST-INFO | started process 3272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0pijhg/profile http://localhost:43443/getInfo.html) 23:28:21 INFO - PROCESS | 3272 | __metrics Screen width/height:1600/1200 23:28:21 INFO - PROCESS | 3272 | colorDepth:24 23:28:21 INFO - PROCESS | 3272 | Browser inner width/height: 1024/697 23:28:21 INFO - PROCESS | 3272 | __metrics 23:28:22 ERROR - PROCESS | 3272 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:28:23 INFO - TEST-INFO | 3272: exit 0 23:28:23 INFO - Browser initialized. 23:28:23 INFO - Running cycle 1/1 for dromaeo_css test... 23:28:23 INFO - TEST-INFO | started process 3354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0pijhg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:35 INFO - PROCESS | 3354 | RSS: Main: 152678400 23:28:35 INFO - PROCESS | 3354 | 23:29:26 INFO - PROCESS | 3354 | 1463639366542 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:31:34 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43443/tests/dromaeo/cssquery-ext.html) 23:31:35 INFO - PROCESS | 3354 | RSS: Main: 257916928 23:31:35 INFO - PROCESS | 3354 | 23:34:37 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-ext.html (next: http://localhost:43443/tests/dromaeo/cssquery-jquery.html) 23:34:38 INFO - PROCESS | 3354 | RSS: Main: 238829568 23:34:38 INFO - PROCESS | 3354 | 23:37:40 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43443/tests/dromaeo/cssquery-mootools.html) 23:37:40 INFO - PROCESS | 3354 | RSS: Main: 245301248 23:37:40 INFO - PROCESS | 3354 | 23:40:42 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43443/tests/dromaeo/cssquery-prototype.html) 23:40:43 INFO - PROCESS | 3354 | RSS: Main: 230637568 23:40:43 INFO - PROCESS | 3354 | 23:43:45 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43443/tests/dromaeo/cssquery-yui.html) 23:43:46 INFO - PROCESS | 3354 | RSS: Main: 225533952 23:43:46 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43443/tests/dromaeo/cssquery-yui.html (next: http://localhost:43443/tests/dromaeo/cssquery-dojo.html) 23:46:49 INFO - PROCESS | 3354 | RSS: Main: 260968448 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | __start_tp_report 23:46:49 INFO - PROCESS | 3354 | _x_x_mozilla_page_load 23:46:49 INFO - PROCESS | 3354 | _x_x_mozilla_page_load_details 23:46:49 INFO - PROCESS | 3354 | |i|pagename|runs| 23:46:49 INFO - PROCESS | 3354 | |0;dojo.html;3113.4862747646653;3118.9532157017643;3141.340318533108;3157.1317887580926;3175.079227024163;5318.601104917137;5345.278387417698;5393.2449457075945;5431.375391829941;5450.5367043801325;5444.727763611823;5454.781808727646;5458.536024437918;5502.504774570288;5529.695866727328;4901;4903.3625628668315;5129.435762066169;5176.611754118438;5206.088934436478;5095.108356037697;5096;5124.820631277906;5161.922571161435;5163.173892177252;4879.414470263556;4884.340614017134;4909.091818013661;4940.950590494103;4969.726665033421;4873.074115917964;4881.487443818419;4938.037082768861;4961.8511444656715;4987.077390682735;4886.975565122188;4907.2393778964315;4915.213565829486;4931.610300437688;4978.5270399312;5396.973015134939;5402.945970540283;5473.534749546293;5558.666480011172;5562.499375056264;5890.352061273256;5980.252468441445;6001.849953751147;6002;6011.12838638395;5675.120356344773;5859.121131830217;5887.941120588782;5937.703114844284;6016;5532.6680399176175;5541.6674999499755;5571.637843540157;5586.804461843816;5593.972030139823;6071.908921366183;6082.68256780024;6083.798352408627;6086.478380404898;6091;5555.250041244381;5737.110747834009;5761.942380576224;5792.1311803229855;5888.087346461305;5881.470667639933;5904.261967254093;5917.940820591825;5961.076033214858;5980.162777211194;5849.2103566018895;5857.560682948796;5870.941290587125;5888.470037696542;5896.233489646319;5644.463775941279;5817.825465236049;5839.240898683229;5880.353161152269;5894.852628684232;4416.138852923713;4456.331550267486;4458.353538736865;4461.910761784811;4485.25993211123;3864.806759662006;3966.2662407454714;3982.980085099556;3991.241664083873;4025.2150830587752;5393.919091213635;5430.266913966643;5442.972785136049;5446;5481.835544933659;5826.854328641818;5829.213056237354;5833.82498525045;5838;5838.620489668158;5367.838964831061;5424.267723857308;5428.647137936022;5448.754806033738;5452.1276595745285;5015;5063.0380227756605;5074.06129865976;5075.086484432763;5087.084324821493;6045.063015232646;6051;6055.8183254501555;6058.333583305833;6060.090986351995;5681.005823980704;5878.764849405976;5903.321118071477;5943.346231914399;5946;6000.21997140369;6092.598375241104;6103.367974696828;6105.603180519319;6112.442689633966;5797.594168408171;5828.446297601721;5835.9708201458725;5840.678762668094;5895.233619629421;5677.517411019944;5901.409859014064;5946.613470124428;5956.136360227656;5993.460588547052;5890.381509941394;5890.676012819336;5895.322037965689;5899.262592175978;5939.4951429129005;5880.764769409176;5890.204822349099;5892.558058145571;5897.144913987534;5898.144769008384;5535.972320138373;5539.307586551681;5555.666660000413;5583.832485025456;5779.913301300399;5757.798477053283;5810.273715785527;5813.651180928989;5816.709164541671;5822.70886455667;5589.608727389043;5630.493255606852;5650;5650.604457688087;5657.773689052392 23:46:49 INFO - PROCESS | 3354 | |1;ext.html;603.7403916315985;633.2527617411454;643.0450780590821;650.5413683353235;659.3933581105382;44662.776686116566;45950.08099838006;45982.540174598245;46040.539594604044;51012.48987510124;44956.775216123955;45282.54717452825;45516.77241613796;45561;45563.31655025177;8739.825203495926;8841.204291613754;8904.421212621159;8910.465372077664;8913.955430222839;8857.557122143899;8883.777905552348;8928.508932008737;8955.41789783662;8956.462612243286;8982.461052336848;9006.459612423243;9020.41367311126;9022.052684468135;9036.77408064797;8913.153250441197;8942.597583108743;8975.910240897638;8986.281097512216;8998.415103018282;8790.077041910572;8888.644454221823;8892.110788921122;8899.110088991049;8901.154390332907;41368.37947430791;41707;41720.37419438711;41734;41820.372694409605;3682;3822.2737679840743;3875.360565506688;3920.0787814863484;4197.97901010496;31903.202419939687;32840.178995525064;33124;33249.6675033249;33930.83034584836;4310.202612516695;4340.6093451589195;4450.132224216279;4463.8214471421425;4467.218236808546;216106;216509;217212;217706;218836;36021.459678104846;36814.8159259202;57944.42055579474;59196;59215.70392148012;38875.22249555049;38974.80512597419;38980.41529377062;39012.609873900896;39055.2188956225;14376.28118594087;14531.78202326966;14534.709305813825;14536.927315363568;14537.273136343141;11443.427828608535;11486.253393529561;11491.54033838637;11492.25300355491;11493.367864767519;8790.648374065093;8805.603747831363;8805.603747831363;8819.514926678967;8920.73237802854;3331;3342.983285083608;3362.327534493111;3379.881704140343;3409.7954122752712;1080.4975686305906;1110.3948348150277;1111.1666250312267;1157.560127151694;1219.2136072233536;34046.82976585151;34347;34540.595889213255;34710.826445867606;34905.12737181591;1129.3957732613176;1176.4941075337688;1186.7863784518697;1238.38699843578;1251.6370252626637;17619.647607047787;17865.37471188528;17888.642227155386;18119.275228990955;18147;564729;570785;571256;577487;579510;59479.70260148758;60485;60864.39135608587;60985;61010;1322.24631959782;1403.677154254527;1418.2199790115396;1443.1485423599916;1446.320229492158;33721.81973630911;35386.646133538336;35409.64590354166;35464;35815.46276805798;51133.23300150426;51404.48595513997;51938.74030629974;51968.74015630049;51984.74007629938;370773;371989;372096;372274;372607;25801.612975805754;28059.57910631383;28609.427811443238;28903.710962890942;30392;48936.26595600998;50165.74917125391;50579;51188.232176518126;51298;42066.36900446557;42241;42481.787591061846;43082;43998.78000609976;41124.38313425241;42244.788776057154;42309.57690423056;43361.34957975696;43710.56289437065;42111;42435.787821060694;43552;43750.12499749923;43760.781196095086;37001.25997479982;37086.814565927;37813.62186378211;38064.61935380722;38326.80836595799;28941.56587651229;29063;29434.411311774074;29588.556171657874;29660.851695742247 23:46:49 INFO - PROCESS | 3354 | |2;jquery.html;413.2520138549228;414.80089557012633;420.77909097723693;423.08402309001013;430.5070694055307;18158.909205453972;18967.715484267712;19589.804101958995;19826.70259946102;20275.898620506912;18446.169922353492;18540.629187416278;18635.813641863577;18694.15876285567;19369.322073727424;5573.526250268722;5626.887462250753;5757.539396848242;5764.452377024176;5768.105943578752;5600.103983362663;5632.802851900185;5645.040343141655;5655.8586035349035;5659.490645841874;5503.724813759316;5773.682447465388;5811.593188476808;5893.292804863422;5894.528437724993;5735.627184233053;5753.626014309078;5839.065749480105;5844.795432159875;6262.780802671885;5603.775848966077;5637.8590535236535;5644.266245388114;5655.236543066716;5659.660420374749;13808;17994.640107197913;19762.70355944662;21746.673799893015;22357.329280121623;2366.7041619797524;2514.3085651445817;2844.1041072062235;3021.1993821637284;3071.1861356740483;9844.212463002943;10150.187984961185;10214.233932455021;10326.845097323547;10479.633212837514;1921.9039048047541;1929.3440230321617;1933.3426634944046;1937.7577802774654;1939.4278687787137;79289;80558.59720701417;84347;85976.14023859806;86460.56769716174;10829.67510974672;11086.445677716081;11139.275947063577;11245.381504017358;11480.885191147981;15715.607109822116;15824.683506330039;15888.443904463289;15895;15905;7572.962135189288;7844.176361481962;7894.960525197452;8001;8081.030276366873;7189.820254493679;7281.672324745399;7405.8889116663295;7443.292887175709;7466.328030477283;4769.189237829577;4837.153498137812;4903.705777653352;4912.95087049125;4916.139675556763;1964.5579744557647;1973.9111739971736;1994.5412555112405;2029.1883246701439;2092.309537852505;970.8301047316692;1062.4953147254992;1082.1883587309517;1100.1748688483638;1104.9834152579647;17849.910750446164;18598.53503662392;18707.906460467882;19215.615687686448;19620.313289034817;997.0876647867266;1014.3609525998721;1016.1667432705111;1057.7567159553346;1102.0577406317643;10093.747656308504;10675;10721.35671859691;10721.571137154426;10780.676579702622;462430;469570;481975;488765;493355;95065;98439.50780246196;98491.50754246183;99388;99611.50194248982;1029.7013865978781;1041.0422411381546;1082.870055593318;1090.547422819537;1117.6423544465856;16456;16488.17559122015;16642.251098700828;16746.24641891142;16866.494005179866;31807.84096079505;38862.61137388703;40405.1918961625;40626;41446;55033;55487.72256138694;56632.73469061191;56900;56940;7155.821104472429;8531.36014798905;8689.435186712843;8911.287097032351;8977.865332020156;11520.135989800967;12786.424610892345;12994.415251313525;13235.205887646773;13329.133606315558;6095.1466794647895;8367.665293388196;11454.568178977628;11614.825777613512;11676.532938682698;11396.829047564128;11528.365939873052;11665.825012624988;11744.823827642422;11841.763164736485;11559.190856639954;11856.170068095496;11958.282503049844;12010.159288849696;12116.575919842764;7771.106322772727;7784.610769461618;7920.881186782318;7957.8408431832195;8033.718819841278;11452.255603385753;11586.478608462809;11686.415679215836;11728.882711172779;11863.110266730202 23:46:49 INFO - PROCESS | 3354 | |3;mootools.html;1374.5944946240859;1512.2892240646895;1563.515310253821;1698.464983530188;1851.3982955539445;8806;9223.354365194438;9231.723048308553;9248.121428464301;9264.58309376078;8979.910200898006;9147.31395145365;9160.770980725485;9161.450312981226;9167;2320.1879342230254;2354.281944007077;2354.5173239485866;2354.72920614129;2355.5406695694346;2291.8395712300144;2331.25399872041;2351.353377821096;2351.49442869783;2351.8471299365574;2313.5372925414986;2333.4399744061475;2341.566810140121;2342.9531409371803;2345.1440224318085;2254.740704818934;2287.5196208796174;2288.0390236100793;2295.2196253273883;2302.5510025545027;2259.53679495703;2264.5810525052916;2267.0591704442636;2267.614505534063;2272.1706577099403;8745.956270218672;8955.46267223962;8959.328050396247;9079.7276081717;9143.817123657556;5276.3140791697215;5380.865478363033;5383.031054410205;5386.946130538684;5406.945930540684;3407.9488807667904;3426.5716785401823;3466.4107101792756;3533.3110043541265;3555.253396786678;1052.3633201912885;1078.4230436716398;1114.6878873915316;1117.1230583991528;1134.563193170627;12926.935365323206;13044.673883152902;13052.543160989415;13054.477820887058;13055.15141515808;4586.105709386704;4679.181143299977;4776.21192503233;4780.808767649325;4784.497627749106;10132.442715650563;10135;10152.898471015344;10172;10179.083882450615;5429.864253393696;5430.755615997289;5439.700816455053;5442.700651464128;5444.428335024844;4426.601605855489;4845.6123510119105;5000.1249781288125;5020.3724534433195;5022.271770593316;3862.729608927348;3869.245497128033;3936.5472970608175;3945.7040721945395;3992.181602771425;1145.6219447582444;1157.479134389528;1162.953481860716;1168.7136651520261;1196.1148749924994;716.5521549031855;893.7274131389859;969.7236287657984;993.3046867192994;993.8509223616371;5598.86002849932;6003.429674180946;6013.850443194182;6110.908336374958;6125.264968203844;469.66614813928607;478.1154863502492;485.15825043549415;488.0312579529631;651.371426573359;3921.8627348042683;4086.570910054461;4136.379543068504;4140.171965606891;4149.834006639761;11620.709482262842;12092.214006089576;12136.211146275464;12151.453184606715;12233.082518811125;11204.271722338022;11701.765964680659;12022.579209727617;12025.579104731292;12026;8773.956130219309;8937.374383793202;8966.910330896739;9019.503927284062;9036.548172591343;6343.682815859096;6591.143151390289;6608.8347791305605;6640.867182656417;6708.22855371619;10575.259731818698;10746.086582640562;11043.447827608748;11046.558137674403;11122.388268645302;10598.841017384899;10609.310394824312;10689.465526723789;10742.19433542503;10765.623203188165;7917.208279172037;8057.677692892219;8132.105468398353;8154.836903261783;8160.224778646019;8709.738707838775;8744.825103497767;8746.256568191775;8760.4305720128;8767.298616110824;7900.367970562226;7957.283844454027;7974.48165869225;8020.839583208186;8084.878726818984;7643.464957452925;7672.424568157299;7851.05787305527;7898.842023159619;8017.719379821679;7279.59962202084;7336.37640800538;7519.172890982097;7525.887111693439;7531.774046778605;5115.462876397924;5129.076766182123;5209.166533354645;5289.68261904287;5322.813701520428;5144.819931302386;5179.300794392709;5247;5276.894462110813;5385.838424847261 23:46:49 INFO - PROCESS | 3354 | |4;prototype.html;332.1215385305866;339.1085732104226;341.5116383571493;348.84127721886546;351.337728382;5347.759350829212;5388.91916621251;5403.378611459683;5421.674699518032;5440.3743569489525;5101.336826212587;5190.2474141249595;5211.42674305826;5237.659552129109;5350;4132.876013719586;4201.857052903026;4210.7473551586845;4215.49414070312;4226.619604235618;4127.669786417079;4160.292750232467;4162.666986641077;4211.347241177607;4248.9575104249025;4102.077032667656;4161.916761664765;4184.99560105574;4210;4220.324748040314;4165.895852603679;4172.040430700926;4186.3092589722655;4192.4759405074365;4211.642010429117;3694.353488139565;3694.612065733086;3704.370257056307;3716.256748650254;3722.7952462614544;4974.801007959677;5135.332406787131;5178.948210517884;5182.015417070745;5183.455737147583;4714.740689262089;4745.501722319176;4779.2077970760965;4783.784729687138;4808.447028591721;5563.415841336642;5573.54763903885;5584.720763961826;5585.385607583163;5604.514803577055;3853.075261937143;4008.4388185654034;4036.233115708006;4040.3636527206527;4089.631933126033;5772.682502462363;5777.220075289824;5787.572507032124;5808.834185368984;5817.156512305734;4049.311617025113;4065.4511640928094;4081.653059489977;4086.3053280942313;4096.3855421686985;4017.2367250222946;4155.667546596325;4156.127213285184;4165;4169.56219596944;4733.621310295237;4758.904821903612;4768.165571025057;4796.5203479651755;4844.588210002119;5556.666600003932;5558.360788509292;5561.805336813192;5659.236003139606;5677.432256774289;1349.9730005400033;1389.423389293432;1444.3139508733477;1473.6168596165073;1473.9166712466329;927.452802846324;973.5639931101568;975.3903810118676;980.4950450517989;984.5274268351232;4842.159979207879;4853.490383509751;4854.296127061556;4863.294822250754;4903.877403064952;5122.692638441706;5150.690958542499;5155.278261043457;5157.4584668610005;5177;4548.4541854977615;4852.1508735971065;4852.2479015752615;4871.878203044952;4888.975555122272;2720.5103081445136;2723.9727602724115;2725.604787305869;2730.2491814750706;2732.7540521353176;5167.405748338989;5194.506521880416;5194.740262986836;5201.661891977085;5206.557442617344;4748.9606651742915;5207.71357575337;5230.372355317386;5242.318498595158;5242.7378631068295;5205.20020385121;5210.921836172461;5281.234221037928;5301.6818990860675;5320.627556071116;4793.736344501086;5061.898762024813;5085.694858308513;5123.052235336475;5127.256547800623;4965.230389289666;4974.975125124496;4979.3526841510375;5066.4680208577565;5088.720120393414;5189.195674670432;5203.907179492349;5241.50205730455;5253.343332083489;5270.920936185884;3736.2527494500664;3791.374423220138;3821.2739579479808;3826.770393776382;3857.71067169969;5375.892482150413;5626.85932851682;5690.715464226855;5841.9707901461925;5887.41125887425;5650.519705825051;5664.575156863334;5674.404187560247;5684;5687.886242275049;5533.889322213614;5701.287339082614;5702.8289151325525;5711.144427786107;5721.799737009184;5574.386817450159;5575.219469274224;5581.162825576196;5589.55283577321;5592.944070559242;5645.520130788929;5655.981923253854;5658.349289831722;5682.460166284196;5701.4298570142655;5421.783128674967;5522.447755224445;5538.833834984957;5552.139418390156;5584.748686309044 23:46:49 INFO - PROCESS | 3354 | |5;yui.html;770.2605498721227;830.7466222802043;838.9622466988985;842.132603418479;878.7188099808056;15185.696286074271;15352.923235383822;16119.91940040301;16129.516114516555;16150.192490375493;14873;14968.850311496883;15007.399704011854;15009.09945403274;15042.247887605603;688.2016860441888;807.4670717326566;822.6627082896014;827.4580150001758;831.9792005199873;830.8587540118165;835.7450977451874;837.5602808525512;838.3502785341349;839.5508403004394;885.8006948436582;886.5478605910968;888.320434867327;889.030956257679;889.2308153447286;715.8067321823105;730.9853802923965;731.3892899428984;856.2465030772943;879.0813599788205;642.1363266406722;646.6314200905485;646.6475770704977;646.7380710812129;647.2007071266981;15114.244287785566;15139.54581362561;15189.468368607157;15284.541463756104;15333.693326133527;13887.166769993833;14628.634284142876;14703.852961470355;14756.48352307664;14761.852381476156;12415.503379864795;12688.429020694091;12696.238225706487;12739.55411560591;12759.553415630407;4570.588647021784;4580.679352445331;4721.079389519045;4748.762561871893;4769.117713223065;62890.37109628891;62979;63088.684556577384;64331.67834160846;64429.67785161091;11175.888241117485;11190.934934456529;11195.832062519068;11326.773464530663;11396.14528910335;21157.68263476049;21469.46326341854;21474.785252147278;21482.78517214839;21494.14023439076;8305.21100495464;8405;8410.747677569683;8619.310455163572;8744.91255087441;4688.484266730657;4702.670813043054;4729.834455794031;4841.12859685253;5100.846974590768;3530.1880567469625;3625.5830579483695;3627.183883626163;3633.2733453309443;3637.4725664778457;664.4219977553311;671.4695390641436;677.4986509982676;681.1859827506082;687.7558466744334;614.8647297594522;657.575863567996;711.548166914003;726.1939247435342;742.9591372474566;9682.225421966226;9712.514374281258;9748.756281093029;9752.317337786288;9820.852687209697;689.5965859971873;741.1439787045971;764.4686942574857;771.0477560213133;776.5263189454429;4567.36056952027;4657.208274593328;4698.083873644607;4706.717596944194;4751.976240118777;71990.64004679942;73293.26706732971;77360.61319693478;77611.61194193993;78964.6051769749;62628.06057909135;62642;67098.66450667716;67102;68267.3173268261;26978.32554186161;27117.593236101475;52754.73622631862;59276.70361648164;59313.80337636459;9966.750831229278;10180.796384072426;10224.59101635956;10438.68683939483;10455.268131230741;37741.4338784924;37945.81027094957;38138.61861381351;38408.80795596116;38424.6157538421;48671.51328486812;49730.502694974035;50231;50269.497305027944;51247;12814.615561533168;12882.742345153232;12986.675333116747;13070.150440221356;13340.799888001493;14385.000647210556;14559.27203639835;14886.404543818126;15002.174880381684;15111;13509.459621615419;13651.180929144282;13818.930905345409;13840.653983650087;14393.496227631982;13119;13670.726585468434;13679.31603419845;14040.227787471378;14063.789043164155;12425;12595.68510787201;12622.305773182563;12708.745825083632;12947.417366218355;11360.602378916697;11609.129315301218;11617.477213525242;11621.593244236412;11888.702782430508;11433.056380415183;11548.769024619629;11755.941220294186;11787.941060294643;11890.583829565923 23:46:49 INFO - PROCESS | 3354 | __end_tp_report 23:46:49 INFO - PROCESS | 3354 | __start_cc_report 23:46:49 INFO - PROCESS | 3354 | _x_x_mozilla_cycle_collect,885 23:46:49 INFO - PROCESS | 3354 | __end_cc_report 23:46:49 INFO - PROCESS | 3354 | __startTimestamp1463640409323__endTimestamp 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | ------- Summary: start ------- 23:46:49 INFO - PROCESS | 3354 | Number of tests: 6 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#0] dojo.html Cycles:165 Average:5456.60 Median:5644.46 stddev:639.08 (11.3%) stddev-sans-first:614.04 23:46:49 INFO - PROCESS | 3354 | Values: 3113.5 3119.0 3141.3 3157.1 3175.1 5318.6 5345.3 5393.2 5431.4 5450.5 5444.7 5454.8 5458.5 5502.5 5529.7 4901.0 4903.4 5129.4 5176.6 5206.1 5095.1 5096.0 5124.8 5161.9 5163.2 4879.4 4884.3 4909.1 4941.0 4969.7 4873.1 4881.5 4938.0 4961.9 4987.1 4887.0 4907.2 4915.2 4931.6 4978.5 5397.0 5402.9 5473.5 5558.7 5562.5 5890.4 5980.3 6001.8 6002.0 6011.1 5675.1 5859.1 5887.9 5937.7 6016.0 5532.7 5541.7 5571.6 5586.8 5594.0 6071.9 6082.7 6083.8 6086.5 6091.0 5555.3 5737.1 5761.9 5792.1 5888.1 5881.5 5904.3 5917.9 5961.1 5980.2 5849.2 5857.6 5870.9 5888.5 5896.2 5644.5 5817.8 5839.2 5880.4 5894.9 4416.1 4456.3 4458.4 4461.9 4485.3 3864.8 3966.3 3983.0 3991.2 4025.2 5393.9 5430.3 5443.0 5446.0 5481.8 5826.9 5829.2 5833.8 5838.0 5838.6 5367.8 5424.3 5428.6 5448.8 5452.1 5015.0 5063.0 5074.1 5075.1 5087.1 6045.1 6051.0 6055.8 6058.3 6060.1 5681.0 5878.8 5903.3 5943.3 5946.0 6000.2 6092.6 6103.4 6105.6 6112.4 5797.6 5828.4 5836.0 5840.7 5895.2 5677.5 5901.4 5946.6 5956.1 5993.5 5890.4 5890.7 5895.3 5899.3 5939.5 5880.8 5890.2 5892.6 5897.1 5898.1 5536.0 5539.3 5555.7 5583.8 5779.9 5757.8 5810.3 5813.7 5816.7 5822.7 5589.6 5630.5 5650.0 5650.6 5657.8 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#1] ext.html Cycles:180 Average:55198.52 Median:41777.19 stddev:110386.39 (264.2%) stddev-sans-first:110619.95 23:46:49 INFO - PROCESS | 3354 | Values: 603.7 633.3 643.0 650.5 659.4 44662.8 45950.1 45982.5 46040.5 51012.5 44956.8 45282.5 45516.8 45561.0 45563.3 8739.8 8841.2 8904.4 8910.5 8914.0 8857.6 8883.8 8928.5 8955.4 8956.5 8982.5 9006.5 9020.4 9022.1 9036.8 8913.2 8942.6 8975.9 8986.3 8998.4 8790.1 8888.6 8892.1 8899.1 8901.2 41368.4 41707.0 41720.4 41734.0 41820.4 3682.0 3822.3 3875.4 3920.1 4198.0 31903.2 32840.2 33124.0 33249.7 33930.8 4310.2 4340.6 4450.1 4463.8 4467.2 216106.0 216509.0 217212.0 217706.0 218836.0 36021.5 36814.8 57944.4 59196.0 59215.7 38875.2 38974.8 38980.4 39012.6 39055.2 14376.3 14531.8 14534.7 14536.9 14537.3 11443.4 11486.3 11491.5 11492.3 11493.4 8790.6 8805.6 8805.6 8819.5 8920.7 3331.0 3343.0 3362.3 3379.9 3409.8 1080.5 1110.4 1111.2 1157.6 1219.2 34046.8 34347.0 34540.6 34710.8 34905.1 1129.4 1176.5 1186.8 1238.4 1251.6 17619.6 17865.4 17888.6 18119.3 18147.0 564729.0 570785.0 571256.0 577487.0 579510.0 59479.7 60485.0 60864.4 60985.0 61010.0 1322.2 1403.7 1418.2 1443.1 1446.3 33721.8 35386.6 35409.6 35464.0 35815.5 51133.2 51404.5 51938.7 51968.7 51984.7 370773.0 371989.0 372096.0 372274.0 372607.0 25801.6 28059.6 28609.4 28903.7 30392.0 48936.3 50165.7 50579.0 51188.2 51298.0 42066.4 42241.0 42481.8 43082.0 43998.8 41124.4 42244.8 42309.6 43361.3 43710.6 42111.0 42435.8 43552.0 43750.1 43760.8 37001.3 37086.8 37813.6 38064.6 38326.8 28941.6 29063.0 29434.4 29588.6 29660.9 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#2] jquery.html Cycles:180 Average:28590.41 Median:2440.51 stddev:79291.66 (3249.0%) stddev-sans-first:79485.87 23:46:49 INFO - PROCESS | 3354 | Values: 413.3 414.8 420.8 423.1 430.5 18158.9 18967.7 19589.8 19826.7 20275.9 18446.2 18540.6 18635.8 18694.2 19369.3 5573.5 5626.9 5757.5 5764.5 5768.1 5600.1 5632.8 5645.0 5655.9 5659.5 5503.7 5773.7 5811.6 5893.3 5894.5 5735.6 5753.6 5839.1 5844.8 6262.8 5603.8 5637.9 5644.3 5655.2 5659.7 13808.0 17994.6 19762.7 21746.7 22357.3 2366.7 2514.3 2844.1 3021.2 3071.2 9844.2 10150.2 10214.2 10326.8 10479.6 1921.9 1929.3 1933.3 1937.8 1939.4 79289.0 80558.6 84347.0 85976.1 86460.6 10829.7 11086.4 11139.3 11245.4 11480.9 15715.6 15824.7 15888.4 15895.0 15905.0 7573.0 7844.2 7895.0 8001.0 8081.0 7189.8 7281.7 7405.9 7443.3 7466.3 4769.2 4837.2 4903.7 4913.0 4916.1 1964.6 1973.9 1994.5 2029.2 2092.3 970.8 1062.5 1082.2 1100.2 1105.0 17849.9 18598.5 18707.9 19215.6 19620.3 997.1 1014.4 1016.2 1057.8 1102.1 10093.7 10675.0 10721.4 10721.6 10780.7 462430.0 469570.0 481975.0 488765.0 493355.0 95065.0 98439.5 98491.5 99388.0 99611.5 1029.7 1041.0 1082.9 1090.5 1117.6 16456.0 16488.2 16642.3 16746.2 16866.5 31807.8 38862.6 40405.2 40626.0 41446.0 55033.0 55487.7 56632.7 56900.0 56940.0 7155.8 8531.4 8689.4 8911.3 8977.9 11520.1 12786.4 12994.4 13235.2 13329.1 6095.1 8367.7 11454.6 11614.8 11676.5 11396.8 11528.4 11665.8 11744.8 11841.8 11559.2 11856.2 11958.3 12010.2 12116.6 7771.1 7784.6 7920.9 7957.8 8033.7 11452.3 11586.5 11686.4 11728.9 11863.1 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#3] mootools.html Cycles:180 Average:6017.62 Median:2629.46 stddev:3552.74 (135.1%) stddev-sans-first:3545.57 23:46:49 INFO - PROCESS | 3354 | Values: 1374.6 1512.3 1563.5 1698.5 1851.4 8806.0 9223.4 9231.7 9248.1 9264.6 8979.9 9147.3 9160.8 9161.5 9167.0 2320.2 2354.3 2354.5 2354.7 2355.5 2291.8 2331.3 2351.4 2351.5 2351.8 2313.5 2333.4 2341.6 2343.0 2345.1 2254.7 2287.5 2288.0 2295.2 2302.6 2259.5 2264.6 2267.1 2267.6 2272.2 8746.0 8955.5 8959.3 9079.7 9143.8 5276.3 5380.9 5383.0 5386.9 5406.9 3407.9 3426.6 3466.4 3533.3 3555.3 1052.4 1078.4 1114.7 1117.1 1134.6 12926.9 13044.7 13052.5 13054.5 13055.2 4586.1 4679.2 4776.2 4780.8 4784.5 10132.4 10135.0 10152.9 10172.0 10179.1 5429.9 5430.8 5439.7 5442.7 5444.4 4426.6 4845.6 5000.1 5020.4 5022.3 3862.7 3869.2 3936.5 3945.7 3992.2 1145.6 1157.5 1163.0 1168.7 1196.1 716.6 893.7 969.7 993.3 993.9 5598.9 6003.4 6013.9 6110.9 6125.3 469.7 478.1 485.2 488.0 651.4 3921.9 4086.6 4136.4 4140.2 4149.8 11620.7 12092.2 12136.2 12151.5 12233.1 11204.3 11701.8 12022.6 12025.6 12026.0 8774.0 8937.4 8966.9 9019.5 9036.5 6343.7 6591.1 6608.8 6640.9 6708.2 10575.3 10746.1 11043.4 11046.6 11122.4 10598.8 10609.3 10689.5 10742.2 10765.6 7917.2 8057.7 8132.1 8154.8 8160.2 8709.7 8744.8 8746.3 8760.4 8767.3 7900.4 7957.3 7974.5 8020.8 8084.9 7643.5 7672.4 7851.1 7898.8 8017.7 7279.6 7336.4 7519.2 7525.9 7531.8 5115.5 5129.1 5209.2 5289.7 5322.8 5144.8 5179.3 5247.0 5276.9 5385.8 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#4] prototype.html Cycles:180 Average:4547.44 Median:5112.01 stddev:1309.33 (25.6%) stddev-sans-first:1274.21 23:46:49 INFO - PROCESS | 3354 | Values: 332.1 339.1 341.5 348.8 351.3 5347.8 5388.9 5403.4 5421.7 5440.4 5101.3 5190.2 5211.4 5237.7 5350.0 4132.9 4201.9 4210.7 4215.5 4226.6 4127.7 4160.3 4162.7 4211.3 4249.0 4102.1 4161.9 4185.0 4210.0 4220.3 4165.9 4172.0 4186.3 4192.5 4211.6 3694.4 3694.6 3704.4 3716.3 3722.8 4974.8 5135.3 5178.9 5182.0 5183.5 4714.7 4745.5 4779.2 4783.8 4808.4 5563.4 5573.5 5584.7 5585.4 5604.5 3853.1 4008.4 4036.2 4040.4 4089.6 5772.7 5777.2 5787.6 5808.8 5817.2 4049.3 4065.5 4081.7 4086.3 4096.4 4017.2 4155.7 4156.1 4165.0 4169.6 4733.6 4758.9 4768.2 4796.5 4844.6 5556.7 5558.4 5561.8 5659.2 5677.4 1350.0 1389.4 1444.3 1473.6 1473.9 927.5 973.6 975.4 980.5 984.5 4842.2 4853.5 4854.3 4863.3 4903.9 5122.7 5150.7 5155.3 5157.5 5177.0 4548.5 4852.2 4852.2 4871.9 4889.0 2720.5 2724.0 2725.6 2730.2 2732.8 5167.4 5194.5 5194.7 5201.7 5206.6 4749.0 5207.7 5230.4 5242.3 5242.7 5205.2 5210.9 5281.2 5301.7 5320.6 4793.7 5061.9 5085.7 5123.1 5127.3 4965.2 4975.0 4979.4 5066.5 5088.7 5189.2 5203.9 5241.5 5253.3 5270.9 3736.3 3791.4 3821.3 3826.8 3857.7 5375.9 5626.9 5690.7 5842.0 5887.4 5650.5 5664.6 5674.4 5684.0 5687.9 5533.9 5701.3 5702.8 5711.1 5721.8 5574.4 5575.2 5581.2 5589.6 5592.9 5645.5 5656.0 5658.3 5682.5 5701.4 5421.8 5522.4 5538.8 5552.1 5584.7 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - PROCESS | 3354 | [#5] yui.html Cycles:180 Average:16348.36 Median:4693.28 stddev:19713.33 (420.0%) stddev-sans-first:19733.92 23:46:49 INFO - PROCESS | 3354 | Values: 770.3 830.7 839.0 842.1 878.7 15185.7 15352.9 16119.9 16129.5 16150.2 14873.0 14968.9 15007.4 15009.1 15042.2 688.2 807.5 822.7 827.5 832.0 830.9 835.7 837.6 838.4 839.6 885.8 886.5 888.3 889.0 889.2 715.8 731.0 731.4 856.2 879.1 642.1 646.6 646.6 646.7 647.2 15114.2 15139.5 15189.5 15284.5 15333.7 13887.2 14628.6 14703.9 14756.5 14761.9 12415.5 12688.4 12696.2 12739.6 12759.6 4570.6 4580.7 4721.1 4748.8 4769.1 62890.4 62979.0 63088.7 64331.7 64429.7 11175.9 11190.9 11195.8 11326.8 11396.1 21157.7 21469.5 21474.8 21482.8 21494.1 8305.2 8405.0 8410.7 8619.3 8744.9 4688.5 4702.7 4729.8 4841.1 5100.8 3530.2 3625.6 3627.2 3633.3 3637.5 664.4 671.5 677.5 681.2 687.8 614.9 657.6 711.5 726.2 743.0 9682.2 9712.5 9748.8 9752.3 9820.9 689.6 741.1 764.5 771.0 776.5 4567.4 4657.2 4698.1 4706.7 4752.0 71990.6 73293.3 77360.6 77611.6 78964.6 62628.1 62642.0 67098.7 67102.0 68267.3 26978.3 27117.6 52754.7 59276.7 59313.8 9966.8 10180.8 10224.6 10438.7 10455.3 37741.4 37945.8 38138.6 38408.8 38424.6 48671.5 49730.5 50231.0 50269.5 51247.0 12814.6 12882.7 12986.7 13070.2 13340.8 14385.0 14559.3 14886.4 15002.2 15111.0 13509.5 13651.2 13818.9 13840.7 14393.5 13119.0 13670.7 13679.3 14040.2 14063.8 12425.0 12595.7 12622.3 12708.7 12947.4 11360.6 11609.1 11617.5 11621.6 11888.7 11433.1 11548.8 11755.9 11787.9 11890.6 23:46:49 INFO - PROCESS | 3354 | -------- Summary: end -------- 23:46:49 INFO - PROCESS | 3354 | 23:46:49 INFO - TEST-INFO | 3354: exit 0 23:46:49 INFO - TEST-OK | dromaeo_css | took 1113297ms 23:46:49 INFO - TEST-START | kraken 23:46:49 INFO - operating with platform_type : linux_ 23:46:49 INFO - Initialising browser for kraken test... 23:46:49 INFO - TEST-INFO | started process 3540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgfZ1s/profile http://localhost:43443/getInfo.html) 23:46:54 INFO - PROCESS | 3540 | __metrics Screen width/height:1600/1200 23:46:54 INFO - PROCESS | 3540 | colorDepth:24 23:46:54 INFO - PROCESS | 3540 | Browser inner width/height: 1024/697 23:46:54 INFO - PROCESS | 3540 | __metrics 23:46:55 ERROR - PROCESS | 3540 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:46:55 INFO - TEST-INFO | 3540: exit 0 23:46:55 INFO - Browser initialized. 23:46:55 INFO - Running cycle 1/1 for kraken test... 23:46:55 INFO - TEST-INFO | started process 3621 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkgfZ1s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:47:07 INFO - PROCESS | 3621 | RSS: Main: 153051136 23:47:07 INFO - PROCESS | 3621 | 23:47:10 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43443/tests/kraken/driver.html?testName=audio-beat-detection) 23:47:11 INFO - PROCESS | 3621 | RSS: Main: 208691200 23:47:11 INFO - PROCESS | 3621 | 23:47:13 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43443/tests/kraken/driver.html?testName=audio-dft) 23:47:14 INFO - PROCESS | 3621 | RSS: Main: 197455872 23:47:14 INFO - PROCESS | 3621 | 23:47:17 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43443/tests/kraken/driver.html?testName=audio-fft) 23:47:18 INFO - PROCESS | 3621 | RSS: Main: 265543680 23:47:18 INFO - PROCESS | 3621 | 23:47:20 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43443/tests/kraken/driver.html?testName=audio-oscillator) 23:47:21 INFO - PROCESS | 3621 | RSS: Main: 174845952 23:47:21 INFO - PROCESS | 3621 | 23:47:23 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:47:23 INFO - PROCESS | 3621 | RSS: Main: 178757632 23:47:23 INFO - PROCESS | 3621 | 23:47:27 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43443/tests/kraken/driver.html?testName=imaging-darkroom) 23:47:27 INFO - PROCESS | 3621 | RSS: Main: 214847488 23:47:27 INFO - PROCESS | 3621 | 23:47:31 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43443/tests/kraken/driver.html?testName=imaging-desaturate) 23:47:31 INFO - PROCESS | 3621 | RSS: Main: 212865024 23:47:31 INFO - PROCESS | 3621 | 23:47:34 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43443/tests/kraken/driver.html?testName=json-parse-financial) 23:47:35 INFO - PROCESS | 3621 | RSS: Main: 213872640 23:47:35 INFO - PROCESS | 3621 | 23:47:37 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:47:37 INFO - PROCESS | 3621 | RSS: Main: 203190272 23:47:37 INFO - PROCESS | 3621 | 23:47:39 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:47:40 INFO - PROCESS | 3621 | RSS: Main: 205864960 23:47:40 INFO - PROCESS | 3621 | 23:47:42 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:47:42 INFO - PROCESS | 3621 | RSS: Main: 215883776 23:47:42 INFO - PROCESS | 3621 | 23:47:45 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:47:46 INFO - PROCESS | 3621 | RSS: Main: 223404032 23:47:46 INFO - PROCESS | 3621 | 23:47:48 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:47:49 INFO - PROCESS | 3621 | RSS: Main: 220901376 23:47:49 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | Cycle 1(1): loaded http://localhost:43443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43443/tests/kraken/driver.html?testName=ai-astar) 23:47:51 INFO - PROCESS | 3621 | RSS: Main: 266543104 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | __start_tp_report 23:47:51 INFO - PROCESS | 3621 | _x_x_mozilla_page_load 23:47:51 INFO - PROCESS | 3621 | _x_x_mozilla_page_load_details 23:47:51 INFO - PROCESS | 3621 | |i|pagename|runs| 23:47:51 INFO - PROCESS | 3621 | |0;ai-astar;110;103;109;109;109;110;108;109;108;109 23:47:51 INFO - PROCESS | 3621 | |1;audio-beat-detection;156;123;154;214;124;162;165;125;180;132 23:47:51 INFO - PROCESS | 3621 | |2;audio-dft;161;161;160;160;161;161;163;161;160;161 23:47:51 INFO - PROCESS | 3621 | |3;audio-fft;74;75;75;157;75;74;75;73;147;76 23:47:51 INFO - PROCESS | 3621 | |4;audio-oscillator;91;92;147;93;92;91;127;92;92;120 23:47:51 INFO - PROCESS | 3621 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;116;117 23:47:51 INFO - PROCESS | 3621 | |6;imaging-darkroom;146;145;147;146;146;145;146;147;146;145 23:47:51 INFO - PROCESS | 3621 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;95 23:47:51 INFO - PROCESS | 3621 | |8;json-parse-financial;55;54;55;54;53;54;55;104;51;52 23:47:51 INFO - PROCESS | 3621 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;60;60;60 23:47:51 INFO - PROCESS | 3621 | |10;stanford-crypto-aes;80;85;77;77;78;79;78;77;80;78 23:47:51 INFO - PROCESS | 3621 | |11;stanford-crypto-ccm;132;124;140;122;121;122;119;125;195;129 23:47:51 INFO - PROCESS | 3621 | |12;stanford-crypto-pbkdf2;160;161;160;157;158;157;155;163;157;159 23:47:51 INFO - PROCESS | 3621 | |13;stanford-crypto-sha256-iterative;63;62;64;64;63;61;62;62;64;61 23:47:51 INFO - PROCESS | 3621 | __end_tp_report 23:47:51 INFO - PROCESS | 3621 | __start_cc_report 23:47:51 INFO - PROCESS | 3621 | _x_x_mozilla_cycle_collect,1872 23:47:51 INFO - PROCESS | 3621 | __end_cc_report 23:47:51 INFO - PROCESS | 3621 | __startTimestamp1463640471477__endTimestamp 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | ------- Summary: start ------- 23:47:51 INFO - PROCESS | 3621 | Number of tests: 14 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:2.01 (1.8%) stddev-sans-first:2.05 23:47:51 INFO - PROCESS | 3621 | Values: 110.0 103.0 109.0 109.0 109.0 110.0 108.0 109.0 108.0 109.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:159.00 stddev:29.15 (18.3%) stddev-sans-first:30.91 23:47:51 INFO - PROCESS | 3621 | Values: 156.0 123.0 154.0 214.0 124.0 162.0 165.0 125.0 180.0 132.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 23:47:51 INFO - PROCESS | 3621 | Values: 161.0 161.0 160.0 160.0 161.0 161.0 163.0 161.0 160.0 161.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#3] audio-fft Cycles:10 Average:90.10 Median:75.00 stddev:32.72 (43.6%) stddev-sans-first:34.18 23:47:51 INFO - PROCESS | 3621 | Values: 74.0 75.0 75.0 157.0 75.0 74.0 75.0 73.0 147.0 76.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:92.00 stddev:20.19 (21.9%) stddev-sans-first:20.88 23:47:51 INFO - PROCESS | 3621 | Values: 91.0 92.0 147.0 93.0 92.0 91.0 127.0 92.0 92.0 120.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:47:51 INFO - PROCESS | 3621 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:47:51 INFO - PROCESS | 3621 | Values: 146.0 145.0 147.0 146.0 146.0 145.0 146.0 147.0 146.0 145.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:47:51 INFO - PROCESS | 3621 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:54.00 stddev:15.97 (29.6%) stddev-sans-first:16.89 23:47:51 INFO - PROCESS | 3621 | Values: 55.0 54.0 55.0 54.0 53.0 54.0 55.0 104.0 51.0 52.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 23:47:51 INFO - PROCESS | 3621 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.50 stddev:2.42 (3.1%) stddev-sans-first:2.54 23:47:51 INFO - PROCESS | 3621 | Values: 80.0 85.0 77.0 77.0 78.0 79.0 78.0 77.0 80.0 78.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:127.00 stddev:22.70 (17.9%) stddev-sans-first:24.07 23:47:51 INFO - PROCESS | 3621 | Values: 132.0 124.0 140.0 122.0 121.0 122.0 119.0 125.0 195.0 129.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.36 (1.5%) stddev-sans-first:2.46 23:47:51 INFO - PROCESS | 3621 | Values: 160.0 161.0 160.0 157.0 158.0 157.0 155.0 163.0 157.0 159.0 23:47:51 INFO - PROCESS | 3621 | 23:47:51 INFO - PROCESS | 3621 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:1.24 23:47:51 INFO - PROCESS | 3621 | Values: 63.0 62.0 64.0 64.0 63.0 61.0 62.0 62.0 64.0 61.0 23:47:51 INFO - PROCESS | 3621 | -------- Summary: end -------- 23:47:51 INFO - PROCESS | 3621 | 23:47:52 INFO - TEST-INFO | 3621: exit 0 23:47:52 INFO - TEST-OK | kraken | took 62533ms 23:47:52 INFO - SUITE-END | took 1175s 23:47:52 INFO - Completed test suite (00:19:35) 23:47:52 INFO - javascript benchmark 23:47:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.4862747646653, 3118.9532157017643, 3141.340318533108, 3157.1317887580926, 3175.079227024163, 5318.601104917137, 5345.278387417698, 5393.2449457075945, 5431.375391829941, 5450.5367043801325, 5444.727763611823, 5454.781808727646, 5458.536024437918, 5502.504774570288, 5529.695866727328, 4901.0, 4903.3625628668315, 5129.435762066169, 5176.611754118438, 5206.088934436478, 5095.108356037697, 5096.0, 5124.820631277906, 5161.922571161435, 5163.173892177252, 4879.414470263556, 4884.340614017134, 4909.091818013661, 4940.950590494103, 4969.726665033421, 4873.074115917964, 4881.487443818419, 4938.037082768861, 4961.8511444656715, 4987.077390682735, 4886.975565122188, 4907.2393778964315, 4915.213565829486, 4931.610300437688, 4978.5270399312, 5396.973015134939, 5402.945970540283, 5473.534749546293, 5558.666480011172, 5562.499375056264, 5890.352061273256, 5980.252468441445, 6001.849953751147, 6002.0, 6011.12838638395, 5675.120356344773, 5859.121131830217, 5887.941120588782, 5937.703114844284, 6016.0, 5532.6680399176175, 5541.6674999499755, 5571.637843540157, 5586.804461843816, 5593.972030139823, 6071.908921366183, 6082.68256780024, 6083.798352408627, 6086.478380404898, 6091.0, 5555.250041244381, 5737.110747834009, 5761.942380576224, 5792.1311803229855, 5888.087346461305, 5881.470667639933, 5904.261967254093, 5917.940820591825, 5961.076033214858, 5980.162777211194, 5849.2103566018895, 5857.560682948796, 5870.941290587125, 5888.470037696542, 5896.233489646319, 5644.463775941279, 5817.825465236049, 5839.240898683229, 5880.353161152269, 5894.852628684232, 4416.138852923713, 4456.331550267486, 4458.353538736865, 4461.910761784811, 4485.25993211123, 3864.806759662006, 3966.2662407454714, 3982.980085099556, 3991.241664083873, 4025.2150830587752, 5393.919091213635, 5430.266913966643, 5442.972785136049, 5446.0, 5481.835544933659, 5826.854328641818, 5829.213056237354, 5833.82498525045, 5838.0, 5838.620489668158, 5367.838964831061, 5424.267723857308, 5428.647137936022, 5448.754806033738, 5452.1276595745285, 5015.0, 5063.0380227756605, 5074.06129865976, 5075.086484432763, 5087.084324821493, 6045.063015232646, 6051.0, 6055.8183254501555, 6058.333583305833, 6060.090986351995, 5681.005823980704, 5878.764849405976, 5903.321118071477, 5943.346231914399, 5946.0, 6000.21997140369, 6092.598375241104, 6103.367974696828, 6105.603180519319, 6112.442689633966, 5797.594168408171, 5828.446297601721, 5835.9708201458725, 5840.678762668094, 5895.233619629421, 5677.517411019944, 5901.409859014064, 5946.613470124428, 5956.136360227656, 5993.460588547052, 5890.381509941394, 5890.676012819336, 5895.322037965689, 5899.262592175978, 5939.4951429129005, 5880.764769409176, 5890.204822349099, 5892.558058145571, 5897.144913987534, 5898.144769008384, 5535.972320138373, 5539.307586551681, 5555.666660000413, 5583.832485025456, 5779.913301300399, 5757.798477053283, 5810.273715785527, 5813.651180928989, 5816.709164541671, 5822.70886455667, 5589.608727389043, 5630.493255606852, 5650.0, 5650.604457688087, 5657.773689052392], "value": 5412.126438611406, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7403916315985, 633.2527617411454, 643.0450780590821, 650.5413683353235, 659.3933581105382, 44662.776686116566, 45950.08099838006, 45982.540174598245, 46040.539594604044, 51012.48987510124, 44956.775216123955, 45282.54717452825, 45516.77241613796, 45561.0, 45563.31655025177, 8739.825203495926, 8841.204291613754, 8904.421212621159, 8910.465372077664, 8913.955430222839, 8857.557122143899, 8883.777905552348, 8928.508932008737, 8955.41789783662, 8956.462612243286, 8982.461052336848, 9006.459612423243, 9020.41367311126, 9022.052684468135, 9036.77408064797, 8913.153250441197, 8942.597583108743, 8975.910240897638, 8986.281097512216, 8998.415103018282, 8790.077041910572, 8888.644454221823, 8892.110788921122, 8899.110088991049, 8901.154390332907, 41368.37947430791, 41707.0, 41720.37419438711, 41734.0, 41820.372694409605, 3682.0, 3822.2737679840743, 3875.360565506688, 3920.0787814863484, 4197.97901010496, 31903.202419939687, 32840.178995525064, 33124.0, 33249.6675033249, 33930.83034584836, 4310.202612516695, 4340.6093451589195, 4450.132224216279, 4463.8214471421425, 4467.218236808546, 216106.0, 216509.0, 217212.0, 217706.0, 218836.0, 36021.459678104846, 36814.8159259202, 57944.42055579474, 59196.0, 59215.70392148012, 38875.22249555049, 38974.80512597419, 38980.41529377062, 39012.609873900896, 39055.2188956225, 14376.28118594087, 14531.78202326966, 14534.709305813825, 14536.927315363568, 14537.273136343141, 11443.427828608535, 11486.253393529561, 11491.54033838637, 11492.25300355491, 11493.367864767519, 8790.648374065093, 8805.603747831363, 8805.603747831363, 8819.514926678967, 8920.73237802854, 3331.0, 3342.983285083608, 3362.327534493111, 3379.881704140343, 3409.7954122752712, 1080.4975686305906, 1110.3948348150277, 1111.1666250312267, 1157.560127151694, 1219.2136072233536, 34046.82976585151, 34347.0, 34540.595889213255, 34710.826445867606, 34905.12737181591, 1129.3957732613176, 1176.4941075337688, 1186.7863784518697, 1238.38699843578, 1251.6370252626637, 17619.647607047787, 17865.37471188528, 17888.642227155386, 18119.275228990955, 18147.0, 564729.0, 570785.0, 571256.0, 577487.0, 579510.0, 59479.70260148758, 60485.0, 60864.39135608587, 60985.0, 61010.0, 1322.24631959782, 1403.677154254527, 1418.2199790115396, 1443.1485423599916, 1446.320229492158, 33721.81973630911, 35386.646133538336, 35409.64590354166, 35464.0, 35815.46276805798, 51133.23300150426, 51404.48595513997, 51938.74030629974, 51968.74015630049, 51984.74007629938, 370773.0, 371989.0, 372096.0, 372274.0, 372607.0, 25801.612975805754, 28059.57910631383, 28609.427811443238, 28903.710962890942, 30392.0, 48936.26595600998, 50165.74917125391, 50579.0, 51188.232176518126, 51298.0, 42066.36900446557, 42241.0, 42481.787591061846, 43082.0, 43998.78000609976, 41124.38313425241, 42244.788776057154, 42309.57690423056, 43361.34957975696, 43710.56289437065, 42111.0, 42435.787821060694, 43552.0, 43750.12499749923, 43760.781196095086, 37001.25997479982, 37086.814565927, 37813.62186378211, 38064.61935380722, 38326.80836595799, 28941.56587651229, 29063.0, 29434.411311774074, 29588.556171657874, 29660.851695742247], "value": 19098.51205445141, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.2520138549228, 414.80089557012633, 420.77909097723693, 423.08402309001013, 430.5070694055307, 18158.909205453972, 18967.715484267712, 19589.804101958995, 19826.70259946102, 20275.898620506912, 18446.169922353492, 18540.629187416278, 18635.813641863577, 18694.15876285567, 19369.322073727424, 5573.526250268722, 5626.887462250753, 5757.539396848242, 5764.452377024176, 5768.105943578752, 5600.103983362663, 5632.802851900185, 5645.040343141655, 5655.8586035349035, 5659.490645841874, 5503.724813759316, 5773.682447465388, 5811.593188476808, 5893.292804863422, 5894.528437724993, 5735.627184233053, 5753.626014309078, 5839.065749480105, 5844.795432159875, 6262.780802671885, 5603.775848966077, 5637.8590535236535, 5644.266245388114, 5655.236543066716, 5659.660420374749, 13808.0, 17994.640107197913, 19762.70355944662, 21746.673799893015, 22357.329280121623, 2366.7041619797524, 2514.3085651445817, 2844.1041072062235, 3021.1993821637284, 3071.1861356740483, 9844.212463002943, 10150.187984961185, 10214.233932455021, 10326.845097323547, 10479.633212837514, 1921.9039048047541, 1929.3440230321617, 1933.3426634944046, 1937.7577802774654, 1939.4278687787137, 79289.0, 80558.59720701417, 84347.0, 85976.14023859806, 86460.56769716174, 10829.67510974672, 11086.445677716081, 11139.275947063577, 11245.381504017358, 11480.885191147981, 15715.607109822116, 15824.683506330039, 15888.443904463289, 15895.0, 15905.0, 7572.962135189288, 7844.176361481962, 7894.960525197452, 8001.0, 8081.030276366873, 7189.820254493679, 7281.672324745399, 7405.8889116663295, 7443.292887175709, 7466.328030477283, 4769.189237829577, 4837.153498137812, 4903.705777653352, 4912.95087049125, 4916.139675556763, 1964.5579744557647, 1973.9111739971736, 1994.5412555112405, 2029.1883246701439, 2092.309537852505, 970.8301047316692, 1062.4953147254992, 1082.1883587309517, 1100.1748688483638, 1104.9834152579647, 17849.910750446164, 18598.53503662392, 18707.906460467882, 19215.615687686448, 19620.313289034817, 997.0876647867266, 1014.3609525998721, 1016.1667432705111, 1057.7567159553346, 1102.0577406317643, 10093.747656308504, 10675.0, 10721.35671859691, 10721.571137154426, 10780.676579702622, 462430.0, 469570.0, 481975.0, 488765.0, 493355.0, 95065.0, 98439.50780246196, 98491.50754246183, 99388.0, 99611.50194248982, 1029.7013865978781, 1041.0422411381546, 1082.870055593318, 1090.547422819537, 1117.6423544465856, 16456.0, 16488.17559122015, 16642.251098700828, 16746.24641891142, 16866.494005179866, 31807.84096079505, 38862.61137388703, 40405.1918961625, 40626.0, 41446.0, 55033.0, 55487.72256138694, 56632.73469061191, 56900.0, 56940.0, 7155.821104472429, 8531.36014798905, 8689.435186712843, 8911.287097032351, 8977.865332020156, 11520.135989800967, 12786.424610892345, 12994.415251313525, 13235.205887646773, 13329.133606315558, 6095.1466794647895, 8367.665293388196, 11454.568178977628, 11614.825777613512, 11676.532938682698, 11396.829047564128, 11528.365939873052, 11665.825012624988, 11744.823827642422, 11841.763164736485, 11559.190856639954, 11856.170068095496, 11958.282503049844, 12010.159288849696, 12116.575919842764, 7771.106322772727, 7784.610769461618, 7920.881186782318, 7957.8408431832195, 8033.718819841278, 11452.255603385753, 11586.478608462809, 11686.415679215836, 11728.882711172779, 11863.110266730202], "value": 9173.119147662714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.5944946240859, 1512.2892240646895, 1563.515310253821, 1698.464983530188, 1851.3982955539445, 8806.0, 9223.354365194438, 9231.723048308553, 9248.121428464301, 9264.58309376078, 8979.910200898006, 9147.31395145365, 9160.770980725485, 9161.450312981226, 9167.0, 2320.1879342230254, 2354.281944007077, 2354.5173239485866, 2354.72920614129, 2355.5406695694346, 2291.8395712300144, 2331.25399872041, 2351.353377821096, 2351.49442869783, 2351.8471299365574, 2313.5372925414986, 2333.4399744061475, 2341.566810140121, 2342.9531409371803, 2345.1440224318085, 2254.740704818934, 2287.5196208796174, 2288.0390236100793, 2295.2196253273883, 2302.5510025545027, 2259.53679495703, 2264.5810525052916, 2267.0591704442636, 2267.614505534063, 2272.1706577099403, 8745.956270218672, 8955.46267223962, 8959.328050396247, 9079.7276081717, 9143.817123657556, 5276.3140791697215, 5380.865478363033, 5383.031054410205, 5386.946130538684, 5406.945930540684, 3407.9488807667904, 3426.5716785401823, 3466.4107101792756, 3533.3110043541265, 3555.253396786678, 1052.3633201912885, 1078.4230436716398, 1114.6878873915316, 1117.1230583991528, 1134.563193170627, 12926.935365323206, 13044.673883152902, 13052.543160989415, 13054.477820887058, 13055.15141515808, 4586.105709386704, 4679.181143299977, 4776.21192503233, 4780.808767649325, 4784.497627749106, 10132.442715650563, 10135.0, 10152.898471015344, 10172.0, 10179.083882450615, 5429.864253393696, 5430.755615997289, 5439.700816455053, 5442.700651464128, 5444.428335024844, 4426.601605855489, 4845.6123510119105, 5000.1249781288125, 5020.3724534433195, 5022.271770593316, 3862.729608927348, 3869.245497128033, 3936.5472970608175, 3945.7040721945395, 3992.181602771425, 1145.6219447582444, 1157.479134389528, 1162.953481860716, 1168.7136651520261, 1196.1148749924994, 716.5521549031855, 893.7274131389859, 969.7236287657984, 993.3046867192994, 993.8509223616371, 5598.86002849932, 6003.429674180946, 6013.850443194182, 6110.908336374958, 6125.264968203844, 469.66614813928607, 478.1154863502492, 485.15825043549415, 488.0312579529631, 651.371426573359, 3921.8627348042683, 4086.570910054461, 4136.379543068504, 4140.171965606891, 4149.834006639761, 11620.709482262842, 12092.214006089576, 12136.211146275464, 12151.453184606715, 12233.082518811125, 11204.271722338022, 11701.765964680659, 12022.579209727617, 12025.579104731292, 12026.0, 8773.956130219309, 8937.374383793202, 8966.910330896739, 9019.503927284062, 9036.548172591343, 6343.682815859096, 6591.143151390289, 6608.8347791305605, 6640.867182656417, 6708.22855371619, 10575.259731818698, 10746.086582640562, 11043.447827608748, 11046.558137674403, 11122.388268645302, 10598.841017384899, 10609.310394824312, 10689.465526723789, 10742.19433542503, 10765.623203188165, 7917.208279172037, 8057.677692892219, 8132.105468398353, 8154.836903261783, 8160.224778646019, 8709.738707838775, 8744.825103497767, 8746.256568191775, 8760.4305720128, 8767.298616110824, 7900.367970562226, 7957.283844454027, 7974.48165869225, 8020.839583208186, 8084.878726818984, 7643.464957452925, 7672.424568157299, 7851.05787305527, 7898.842023159619, 8017.719379821679, 7279.59962202084, 7336.37640800538, 7519.172890982097, 7525.887111693439, 7531.774046778605, 5115.462876397924, 5129.076766182123, 5209.166533354645, 5289.68261904287, 5322.813701520428, 5144.819931302386, 5179.300794392709, 5247.0, 5276.894462110813, 5385.838424847261], "value": 4669.63221440665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1215385305866, 339.1085732104226, 341.5116383571493, 348.84127721886546, 351.337728382, 5347.759350829212, 5388.91916621251, 5403.378611459683, 5421.674699518032, 5440.3743569489525, 5101.336826212587, 5190.2474141249595, 5211.42674305826, 5237.659552129109, 5350.0, 4132.876013719586, 4201.857052903026, 4210.7473551586845, 4215.49414070312, 4226.619604235618, 4127.669786417079, 4160.292750232467, 4162.666986641077, 4211.347241177607, 4248.9575104249025, 4102.077032667656, 4161.916761664765, 4184.99560105574, 4210.0, 4220.324748040314, 4165.895852603679, 4172.040430700926, 4186.3092589722655, 4192.4759405074365, 4211.642010429117, 3694.353488139565, 3694.612065733086, 3704.370257056307, 3716.256748650254, 3722.7952462614544, 4974.801007959677, 5135.332406787131, 5178.948210517884, 5182.015417070745, 5183.455737147583, 4714.740689262089, 4745.501722319176, 4779.2077970760965, 4783.784729687138, 4808.447028591721, 5563.415841336642, 5573.54763903885, 5584.720763961826, 5585.385607583163, 5604.514803577055, 3853.075261937143, 4008.4388185654034, 4036.233115708006, 4040.3636527206527, 4089.631933126033, 5772.682502462363, 5777.220075289824, 5787.572507032124, 5808.834185368984, 5817.156512305734, 4049.311617025113, 4065.4511640928094, 4081.653059489977, 4086.3053280942313, 4096.3855421686985, 4017.2367250222946, 4155.667546596325, 4156.127213285184, 4165.0, 4169.56219596944, 4733.621310295237, 4758.904821903612, 4768.165571025057, 4796.5203479651755, 4844.588210002119, 5556.666600003932, 5558.360788509292, 5561.805336813192, 5659.236003139606, 5677.432256774289, 1349.9730005400033, 1389.423389293432, 1444.3139508733477, 1473.6168596165073, 1473.9166712466329, 927.452802846324, 973.5639931101568, 975.3903810118676, 980.4950450517989, 984.5274268351232, 4842.159979207879, 4853.490383509751, 4854.296127061556, 4863.294822250754, 4903.877403064952, 5122.692638441706, 5150.690958542499, 5155.278261043457, 5157.4584668610005, 5177.0, 4548.4541854977615, 4852.1508735971065, 4852.2479015752615, 4871.878203044952, 4888.975555122272, 2720.5103081445136, 2723.9727602724115, 2725.604787305869, 2730.2491814750706, 2732.7540521353176, 5167.405748338989, 5194.506521880416, 5194.740262986836, 5201.661891977085, 5206.557442617344, 4748.9606651742915, 5207.71357575337, 5230.372355317386, 5242.318498595158, 5242.7378631068295, 5205.20020385121, 5210.921836172461, 5281.234221037928, 5301.6818990860675, 5320.627556071116, 4793.736344501086, 5061.898762024813, 5085.694858308513, 5123.052235336475, 5127.256547800623, 4965.230389289666, 4974.975125124496, 4979.3526841510375, 5066.4680208577565, 5088.720120393414, 5189.195674670432, 5203.907179492349, 5241.50205730455, 5253.343332083489, 5270.920936185884, 3736.2527494500664, 3791.374423220138, 3821.2739579479808, 3826.770393776382, 3857.71067169969, 5375.892482150413, 5626.85932851682, 5690.715464226855, 5841.9707901461925, 5887.41125887425, 5650.519705825051, 5664.575156863334, 5674.404187560247, 5684.0, 5687.886242275049, 5533.889322213614, 5701.287339082614, 5702.8289151325525, 5711.144427786107, 5721.799737009184, 5574.386817450159, 5575.219469274224, 5581.162825576196, 5589.55283577321, 5592.944070559242, 5645.520130788929, 5655.981923253854, 5658.349289831722, 5682.460166284196, 5701.4298570142655, 5421.783128674967, 5522.447755224445, 5538.833834984957, 5552.139418390156, 5584.748686309044], "value": 4138.692307883291, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.2605498721227, 830.7466222802043, 838.9622466988985, 842.132603418479, 878.7188099808056, 15185.696286074271, 15352.923235383822, 16119.91940040301, 16129.516114516555, 16150.192490375493, 14873.0, 14968.850311496883, 15007.399704011854, 15009.09945403274, 15042.247887605603, 688.2016860441888, 807.4670717326566, 822.6627082896014, 827.4580150001758, 831.9792005199873, 830.8587540118165, 835.7450977451874, 837.5602808525512, 838.3502785341349, 839.5508403004394, 885.8006948436582, 886.5478605910968, 888.320434867327, 889.030956257679, 889.2308153447286, 715.8067321823105, 730.9853802923965, 731.3892899428984, 856.2465030772943, 879.0813599788205, 642.1363266406722, 646.6314200905485, 646.6475770704977, 646.7380710812129, 647.2007071266981, 15114.244287785566, 15139.54581362561, 15189.468368607157, 15284.541463756104, 15333.693326133527, 13887.166769993833, 14628.634284142876, 14703.852961470355, 14756.48352307664, 14761.852381476156, 12415.503379864795, 12688.429020694091, 12696.238225706487, 12739.55411560591, 12759.553415630407, 4570.588647021784, 4580.679352445331, 4721.079389519045, 4748.762561871893, 4769.117713223065, 62890.37109628891, 62979.0, 63088.684556577384, 64331.67834160846, 64429.67785161091, 11175.888241117485, 11190.934934456529, 11195.832062519068, 11326.773464530663, 11396.14528910335, 21157.68263476049, 21469.46326341854, 21474.785252147278, 21482.78517214839, 21494.14023439076, 8305.21100495464, 8405.0, 8410.747677569683, 8619.310455163572, 8744.91255087441, 4688.484266730657, 4702.670813043054, 4729.834455794031, 4841.12859685253, 5100.846974590768, 3530.1880567469625, 3625.5830579483695, 3627.183883626163, 3633.2733453309443, 3637.4725664778457, 664.4219977553311, 671.4695390641436, 677.4986509982676, 681.1859827506082, 687.7558466744334, 614.8647297594522, 657.575863567996, 711.548166914003, 726.1939247435342, 742.9591372474566, 9682.225421966226, 9712.514374281258, 9748.756281093029, 9752.317337786288, 9820.852687209697, 689.5965859971873, 741.1439787045971, 764.4686942574857, 771.0477560213133, 776.5263189454429, 4567.36056952027, 4657.208274593328, 4698.083873644607, 4706.717596944194, 4751.976240118777, 71990.64004679942, 73293.26706732971, 77360.61319693478, 77611.61194193993, 78964.6051769749, 62628.06057909135, 62642.0, 67098.66450667716, 67102.0, 68267.3173268261, 26978.32554186161, 27117.593236101475, 52754.73622631862, 59276.70361648164, 59313.80337636459, 9966.750831229278, 10180.796384072426, 10224.59101635956, 10438.68683939483, 10455.268131230741, 37741.4338784924, 37945.81027094957, 38138.61861381351, 38408.80795596116, 38424.6157538421, 48671.51328486812, 49730.502694974035, 50231.0, 50269.497305027944, 51247.0, 12814.615561533168, 12882.742345153232, 12986.675333116747, 13070.150440221356, 13340.799888001493, 14385.000647210556, 14559.27203639835, 14886.404543818126, 15002.174880381684, 15111.0, 13509.459621615419, 13651.180929144282, 13818.930905345409, 13840.653983650087, 14393.496227631982, 13119.0, 13670.726585468434, 13679.31603419845, 14040.227787471378, 14063.789043164155, 12425.0, 12595.68510787201, 12622.305773182563, 12708.745825083632, 12947.417366218355, 11360.602378916697, 11609.129315301218, 11617.477213525242, 11621.593244236412, 11888.702782430508, 11433.056380415183, 11548.769024619629, 11755.941220294186, 11787.941060294643, 11890.583829565923], "value": 7210.837285655173, "unit": "score"}], "name": "dromaeo_css", "value": 7136.904701249509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 109.0, 109.0, 110.0, 108.0, 109.0, 108.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 154.0, 214.0, 124.0, 162.0, 165.0, 125.0, 180.0, 132.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 163.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 157.0, 75.0, 74.0, 75.0, 73.0, 147.0, 76.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 147.0, 93.0, 92.0, 91.0, 127.0, 92.0, 92.0, 120.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 53.0, 54.0, 55.0, 104.0, 51.0, 52.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 77.0, 77.0, 78.0, 79.0, 78.0, 77.0, 80.0, 78.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 124.0, 140.0, 122.0, 121.0, 122.0, 119.0, 125.0, 195.0, 129.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 157.0, 158.0, 157.0, 155.0, 163.0, 157.0, 159.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 64.0, 63.0, 61.0, 62.0, 62.0, 64.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1526.1000000000004, "alertThreshold": 2.0}]} 23:47:52 INFO - Return code: 0 23:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:47:52 ERROR - # TBPL SUCCESS # 23:47:52 INFO - Running post-action listener: _resource_record_post_action 23:47:52 INFO - ##### 23:47:52 INFO - ##### Finished run-tests step (success) 23:47:52 INFO - ##### 23:47:52 INFO - Running post-run listener: _resource_record_post_run 23:47:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8130560; Write bytes: 431497216; Read time: 1908; Write time: 313572 23:47:52 INFO - TinderboxPrint: CPU usage
13.2% 23:47:52 INFO - TinderboxPrint: I/O read bytes / time
8,130,560 / 1,908 23:47:52 INFO - TinderboxPrint: I/O write bytes / time
431,497,216 / 313,572 23:47:52 INFO - TinderboxPrint: CPU idle
8,272.7 (86.8%) 23:47:52 INFO - TinderboxPrint: CPU user
1,208.1 (12.7%) 23:47:52 INFO - TinderboxPrint: Swap in / out
0 / 0 23:47:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 8871936; Read time: 0; Write time: 4332 23:47:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8130560; Write bytes: 337104896; Read time: 1908; Write time: 256492 23:47:53 INFO - Running post-run listener: _upload_blobber_files 23:47:53 INFO - Blob upload gear active. 23:47:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:47:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 23:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:54 INFO - (blobuploader) - INFO - Done attempting. 23:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:55 INFO - (blobuploader) - INFO - Done attempting. 23:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:47:59 INFO - (blobuploader) - INFO - Done attempting. 23:47:59 INFO - (blobuploader) - INFO - Iteration through files over. 23:47:59 INFO - Return code: 0 23:47:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:47:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:47:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb3971b23b6ae2f4e66158cecde9b1fb1627945cce69be91c1d7bdbdda743c97a1b48c8e4e24f07163990645d0a7f5583aecadb9922775b0225d4b6689d920d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e395ceef6de28c33101b9e3d357d3a121cb681ddaae1329938bc7cbe5017f8e88e98f5944f7e3bab38394a6410d18abbadc16853fdfe8fbc2b2132fce2f10fe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83a4eac470bcc007482f034e10e5607bbb6377ba0740d43cefc7a26206b978a687c7659cc0e50d551519695860be99f73d017bc1be902ff2ebffa1f62af56ef4"} 23:47:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:47:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:47:59 INFO - Contents: 23:47:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb3971b23b6ae2f4e66158cecde9b1fb1627945cce69be91c1d7bdbdda743c97a1b48c8e4e24f07163990645d0a7f5583aecadb9922775b0225d4b6689d920d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e395ceef6de28c33101b9e3d357d3a121cb681ddaae1329938bc7cbe5017f8e88e98f5944f7e3bab38394a6410d18abbadc16853fdfe8fbc2b2132fce2f10fe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83a4eac470bcc007482f034e10e5607bbb6377ba0740d43cefc7a26206b978a687c7659cc0e50d551519695860be99f73d017bc1be902ff2ebffa1f62af56ef4"} 23:47:59 INFO - Running post-run listener: copy_logs_to_upload_dir 23:47:59 INFO - Copying logs to upload dir... 23:47:59 INFO - mkdir: /builds/slave/test/build/upload/logs 23:47:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.794360 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-18 23:47:59.088227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 23:47:59.092881) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 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/8fb3971b23b6ae2f4e66158cecde9b1fb1627945cce69be91c1d7bdbdda743c97a1b48c8e4e24f07163990645d0a7f5583aecadb9922775b0225d4b6689d920d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e395ceef6de28c33101b9e3d357d3a121cb681ddaae1329938bc7cbe5017f8e88e98f5944f7e3bab38394a6410d18abbadc16853fdfe8fbc2b2132fce2f10fe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83a4eac470bcc007482f034e10e5607bbb6377ba0740d43cefc7a26206b978a687c7659cc0e50d551519695860be99f73d017bc1be902ff2ebffa1f62af56ef4"} build_url:https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010993 build_url: 'https://queue.taskcluster.net/v1/task/fQfq3Fx6T52pCtgZ4di3jQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fb3971b23b6ae2f4e66158cecde9b1fb1627945cce69be91c1d7bdbdda743c97a1b48c8e4e24f07163990645d0a7f5583aecadb9922775b0225d4b6689d920d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e395ceef6de28c33101b9e3d357d3a121cb681ddaae1329938bc7cbe5017f8e88e98f5944f7e3bab38394a6410d18abbadc16853fdfe8fbc2b2132fce2f10fe7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83a4eac470bcc007482f034e10e5607bbb6377ba0740d43cefc7a26206b978a687c7659cc0e50d551519695860be99f73d017bc1be902ff2ebffa1f62af56ef4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 23:47:59.119897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:47:59.120228) ========= 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=337fe3f4b1febe37b85fccc40000019e-1463638902.458258-1483302723 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 23:47:59.200361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 23:47:59.203717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 23:47:59.204005) ========= ========= Total master_lag: 0.06 =========