builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1463621463.19 results: success (0) buildid: 20160518172845 builduid: 213804cc4b3045a08e311bdc6ec89854 revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.187251) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.187817) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.188137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.204513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.204925) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 18:31:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-05-18 18:31:03 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136221 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.395029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.395360) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015707 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.428542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:03.428939) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5bd03d0a58768dbe3184fa9f001372291bd679b8 --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 5bd03d0a58768dbe3184fa9f001372291bd679b8 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 18:31:03,650 truncating revision to first 12 chars 2016-05-18 18:31:03,651 Setting DEBUG logging. 2016-05-18 18:31:03,651 attempt 1/10 2016-05-18 18:31:03,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5bd03d0a5876?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 18:31:04,027 unpacking tar archive at: fx-team-5bd03d0a5876/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969433 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.414226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.414545) ========= script_repo_revision: 5bd03d0a58768dbe3184fa9f001372291bd679b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.414982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.415531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 18:31:04.426006) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-18 18:31:04.426308) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:31:04 INFO - MultiFileLogger online at 20160518 18:31:04 in /builds/slave/test 18:31:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:31:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:31:04 INFO - {'append_to_log': False, 18:31:04 INFO - 'base_work_dir': '/builds/slave/test', 18:31:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:31:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:31:04 INFO - 'branch': 'Fx-Team-Non-PGO', 18:31:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:31:04 INFO - 'config_files': ('talos/linux_config.py',), 18:31:04 INFO - 'default_actions': ('clobber', 18:31:04 INFO - 'read-buildbot-config', 18:31:04 INFO - 'download-and-extract', 18:31:04 INFO - 'populate-webroot', 18:31:04 INFO - 'create-virtualenv', 18:31:04 INFO - 'install', 18:31:04 INFO - 'run-tests'), 18:31:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:31:04 INFO - 'download_minidump_stackwalk': True, 18:31:04 INFO - 'download_symbols': 'ondemand', 18:31:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:31:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:31:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:31:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:31:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:31:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:31:04 INFO - 'installer_path': 'installer.exe', 18:31:04 INFO - 'log_level': 'info', 18:31:04 INFO - 'log_name': 'talos', 18:31:04 INFO - 'log_to_console': True, 18:31:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:31:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:31:04 INFO - 'opt_config_files': (), 18:31:04 INFO - 'pip_index': False, 18:31:04 INFO - 'sps_profile': False, 18:31:04 INFO - 'sps_profile_interval': 0, 18:31:04 INFO - 'suite': 'dromaeojs', 18:31:04 INFO - 'system_bits': '32', 18:31:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:31:04 INFO - 'title': 'talos-linux64-ix-065', 18:31:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:31:04 INFO - 'use_talos_json': True, 18:31:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:31:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:31:04 INFO - 'work_dir': 'build'} 18:31:04 INFO - ##### 18:31:04 INFO - ##### Running clobber step. 18:31:04 INFO - ##### 18:31:04 INFO - Running pre-action listener: _resource_record_pre_action 18:31:04 INFO - Running main action method: clobber 18:31:04 INFO - rmtree: /builds/slave/test/build 18:31:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:31:05 INFO - Running post-action listener: _resource_record_post_action 18:31:05 INFO - ##### 18:31:05 INFO - ##### Finished clobber step (success) 18:31:05 INFO - ##### 18:31:05 INFO - ##### 18:31:05 INFO - ##### Running read-buildbot-config step. 18:31:05 INFO - ##### 18:31:05 INFO - Running pre-action listener: _resource_record_pre_action 18:31:05 INFO - Running main action method: read_buildbot_config 18:31:05 INFO - Using buildbot properties: 18:31:05 INFO - { 18:31:05 INFO - "project": "", 18:31:05 INFO - "product": "firefox", 18:31:05 INFO - "script_repo_revision": "production", 18:31:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:31:05 INFO - "repository": "", 18:31:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:31:05 INFO - "buildid": "20160518172845", 18:31:05 INFO - "pgo_build": "False", 18:31:05 INFO - "basedir": "/builds/slave/test", 18:31:05 INFO - "buildnumber": 2986, 18:31:05 INFO - "slavename": "talos-linux64-ix-065", 18:31:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:31:05 INFO - "platform": "ubuntu64_hw", 18:31:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:31:05 INFO - "branch": "fx-team", 18:31:05 INFO - "repo_path": "integration/fx-team", 18:31:05 INFO - "revision": "5bd03d0a58768dbe3184fa9f001372291bd679b8", 18:31:05 INFO - "stage_platform": "linux64", 18:31:05 INFO - "builduid": "213804cc4b3045a08e311bdc6ec89854", 18:31:05 INFO - "slavebuilddir": "test" 18:31:05 INFO - } 18:31:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:31:05 INFO - Running post-action listener: _resource_record_post_action 18:31:05 INFO - ##### 18:31:05 INFO - ##### Finished read-buildbot-config step (success) 18:31:05 INFO - ##### 18:31:05 INFO - ##### 18:31:05 INFO - ##### Running download-and-extract step. 18:31:05 INFO - ##### 18:31:05 INFO - Running pre-action listener: _resource_record_pre_action 18:31:05 INFO - Running main action method: download_and_extract 18:31:05 INFO - mkdir: /builds/slave/test/build/tests 18:31:05 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')]} 18:31:05 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:31:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:20 INFO - Downloaded 1361 bytes. 18:31:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:31:20 INFO - Using the following test package requirements: 18:31:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:31:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:31:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'jsshell-linux-x86_64.zip'], 18:31:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:31:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:31:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:31:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:31:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:31:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:31:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:31:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:31: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')]} 18:31:20 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:27 INFO - Downloaded 22812201 bytes. 18:31: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'] 18:31: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 18:31:28 INFO - Return code: 0 18:31:28 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 18:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:28 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:31 INFO - Downloaded 22812201 bytes. 18:31:31 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'] 18:31:31 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 18:31:33 INFO - Return code: 0 18:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:33 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:34 INFO - Downloaded 10840194 bytes. 18:31:34 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'] 18:31:34 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 18:31:34 INFO - Return code: 0 18:31:34 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')]} 18:31:34 INFO - https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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 18:31:36 INFO - Downloaded 54801701 bytes. 18:31:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - mkdir: /builds/slave/test/properties 18:31:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:36 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:36 INFO - Contents: 18:31:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:31:36 INFO - Running post-action listener: _resource_record_post_action 18:31:36 INFO - Running post-action listener: set_extra_try_arguments 18:31:36 INFO - ##### 18:31:36 INFO - ##### Finished download-and-extract step (success) 18:31:36 INFO - ##### 18:31:36 INFO - ##### 18:31:36 INFO - ##### Running populate-webroot step. 18:31:36 INFO - ##### 18:31:36 INFO - Running pre-action listener: _resource_record_pre_action 18:31:36 INFO - Running main action method: populate_webroot 18:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:31:36 INFO - '--tppagecycles', 18:31:36 INFO - '7'], 18:31:36 INFO - 'tests': ['tsvgm']}}, 18:31:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:31:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:31:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['damp', 'tps']}, 18:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['damp', 'tps']}, 18:31:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['dromaeo_dom']}, 18:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['a11yr', 18:31:36 INFO - 'ts_paint', 18:31:36 INFO - 'tpaint', 18:31:36 INFO - 'sessionrestore', 18:31:36 INFO - 'sessionrestore_no_auto_restore', 18:31:36 INFO - 'tabpaint']}, 18:31:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tsvgx', 18:31:36 INFO - 'tsvgr_opacity', 18:31:36 INFO - 'tart', 18:31:36 INFO - 'tscrollx', 18:31:36 INFO - 'cart']}, 18:31:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:36 INFO - 'tsvgr_opacity', 18:31:36 INFO - 'tart', 18:31:36 INFO - 'tscrollx', 18:31:36 INFO - 'cart']}, 18:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s'], 18:31:36 INFO - 'tests': ['tp5o']}, 18:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'tests': ['tp5o']}, 18:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--disable-e10s', 18:31:36 INFO - '--xperf_path', 18:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:36 INFO - 'tests': ['tp5n']}, 18:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:31:36 INFO - 'talos_options': ['--xperf_path', 18:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:36 INFO - 'tests': ['tp5n']}}, 18:31:36 INFO - 'talos.zip': {'path': '', 18:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:31:36 INFO - Running post-action listener: _resource_record_post_action 18:31:36 INFO - ##### 18:31:36 INFO - ##### Finished populate-webroot step (success) 18:31:36 INFO - ##### 18:31:36 INFO - ##### 18:31:36 INFO - ##### Running create-virtualenv step. 18:31:36 INFO - ##### 18:31:36 INFO - Running pre-action listener: _resource_record_pre_action 18:31:36 INFO - Running main action method: create_virtualenv 18:31:36 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:36 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 18:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:36 INFO - Using real prefix '/usr' 18:31:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:39 INFO - Installing pip.................done. 18:31:39 INFO - Return code: 0 18:31:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31: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', 'pip>=1.5'] in /builds/slave/test/build 18:31: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 pip>=1.5 18:31:39 INFO - Using env: {'DISPLAY': ':0', 18:31:39 INFO - 'HOME': '/home/cltbld', 18:31:39 INFO - 'LANG': 'en_US.UTF-8', 18:31:39 INFO - 'LANGUAGE': 'en_US:en', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MAIL': '/var/mail/cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SHLVL': '1', 18:31:39 INFO - 'TERM': 'linux', 18:31:39 INFO - 'TMOUT': '86400', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - '_': '/tools/buildbot/bin/python'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 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 18:31:39 INFO - Cleaning up... 18:31:39 INFO - Return code: 0 18:31:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', '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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31: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 psutil>=3.1.1 18:31:39 INFO - Using env: {'DISPLAY': ':0', 18:31:39 INFO - 'HOME': '/home/cltbld', 18:31:39 INFO - 'LANG': 'en_US.UTF-8', 18:31:39 INFO - 'LANGUAGE': 'en_US:en', 18:31:39 INFO - 'LOGNAME': 'cltbld', 18:31:39 INFO - 'MAIL': '/var/mail/cltbld', 18:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:39 INFO - 'MOZ_NO_REMOTE': '1', 18:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:39 INFO - 'NO_EM_RESTART': '1', 18:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:39 INFO - 'PWD': '/builds/slave/test', 18:31:39 INFO - 'SHELL': '/bin/bash', 18:31:39 INFO - 'SHLVL': '1', 18:31:39 INFO - 'TERM': 'linux', 18:31:39 INFO - 'TMOUT': '86400', 18:31:39 INFO - 'USER': 'cltbld', 18:31:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:39 INFO - '_': '/tools/buildbot/bin/python'} 18:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:39 INFO - Downloading/unpacking psutil>=3.1.1 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:41 INFO - Installing collected packages: psutil 18:31:41 INFO - Running setup.py install for psutil 18:31:41 INFO - building 'psutil._psutil_linux' extension 18:31:41 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 18:31:42 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 18:31:42 INFO - building 'psutil._psutil_posix' extension 18:31:42 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 18:31:42 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 18:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:42 INFO - Successfully installed psutil 18:31:42 INFO - Cleaning up... 18:31:42 INFO - Return code: 0 18:31:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:42 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:42 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 18:31:42 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 18:31:42 INFO - Using env: {'DISPLAY': ':0', 18:31:42 INFO - 'HOME': '/home/cltbld', 18:31:42 INFO - 'LANG': 'en_US.UTF-8', 18:31:42 INFO - 'LANGUAGE': 'en_US:en', 18:31:42 INFO - 'LOGNAME': 'cltbld', 18:31:42 INFO - 'MAIL': '/var/mail/cltbld', 18:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:42 INFO - 'MOZ_NO_REMOTE': '1', 18:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:42 INFO - 'NO_EM_RESTART': '1', 18:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:42 INFO - 'PWD': '/builds/slave/test', 18:31:42 INFO - 'SHELL': '/bin/bash', 18:31:42 INFO - 'SHLVL': '1', 18:31:42 INFO - 'TERM': 'linux', 18:31:42 INFO - 'TMOUT': '86400', 18:31:42 INFO - 'USER': 'cltbld', 18:31:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:42 INFO - '_': '/tools/buildbot/bin/python'} 18:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:44 INFO - Installing collected packages: mozsystemmonitor 18:31:44 INFO - Running setup.py install for mozsystemmonitor 18:31:44 INFO - Successfully installed mozsystemmonitor 18:31:44 INFO - Cleaning up... 18:31:44 INFO - Return code: 0 18:31:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:44 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:44 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 18:31:44 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 18:31:44 INFO - Using env: {'DISPLAY': ':0', 18:31:44 INFO - 'HOME': '/home/cltbld', 18:31:44 INFO - 'LANG': 'en_US.UTF-8', 18:31:44 INFO - 'LANGUAGE': 'en_US:en', 18:31:44 INFO - 'LOGNAME': 'cltbld', 18:31:44 INFO - 'MAIL': '/var/mail/cltbld', 18:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:44 INFO - 'MOZ_NO_REMOTE': '1', 18:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:44 INFO - 'NO_EM_RESTART': '1', 18:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:44 INFO - 'PWD': '/builds/slave/test', 18:31:44 INFO - 'SHELL': '/bin/bash', 18:31:44 INFO - 'SHLVL': '1', 18:31:44 INFO - 'TERM': 'linux', 18:31:44 INFO - 'TMOUT': '86400', 18:31:44 INFO - 'USER': 'cltbld', 18:31:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:44 INFO - '_': '/tools/buildbot/bin/python'} 18:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:44 INFO - Downloading/unpacking blobuploader==1.2.4 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:46 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 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 18:31:47 INFO - Downloading docopt-0.6.1.tar.gz 18:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:47 INFO - Running setup.py install for blobuploader 18:31:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:47 INFO - Running setup.py install for requests 18:31:47 INFO - Running setup.py install for docopt 18:31:48 INFO - Successfully installed blobuploader requests docopt 18:31:48 INFO - Cleaning up... 18:31:48 INFO - Return code: 0 18:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:48 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:48 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 18:31:48 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 18:31:48 INFO - Using env: {'DISPLAY': ':0', 18:31:48 INFO - 'HOME': '/home/cltbld', 18:31:48 INFO - 'LANG': 'en_US.UTF-8', 18:31:48 INFO - 'LANGUAGE': 'en_US:en', 18:31:48 INFO - 'LOGNAME': 'cltbld', 18:31:48 INFO - 'MAIL': '/var/mail/cltbld', 18:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:48 INFO - 'MOZ_NO_REMOTE': '1', 18:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:48 INFO - 'NO_EM_RESTART': '1', 18:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:48 INFO - 'PWD': '/builds/slave/test', 18:31:48 INFO - 'SHELL': '/bin/bash', 18:31:48 INFO - 'SHLVL': '1', 18:31:48 INFO - 'TERM': 'linux', 18:31:48 INFO - 'TMOUT': '86400', 18:31:48 INFO - 'USER': 'cltbld', 18:31:48 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:48 INFO - '_': '/tools/buildbot/bin/python'} 18:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:48 INFO - Running setup.py (path:/tmp/pip-LEEx53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:48 INFO - Running setup.py (path:/tmp/pip-TR0ndB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:48 INFO - Running setup.py (path:/tmp/pip-kSSk7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:48 INFO - Running setup.py (path:/tmp/pip-VnKy3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:48 INFO - Running setup.py (path:/tmp/pip-XUV3pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:48 INFO - Running setup.py (path:/tmp/pip-Weng18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:48 INFO - Running setup.py (path:/tmp/pip-wrEs5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:48 INFO - Running setup.py (path:/tmp/pip-XnQ0oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:48 INFO - Running setup.py (path:/tmp/pip-pV6mCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:49 INFO - Running setup.py (path:/tmp/pip-9FPgvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:49 INFO - Running setup.py (path:/tmp/pip-bKR4p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:49 INFO - Running setup.py (path:/tmp/pip-RamtO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:49 INFO - Running setup.py (path:/tmp/pip-PI2kMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:49 INFO - Running setup.py (path:/tmp/pip-DRejN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:49 INFO - Running setup.py (path:/tmp/pip-8rDUQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:49 INFO - Running setup.py (path:/tmp/pip-21sLIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:49 INFO - Running setup.py (path:/tmp/pip-Zjwbbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:49 INFO - Running setup.py install for manifestparser 18:31:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:49 INFO - Running setup.py install for mozcrash 18:31:49 INFO - Running setup.py install for mozdebug 18:31:49 INFO - Running setup.py install for mozdevice 18:31:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozfile 18:31:50 INFO - Running setup.py install for mozhttpd 18:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozinfo 18:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozInstall 18:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozleak 18:31:50 INFO - Running setup.py install for mozlog 18:31:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for moznetwork 18:31:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozprocess 18:31:50 INFO - Running setup.py install for mozprofile 18:31:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:50 INFO - Running setup.py install for mozrunner 18:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:51 INFO - Running setup.py install for mozscreenshot 18:31:51 INFO - Running setup.py install for moztest 18:31:51 INFO - Running setup.py install for mozversion 18:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:51 INFO - Cleaning up... 18:31:51 INFO - Return code: 0 18:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:51 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:51 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 18:31:51 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 18:31:51 INFO - Using env: {'DISPLAY': ':0', 18:31:51 INFO - 'HOME': '/home/cltbld', 18:31:51 INFO - 'LANG': 'en_US.UTF-8', 18:31:51 INFO - 'LANGUAGE': 'en_US:en', 18:31:51 INFO - 'LOGNAME': 'cltbld', 18:31:51 INFO - 'MAIL': '/var/mail/cltbld', 18:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:51 INFO - 'MOZ_NO_REMOTE': '1', 18:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:51 INFO - 'NO_EM_RESTART': '1', 18:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:51 INFO - 'PWD': '/builds/slave/test', 18:31:51 INFO - 'SHELL': '/bin/bash', 18:31:51 INFO - 'SHLVL': '1', 18:31:51 INFO - 'TERM': 'linux', 18:31:51 INFO - 'TMOUT': '86400', 18:31:51 INFO - 'USER': 'cltbld', 18:31:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:51 INFO - '_': '/tools/buildbot/bin/python'} 18:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:51 INFO - Running setup.py (path:/tmp/pip-cU0rkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:51 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)) 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:51 INFO - Running setup.py (path:/tmp/pip-WqSnDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:51 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)) 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:51 INFO - Running setup.py (path:/tmp/pip-USc5x2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:51 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)) 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:51 INFO - Running setup.py (path:/tmp/pip-VWuGOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:51 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)) 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:51 INFO - Running setup.py (path:/tmp/pip-b1QzEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:51 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)) 18:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:51 INFO - Running setup.py (path:/tmp/pip-2zXQC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 INFO - Running setup.py (path:/tmp/pip-ZhVqPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 INFO - Running setup.py (path:/tmp/pip-ik4Rt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:52 INFO - Running setup.py (path:/tmp/pip-67_PnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:52 INFO - Running setup.py (path:/tmp/pip-71i3zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:52 INFO - Running setup.py (path:/tmp/pip-KDFCi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:52 INFO - Running setup.py (path:/tmp/pip-g0GX7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:52 INFO - Running setup.py (path:/tmp/pip-qy0lt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:52 INFO - Running setup.py (path:/tmp/pip-Yk_qSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:52 INFO - Running setup.py (path:/tmp/pip-op6UWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:52 INFO - Running setup.py (path:/tmp/pip-vhTvDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:52 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)) 18:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:52 INFO - Running setup.py (path:/tmp/pip-wbaSsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:52 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)) 18:31:52 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)) 18:31:52 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)) 18:31:52 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)) 18:31:52 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)) 18:31:52 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)) 18:31:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:54 INFO - Downloading blessings-1.6.tar.gz 18:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:54 INFO - Installing collected packages: blessings 18:31:54 INFO - Running setup.py install for blessings 18:31:54 INFO - Successfully installed blessings 18:31:54 INFO - Cleaning up... 18:31:54 INFO - Return code: 0 18:31:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:55 INFO - Reading from file tmpfile_stdout 18:31:55 INFO - Current package versions: 18:31:55 INFO - argparse == 1.2.1 18:31:55 INFO - blessings == 1.6 18:31:55 INFO - blobuploader == 1.2.4 18:31:55 INFO - docopt == 0.6.1 18:31:55 INFO - manifestparser == 1.1 18:31:55 INFO - mozInstall == 1.12 18:31:55 INFO - mozcrash == 0.17 18:31:55 INFO - mozdebug == 0.1 18:31:55 INFO - mozdevice == 0.48 18:31:55 INFO - mozfile == 1.2 18:31:55 INFO - mozhttpd == 0.7 18:31:55 INFO - mozinfo == 0.9 18:31:55 INFO - mozleak == 0.1 18:31:55 INFO - mozlog == 3.2 18:31:55 INFO - moznetwork == 0.27 18:31:55 INFO - mozprocess == 0.22 18:31:55 INFO - mozprofile == 0.28 18:31:55 INFO - mozrunner == 6.11 18:31:55 INFO - mozscreenshot == 0.1 18:31:55 INFO - mozsystemmonitor == 0.3 18:31:55 INFO - moztest == 0.7 18:31:55 INFO - mozversion == 1.4 18:31:55 INFO - psutil == 3.1.1 18:31:55 INFO - requests == 1.2.3 18:31:55 INFO - wsgiref == 0.1.2 18:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:55 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:55 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 18:31:55 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 18:31:55 INFO - Using env: {'DISPLAY': ':0', 18:31:55 INFO - 'HOME': '/home/cltbld', 18:31:55 INFO - 'LANG': 'en_US.UTF-8', 18:31:55 INFO - 'LANGUAGE': 'en_US:en', 18:31:55 INFO - 'LOGNAME': 'cltbld', 18:31:55 INFO - 'MAIL': '/var/mail/cltbld', 18:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:55 INFO - 'MOZ_NO_REMOTE': '1', 18:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:55 INFO - 'NO_EM_RESTART': '1', 18:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:55 INFO - 'PWD': '/builds/slave/test', 18:31:55 INFO - 'SHELL': '/bin/bash', 18:31:55 INFO - 'SHLVL': '1', 18:31:55 INFO - 'TERM': 'linux', 18:31:55 INFO - 'TMOUT': '86400', 18:31:55 INFO - 'USER': 'cltbld', 18:31:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:55 INFO - '_': '/tools/buildbot/bin/python'} 18:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 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)) 18:31:55 INFO - Cleaning up... 18:31:55 INFO - Return code: 0 18:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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')]} 18:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31: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', 'jsonschema'] in /builds/slave/test/build 18:31: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 jsonschema 18:31:55 INFO - Using env: {'DISPLAY': ':0', 18:31:55 INFO - 'HOME': '/home/cltbld', 18:31:55 INFO - 'LANG': 'en_US.UTF-8', 18:31:55 INFO - 'LANGUAGE': 'en_US:en', 18:31:55 INFO - 'LOGNAME': 'cltbld', 18:31:55 INFO - 'MAIL': '/var/mail/cltbld', 18:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:55 INFO - 'MOZ_NO_REMOTE': '1', 18:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:55 INFO - 'NO_EM_RESTART': '1', 18:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:55 INFO - 'PWD': '/builds/slave/test', 18:31:55 INFO - 'SHELL': '/bin/bash', 18:31:55 INFO - 'SHLVL': '1', 18:31:55 INFO - 'TERM': 'linux', 18:31:55 INFO - 'TMOUT': '86400', 18:31:55 INFO - 'USER': 'cltbld', 18:31:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:55 INFO - '_': '/tools/buildbot/bin/python'} 18:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:55 INFO - Downloading/unpacking jsonschema 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:57 INFO - Downloading/unpacking functools32 (from jsonschema) 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31: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 18:31:57 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:57 INFO - warning: no files found matching '*.txt' 18:31:57 INFO - no previously-included directories found matching 'build' 18:31:57 INFO - no previously-included directories found matching 'dist' 18:31:57 INFO - no previously-included directories found matching '.git*' 18:31:57 INFO - Installing collected packages: jsonschema, functools32 18:31:57 INFO - Running setup.py install for functools32 18:31:57 INFO - warning: no files found matching '*.txt' 18:31:57 INFO - no previously-included directories found matching 'build' 18:31:57 INFO - no previously-included directories found matching 'dist' 18:31:57 INFO - no previously-included directories found matching '.git*' 18:31:57 INFO - Successfully installed jsonschema functools32 18:31:57 INFO - Cleaning up... 18:31:57 INFO - Return code: 0 18:31:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:31:57 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')]} 18:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:57 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')]} 18:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:31:57 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 0x7f4d84471f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x234f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x241a770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', '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 18:31:57 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 18:31:57 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 18:31:57 INFO - Using env: {'DISPLAY': ':0', 18:31:57 INFO - 'HOME': '/home/cltbld', 18:31:57 INFO - 'LANG': 'en_US.UTF-8', 18:31:57 INFO - 'LANGUAGE': 'en_US:en', 18:31:57 INFO - 'LOGNAME': 'cltbld', 18:31:57 INFO - 'MAIL': '/var/mail/cltbld', 18:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:57 INFO - 'MOZ_NO_REMOTE': '1', 18:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:57 INFO - 'NO_EM_RESTART': '1', 18:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:57 INFO - 'PWD': '/builds/slave/test', 18:31:57 INFO - 'SHELL': '/bin/bash', 18:31:57 INFO - 'SHLVL': '1', 18:31:57 INFO - 'TERM': 'linux', 18:31:57 INFO - 'TMOUT': '86400', 18:31:57 INFO - 'USER': 'cltbld', 18:31:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:57 INFO - '_': '/tools/buildbot/bin/python'} 18:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:58 INFO - Downloading/unpacking flake8 18:31:58 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 18:31:58 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 18:31:58 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 18:31:58 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 18:31:58 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 18:31:58 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 18:32:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:32:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:32:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 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 18:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:00 INFO - no previously-included directories found matching 'docs/_build' 18:32:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:32:00 INFO - Running setup.py install for pep8 18:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:32:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:32:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:32:00 INFO - no previously-included directories found matching 'docs/_build' 18:32:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:32:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:32:00 INFO - Cleaning up... 18:32:01 INFO - Return code: 0 18:32:01 INFO - Running post-action listener: _resource_record_post_action 18:32:01 INFO - Running post-action listener: _start_resource_monitoring 18:32:01 INFO - Starting resource monitoring. 18:32:01 INFO - ##### 18:32:01 INFO - ##### Finished create-virtualenv step (success) 18:32:01 INFO - ##### 18:32:01 INFO - ##### 18:32:01 INFO - ##### Running install step. 18:32:01 INFO - ##### 18:32:01 INFO - Running pre-action listener: _resource_record_pre_action 18:32:01 INFO - Running main action method: install 18:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:32:01 INFO - Reading from file tmpfile_stdout 18:32:01 INFO - Detecting whether we're running mozinstall >=1.0... 18:32:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:32:01 INFO - Reading from file tmpfile_stdout 18:32:01 INFO - Output received: 18:32:01 INFO - Usage: mozinstall [options] installer 18:32:01 INFO - Options: 18:32:01 INFO - -h, --help show this help message and exit 18:32:01 INFO - -d DEST, --destination=DEST 18:32:01 INFO - Directory to install application into. [default: 18:32:01 INFO - "/builds/slave/test"] 18:32:01 INFO - --app=APP Application being installed. [default: firefox] 18:32:01 INFO - mkdir: /builds/slave/test/build/application 18:32:01 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'] 18:32:01 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 18:32:17 INFO - Reading from file tmpfile_stdout 18:32:17 INFO - Output received: 18:32:17 INFO - /builds/slave/test/build/application/firefox/firefox 18:32:17 INFO - Running post-action listener: _resource_record_post_action 18:32:17 INFO - ##### 18:32:17 INFO - ##### Finished install step (success) 18:32:17 INFO - ##### 18:32:17 INFO - ##### 18:32:17 INFO - ##### Running run-tests step. 18:32:17 INFO - ##### 18:32:17 INFO - Running pre-action listener: _resource_record_pre_action 18:32:17 INFO - Running main action method: run_tests 18:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:32:17 INFO - Python 2.7.3 18:32:17 INFO - Return code: 0 18:32:17 INFO - grabbing minidump binary from tooltool 18:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:32:17 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 0x24a99c0>, '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 0x24aa8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24aad50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:32:17 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 18:32:17 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 18:32:17 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 18:32:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:32:17 INFO - Return code: 0 18:32:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:32:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:32:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:32:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:32:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:32:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:32:18 INFO - Return code: 0 18:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:32:18 INFO - Using env: {'DISPLAY': ':0', 18:32:18 INFO - 'HOME': '/home/cltbld', 18:32:18 INFO - 'LANG': 'en_US.UTF-8', 18:32:18 INFO - 'LANGUAGE': 'en_US:en', 18:32:18 INFO - 'LOGNAME': 'cltbld', 18:32:18 INFO - 'MAIL': '/var/mail/cltbld', 18:32:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:32:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:32:18 INFO - 'MOZ_NO_REMOTE': '1', 18:32:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:32:18 INFO - 'NO_EM_RESTART': '1', 18:32:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:32:18 INFO - 'PWD': '/builds/slave/test', 18:32:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:32:18 INFO - 'SHELL': '/bin/bash', 18:32:18 INFO - 'SHLVL': '1', 18:32:18 INFO - 'TERM': 'linux', 18:32:18 INFO - 'TMOUT': '86400', 18:32:18 INFO - 'USER': 'cltbld', 18:32:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465', 18:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:32:18 INFO - '_': '/tools/buildbot/bin/python'} 18:32:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:32:18 INFO - mozversion application_buildid: 20160518172845 18:32:18 INFO - mozversion application_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 18:32:18 INFO - mozversion application_display_name: Nightly 18:32:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:32:18 INFO - mozversion application_name: Firefox 18:32:18 INFO - mozversion application_remotingname: firefox 18:32:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:32:18 INFO - mozversion application_vendor: Mozilla 18:32:18 INFO - mozversion application_version: 49.0a1 18:32:18 INFO - mozversion platform_buildid: 20160518172845 18:32:18 INFO - mozversion platform_changeset: 5bd03d0a58768dbe3184fa9f001372291bd679b8 18:32:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:32:18 INFO - mozversion platform_version: 49.0a1 18:32:18 INFO - using testdate: 1463621538 18:32:18 INFO - actual date: 1463621538 18:32:18 INFO - starting webserver on 'localhost:40243' 18:32:18 INFO - SUITE-START | Running 2 tests 18:32:18 INFO - TEST-START | dromaeo_css 18:32:18 INFO - operating with platform_type : linux_ 18:32:18 INFO - Initialising browser for dromaeo_css test... 18:32:18 INFO - TEST-INFO | started process 11187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUGXAO/profile http://localhost:40243/getInfo.html) 18:32:23 INFO - PROCESS | 11187 | __metrics Screen width/height:1600/1200 18:32:23 INFO - PROCESS | 11187 | colorDepth:24 18:32:23 INFO - PROCESS | 11187 | Browser inner width/height: 1024/697 18:32:23 INFO - PROCESS | 11187 | __metrics 18:32:23 ERROR - PROCESS | 11187 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:32:24 INFO - TEST-INFO | 11187: exit 0 18:32:24 INFO - Browser initialized. 18:32:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:32:24 INFO - TEST-INFO | started process 11269 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUUGXAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:36 INFO - PROCESS | 11269 | RSS: Main: 154669056 18:32:36 INFO - PROCESS | 11269 | 18:33:28 INFO - PROCESS | 11269 | 1463621608308 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] 18:35:40 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40243/tests/dromaeo/cssquery-ext.html) 18:35:41 INFO - PROCESS | 11269 | RSS: Main: 272928768 18:35:41 INFO - PROCESS | 11269 | 18:38:43 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-ext.html (next: http://localhost:40243/tests/dromaeo/cssquery-jquery.html) 18:38:44 INFO - PROCESS | 11269 | RSS: Main: 235167744 18:38:44 INFO - PROCESS | 11269 | 18:41:46 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40243/tests/dromaeo/cssquery-mootools.html) 18:41:47 INFO - PROCESS | 11269 | RSS: Main: 242237440 18:41:47 INFO - PROCESS | 11269 | 18:44:49 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40243/tests/dromaeo/cssquery-prototype.html) 18:44:49 INFO - PROCESS | 11269 | RSS: Main: 231976960 18:44:49 INFO - PROCESS | 11269 | 18:47:52 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40243/tests/dromaeo/cssquery-yui.html) 18:47:53 INFO - PROCESS | 11269 | RSS: Main: 225583104 18:47:53 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | Cycle 1(1): loaded http://localhost:40243/tests/dromaeo/cssquery-yui.html (next: http://localhost:40243/tests/dromaeo/cssquery-dojo.html) 18:50:56 INFO - PROCESS | 11269 | RSS: Main: 300052480 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | __start_tp_report 18:50:56 INFO - PROCESS | 11269 | _x_x_mozilla_page_load 18:50:56 INFO - PROCESS | 11269 | _x_x_mozilla_page_load_details 18:50:56 INFO - PROCESS | 11269 | |i|pagename|runs| 18:50:56 INFO - PROCESS | 11269 | |0;dojo.html;2709.810313278069;2710.620513128162;2731.9317017074573;2753.2703833484115;2780.3883145707937;4682.204025315696;4759.214729569617;4768.570828625423;4826.493218212086;4871.683340582864;4789.497102804207;4813.181759100952;4823.348847905531;4831.951680483194;4847.830325938593;4358.389825424443;4395.252807022814;4429.527523713581;4482.708623939449;4549.818007279721;4447.155040542287;4484.686071974963;4501.707389019703;4507.166174257773;4536.841210557631;4284.078923031532;4329.870103896888;4363.738175709467;4384.0355121873135;4409.9118017639785;4357.477102747691;4372.038151606642;4372.19114463822;4450.399196108517;4455.866324010285;4357.542458041923;4382.824687012516;4395.549865523365;4425.380446737459;4442.777861106932;4556.453225612914;4692.859214223578;4741.5495527924795;4753.453352864431;4785.521447855222;5172.844814655567;5224.52979231871;5231.712255825928;5239.423663397023;5244.842654720364;5204.583633309327;5252.501012403815;5260.421353651095;5273.604479664041;5275.841724748264;4703.0593881223895;4766.142094423037;4797.544233297831;4806.7836947337455;4861.95138048615;5253.527182553588;5277.102892508283;5308.946910530923;5312.04383211018;5333.280007198979;5070.909754402747;5075.061113693979;5100.846974590768;5129.589632829365;5134.306868572769;4982.128127577659;5119;5208.296879921238;5213.817516386908;5223.085959956992;5126.333576635014;5173.430922598511;5173.767180476812;5174.456682048406;5226.712530810766;5012.097822391932;5138.3833939927445;5148.176291793295;5152;5159.1487404578575;4294.957050429456;4295.613394794421;4296.806643701041;4297.871063868089;4306.074194048295;3781.5084039074745;3787.696984241254;3814.1418180909627;3825.7513261637905;3876.282887665791;4470.083632855257;4481.843135490242;4493.281075028045;4493.752843593568;4535.25168347219;4998.450170481244;5131;5147.3051138096625;5178.093833579184;5244.763985620656;4455.6658250631335;4494.348319493655;4503.392042074343;4506.143832671782;4552.021315417202;4646.79089440976;4653.464851542049;4655.2784318430695;4662.557057079572;4706.7411292378565;4718.174319494144;4859.1010663027455;4876.366072410706;4913.9017219656125;4923.015396920702;5229.084910140787;5242.370915490165;5245.370555533208;5245.370555533361;5250.343707036621;4874.171390863491;4889.608831293417;4894.070126675921;4917.918058027229;4982;4932.950670493393;5043.44522102561;5077.466865979019;5112.284280200701;5118.846434606968;5155.742212889266;5177.378714554277;5177.585793136615;5183.974080129575;5235.581153507786;4927.827526036572;5017.64876458659;5027.899442011212;5033.194688849767;5036.118679231046;4997.550220480174;5025;5054.570361519312;5060.342155519759;5066.189409694432;4987.600991920565;4992.775325110306;5030.597552195889;5036.370453693288;5045.7981680732355;4923.950760492493;4988.8752781180765;5089.312942752681;5125.487451254845;5145.511176438233;4816;4870.4155501340065;4882.389701287339;4907.730074845775;4933.876653083558 18:50:56 INFO - PROCESS | 11269 | |1;ext.html;574.5977815529128;605.3039005144085;611.4649681528663;616.6618437989562;635.869646722422;27632.171034868938;41749.79125104378;42323;42343.78828105855;42458.78770606146;43568.34647480283;43833.56166438335;43925.56074439255;44004.77997610007;44017;7568.053993250844;7856.764297071083;8033.1565185655545;8035.2366525180305;8035.839283214332;7397.631438183927;7728.188540203282;7730.652120654556;10088.445135517544;10422.21833362501;10175.898241017569;10229.641962531314;10243.180545556375;10243.3341832781;10305.84541231882;10031.74920626983;10096.293259471766;10114.595416183343;10123.746906327327;10124.341917775395;7448.702051917917;9728.562214700356;10112.443815590139;10115.443650599214;10121.595136194543;37154;37843.24313513714;37917.81041094777;41672.166556669;41730;3155.2900597365638;3177.3168768714604;3225.9999400185784;3267.4118658641437;3618.493410922473;30553.23616909573;30896.227594310098;31231;31323.53014704781;31362.37275254505;3528.6855049087085;3548.6983606393487;3578.2306804037257;3597.6328994982;3707.258548290326;288544;290153;290212;290276;290462;61129.38870611237;62134;62189.68905155445;62338;62457.375426245155;36009.81995090008;37099.81450092732;37146.62853371486;39014;39096.21807563833;14470.782938255934;14476.493322733864;14540.781888271684;14572.271386430848;14573.125612463286;10352.120069794002;11667.533298668128;11794.05647548194;11796.233244839059;11797.115216358636;20167.697484537744;20925.89537052305;21082.89458552728;21671.34985950424;21781.950526926244;7622.390208783284;7816.68733250675;7878.487898286593;7909.644066016928;7962.6416811243635;909.3407279722148;1013.7871047080048;1029.4698230411343;1052.400131924811;1082.826747720361;29718.851405742833;29808.552871706943;29841.701582983893;30119.397612047636;30222.244443889078;998.4259051045677;1044.7597052677775;1065.5098654618962;1080.773037662084;1114.5987444519967;15531.689366212839;15713.68572628541;15746.212689365486;15813.288402021937;16004.75992860108;127764;128271;128816.35591822168;129727;130116;51663.74168129135;52035.47964520382;52084;52103.21845172325;52150;1164.4759858063735;1276.3809552367095;1293.7865252233464;1300.13540995239;1316.4010375279224;29011;30741.846290768404;30793.384132317675;30915.0725478236;31110.53334200034;45338;45465;45793.08413831771;45815.77092114518;45858.54141458543;329446;330946;331443;331480;331708;23847.64228536608;24298.635520466854;24356.87821560881;25159.645549895795;27272.59091113595;43596.56403435925;44090;44310.335344970495;44414.555854441045;45200;37845.62154378531;37928.62071379251;38277.80861095788;38368.58307016488;38468.42297365486;37258.50736748669;37940.62059379371;37991.81004094962;38080.23839523138;38164.42753358757;36743.63256367509;37092.44361334636;37456.25087498289;37883.431748524345;37922.24155516819;32658.71389002747;33383;34332.31335373328;34415.13962150966;34661.65338346584;26060.218193454228;26342.20973370802;26374.340641484116;26408.8679556601;26516.204513864614 18:50:56 INFO - PROCESS | 11269 | |2;jquery.html;373.3634153767826;383.15514290988375;395.6281095769976;400.07183334663586;410.110061167267;16202.75695864563;17559.648807023852;18368.90815545922;18399.72400413995;18433.907830460845;17207.655846883055;17299.82700172998;17798.64402711948;17977.910110449462;18298.268069277212;5066.645334826573;5211.062008838408;5211.4788521147775;5240.79036838526;5262.81580144695;3729.720270979674;3856.421536769493;5040.470750571192;5981.940180598203;5994.1608174855555;5984.132300816379;6026.9095963560585;6028.698565071729;6045.848853778669;6057.545684073712;5790.218320526738;5901.114832775075;5923.229980102559;5934.614250073753;6045.697715114248;3416.453367461219;3574.946375804365;3576.7138628909884;3610.530631017977;4868.148074087056;20988;21689.240876569245;21789.891050544804;21814.781852181433;21881.12475500978;1997.3209108902897;2054.311805545144;2108.81020708137;2130.2331160782105;2157.1479265690123;13182.088597153455;13387.866121338759;13421.597352079454;13567.118137321042;13925.651858703512;1722.1733567887484;1755.1048965027928;1763.0567646309291;1901.1919934027983;1904.8952307623076;63708.999999999534;66832.33167668358;71157.28842711558;72497.63751181263;74237.25762742411;10237.43694096817;10314.638987635397;10489.790204195873;10644.467776611293;10777;14870.70258594822;14965;14965.551033469013;14971.475998340005;14973.176475293963;7153.642317884085;7212;7242.275772422716;7359.7056117755765;7391.85216295671;6683.832904177434;6692.330766923269;6819.659017049128;6851.725930962805;6950.54821436605;4587.77061146948;4604.608608268335;4604.631629469634;4639.118567472169;4728.645351598644;1657.6684663067435;1708.8120306766245;1766.399424195754;1793.157216108427;1820.8088150743981;857.511218605389;913.5751875377981;937.3344925103253;965.16513216069;980.1962390839585;16932.407365742387;17712.822871771117;17856.19647115883;17969.550761231072;18261.086945652663;856.0797143071223;899.8830152080319;953.561361773578;961.8893827209821;1019.6125472320471;9110.633404989172;9855.655052073143;9989.200863930868;10014.599416023277;10020.398776073458;393086;410450;410991;413442;413725;81164.59417702873;84530;85905.5704721485;87746.56126719326;87800.56099719461;997.6807421625156;1000.5297510170209;1018.923580731448;1026.1585499890018;1028.5628607841638;15296.694066118838;15420.072490938634;15578.143202123538;15610.531684049496;15861;34806.82596587001;35033.64966350406;36076.27847442984;37228;38175.80912095422;46682.29976550287;47514.524854752395;50416.49583504118;52853.735731321096;52999.470005300995;7071.151461824614;7391.667374968032;7821.217878212134;8264.090949995376;8275.469038227706;11522.884771152181;11561.942190289332;11718.589849355232;12278.570250041206;12310;10527.420991845522;10567.947160264457;10581.52383142745;10807.891921080689;10929.453527323443;5421.430749771375;9375.765605859908;10293.639722609672;10755.946220269161;10934.781304374028;6144;9207.907920920705;10217.846732299171;10583.417912014913;11068.446577671246;7517.849643007218;7647.311741943252;7666.271704188093;7683.615819208905;7685.884711729217;10789.136869050613;11167.944160279147;11265.380404077854;11285.943570282425;11330.660080197607 18:50:56 INFO - PROCESS | 11269 | |3;mootools.html;1327.720530290183;1512.56135720641;1513.9394424223033;1708.9230984605692;1843.8985855777935;6822.7270909163635;7817.765467035991;8029.47808392454;8033;8270.669173233064;7968.3625309975205;8132.634031468583;8146.429749917508;8146.470479418834;8155.266026057669;2289.6222123349626;2329.3710698111586;2330.487292795582;2331.114176612893;2332.4518738096535;2272.9545409091807;2293.587154312223;2316.444053427182;2316.895739691718;2318.7681231876763;2264.62633665445;2272.5909336319455;2283.54329134173;2316.027268547206;2318.107528601492;2194.3416974907464;2194.8792816395094;2197.846150769447;2199.5820794049077;2212.5132470856547;2234.6871437998693;2238.507528343762;2242.8654280743044;2247.0337754765446;2249.7300323961067;7842.098158711764;8043.235892590194;8088.352931765445;8090.757277281691;8094.352451803841;4689.812407503696;4791.856244312677;4796.52034796521;4798.832040878588;4808.038392321515;3094.860731267076;3181.9681803182134;3208.0856955767495;3211.020638705194;3240.643529211785;1006.4701653486642;1007.5466040281902;1012.2205901455911;1031.6028329093278;1051.673981065872;10982.505787239594;10988;11037.558497660004;11054.115670746402;11081.778364432746;4253.978730106392;4358.498772641124;4364.607185353333;4366.323219900921;4366.476022877275;8551.957240213884;8624.482531048157;8624.482531048157;8629.352798540134;8659.263962563253;4619.214733495314;4715.033418149271;4716.056788642285;4722.268048452495;4723.976380118146;3784.7161462890394;3853.865114720971;3857.614238576176;4045.1707399982934;4398.120375924827;3278.6229583597715;3370.1743072947284;3371;3573.4997100405963;3581;1082.3505896462218;1088.8584484017026;1095.4194277033184;1111.7387413957713;1114.849495318138;791.5962858941866;905.7735566108473;909.7907481279343;911.7082533589321;935.7988032572894;5460.645058071213;5590.049691552445;5597.552195824405;5618.606697531215;5619.136352992235;449.53473155284127;450.6552487347182;454.19380599435607;457.19533620826917;459.31561972660495;3828.9808550957623;3842.8462861485787;3890.4747859038666;3891.2217556488818;3927.0378757204667;9420.387674801115;9706.563204655808;9802.411855288705;9827.557759900821;9851.852222216672;9677.661281855102;9722.465264410384;9725.319227654138;9735.561899714388;9743.366681165702;7407.703691852265;7431.702731890772;7434.665440055211;7491.66287517063;7532.472726909174;5523.475269849358;5560.2493663356545;5685.924637507197;5754.913676294943;5820.388859169726;8950.104989500998;8984.86522702147;9212.815743684954;9249.445033298023;9250.02874698174;9014.729558113268;9161.404508706913;9187.908120918974;9218;9334.25325973907;7033.261507541634;7077.787666370017;7131.928680713127;7138.321859423347;7167.283271672791;6699.43054840344;7257.52826066304;7473.92526074754;7478.962605186939;7709.9614501927135;6597.80206593803;6916.481263905328;7029.29707029293;7079.185893622093;7179.928200717926;6534.673266336759;6692.130023096966;6735.326467353226;6937.687804048931;6963.234044255027;6092.451679348703;6168.629882207082;6219.751209951552;6232.439080482597;6237.220347456568;4453.487848897289;4472.79872405749;4746.7389293589185;4761.2382018876815;4785.449673287477;4707.082118986765;4723.622110231242;4763.666543341933;4801.207800712983;4844.539768721966 18:50:56 INFO - PROCESS | 11269 | |4;prototype.html;310.74984637366924;314.8268452351207;324.08930904159314;324.8814182823267;325.9136328872848;4658.813647454106;4803.591694705946;4837.346958160647;4891.239153904596;4900.705957642544;4646.3030545418205;4763.714177149373;4767.1419144553965;4805.543473370033;4806.663533552653;3774.2451509698035;3779.848806047755;3781.8676346327884;3814.771113733171;3846.8461261549505;3604.7476676632646;3700.3903302063554;3796.126890815114;3813.48517950076;3873.7288389812725;3788.867389641363;3808.7714737115725;3824.4072168813877;3829.7893615851117;3835.7698538087666;3785;3796.4305354196817;3804.353259945816;3816.637419445148;3835.4822099016833;3383.932321353559;3390.1016230698883;3392.3893699134146;3398.1844357354303;3431.330890476358;4595.172868883633;4628.560286772785;4630.027694184192;4647.279671650899;4663.626909847238;4350.369196466526;4366.694331396803;4376.5842244987;4391.429114215131;4392.648588112943;5032.647714659939;5039.596832253411;5059.418166910778;5063.493650634944;5064.404712515546;3544.2025544252597;3712.2389910068373;3720.3489389357023;3728.9627103728885;3737.336885086138;5230.215467679878;5235.712035838027;5240.410318931506;5246.580273578104;5258.92111618326;3814.8664796731982;3816.2558301131567;3818.694504439638;3824.9808750956067;3845.5000849889334;3561.554805649294;3851.268259030775;3873.4577159197734;3875.7093218008763;3895.8636447724193;4239.427677263591;4284.507281662586;4290.313549832012;4297.505786834491;4301.870943871689;5042.747862606855;5049.368828896388;5057.671251368649;5061;5123.410807757081;1225.3199474291675;1242.931638759877;1249.5193196062514;1255.6358655989661;1257.4781465691635;886.6276164011002;896.9103089690979;899.469313105271;901.5942825728448;907.2923119966437;4448.532904045093;4492.887677808016;4501.459824820977;4507.684462087688;4527.637788976874;4995.650304478651;5140.588752899759;5203.661761985459;5221.7128057956415;5237.162054071407;4408.977955110268;4419.690621656518;4427.911441771146;4441.422615060086;4493.146302202571;2737.534619114755;2739.1782465260344;2744.533429316981;2745.203890871665;2766.5988431677292;4709.7174169549935;4849.345338379274;4853.95146048542;4859.708417494961;4997.825076122391;5338.145896656516;5342.252084708144;5367.409584945653;5373.53407052449;5389.622726409192;4911.607071434277;4963.950360496421;4990.750462476862;5032.924506132485;5044.798208071636;5050.949490505195;5297.841064768063;5307.363116426053;5307.761150748149;5332.200169974535;5072.644914855925;5101.668391554537;5180.145276029413;5198.376194856642;5221.582273418041;4940.184869496493;4971.005798840174;4989.12690279207;4999.300097986212;5014.724190169576;3596.946045809367;3655.4151335786146;3667.394879844796;3693.501377314136;3701.7229055975645;5248.76380562868;5275.868103297448;5277.973610131925;5283.524482796567;5288.545649946295;5111.897762044812;5145.331106956071;5162.586993040472;5163.4578369270685;5172.612054095883;4908.214685650279;4913.65604407688;5068.417132029716;5144.794208231779;5148.562372198405;4935.654504184817;5002.499750025114;5002.649814512949;5023.2214006829;5030.547250747304;5087.287779710769;5099.158638824552;5110.134800797608;5134.5378915897745;5135.563477104339;4808.831690890802;5016.3227964225825;5021.44764075944;5024.799008039638;5031.396232452129 18:50:56 INFO - PROCESS | 11269 | |5;yui.html;698.9440844732421;781.992180078199;792.8810678398238;798.9161138080498;813.4184058398248;12334;12388.442520086595;12399.256044637317;12464.439100240488;12534.686632834173;12763.23420594765;12785.232886026844;12798.104132710714;12802.551910683127;12808.167469114502;668.1247565688939;682.4881338995754;683.0744341417383;835.7325655790149;850.9234168924795;677.844095857953;820.9055958564782;849.3163003781953;850.4812064640595;852.5353682243192;895.552223888056;900.6262401103534;903.3856977255464;904.9140331668514;905.9411138275991;895.0557162193883;900.0819164452222;900.8828852249165;901.9098090190994;902.3728508686465;518.476338897716;648.6400047973373;663.1677245057471;663.6184194088419;666.373608807724;12315.137940344179;12326.630201093982;12340.876591234151;12351.38243087851;12369.13416060876;12063.698407539794;12604.243745375306;12625.684357891034;12781.808272875915;12903.677408064874;10660.62687805931;10941.12471002318;11000.944995275053;11334.036606888425;11644.708882277926;4183.895402614929;4237.300845360512;4262.509811371701;4383.561643835623;4387.714798538117;45605.543944560464;45777;45784.31323530116;46208.537914620756;46266.53733462656;9736.707898763048;10049.072220530395;10171.796564068825;10180.083792458714;10441.84337234942;17746.645067098587;17767.378141764977;17775.377861775036;17797.377091801725;17799.911000444914;6557;6633.2703402625675;6653.9667301663185;6657.46740260778;6820.35206655367;3581.212133330663;3723.255348930225;3737.5514938207043;3783.3379158647126;3795.1460921292487;2669.7864170866283;2752.545829938038;2770.404363061911;2772.487089888377;2773.1126039667115;496.4390239029873;506.95183957524716;515.4896652314181;521.7000224870715;533.8638647144953;547.9479449452296;564.4919572384805;582.4495851420452;583.9270091238595;607.0226934635234;7953.761387158394;8054.23484768946;8077.555734434663;8161.387895907831;8225;501.24312288444713;544.8855740294582;595.7140572525126;617.7127635649355;620.2959640807626;3873.69010479161;4023.6177563131455;4085.7752823594988;4119.114390406077;4239.745615263094;55487.445125549035;56368;56584.71707641435;56921.43078569244;57040.71479642575;47463.288050679264;50897.74551127221;51409;52520;53086;48726.51273487291;49610.50389496059;50108;50311;50395.24407133896;8569.442986205877;8589.785255368666;8697.608607612547;8755.25580325654;8978.461292322481;33181.33637327288;33358.16604584808;33424.33151336911;33449;34054.82972585121;39714;42076.78961605173;42479.362809557264;42957.57042429536;43673.34489982716;11030.613928512785;11179.385133817717;11286.774264514499;11364.488598013275;11711;11852.940735296268;12097.516099356279;12185.573504927284;12512.74974500523;12810.167339122927;11229.550817967516;11521.596744114251;11664.586181616383;11720.179587428798;11774.587889423829;11148.832767508331;11602.419879006186;11910.749371315887;11916.880831191924;11924.642260732191;10887.23789334739;11700.47347869331;12103.273803571814;12119.212251203644;12130.878691212974;8550.230479256898;9261.398009129385;9280.535973201448;9340.953295233481;9587.856182157133;9090.409123406956;9091.954540227256;9312.906870931203;9517.857232141385;9641.228701703987 18:50:56 INFO - PROCESS | 11269 | __end_tp_report 18:50:56 INFO - PROCESS | 11269 | __start_cc_report 18:50:56 INFO - PROCESS | 11269 | _x_x_mozilla_cycle_collect,1074 18:50:56 INFO - PROCESS | 11269 | __end_cc_report 18:50:56 INFO - PROCESS | 11269 | __startTimestamp1463622656705__endTimestamp 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | ------- Summary: start ------- 18:50:56 INFO - PROCESS | 11269 | Number of tests: 6 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#0] dojo.html Cycles:165 Average:4770.52 Median:4889.61 stddev:503.52 (10.3%) stddev-sans-first:478.41 18:50:56 INFO - PROCESS | 11269 | Values: 2709.8 2710.6 2731.9 2753.3 2780.4 4682.2 4759.2 4768.6 4826.5 4871.7 4789.5 4813.2 4823.3 4832.0 4847.8 4358.4 4395.3 4429.5 4482.7 4549.8 4447.2 4484.7 4501.7 4507.2 4536.8 4284.1 4329.9 4363.7 4384.0 4409.9 4357.5 4372.0 4372.2 4450.4 4455.9 4357.5 4382.8 4395.5 4425.4 4442.8 4556.5 4692.9 4741.5 4753.5 4785.5 5172.8 5224.5 5231.7 5239.4 5244.8 5204.6 5252.5 5260.4 5273.6 5275.8 4703.1 4766.1 4797.5 4806.8 4862.0 5253.5 5277.1 5308.9 5312.0 5333.3 5070.9 5075.1 5100.8 5129.6 5134.3 4982.1 5119.0 5208.3 5213.8 5223.1 5126.3 5173.4 5173.8 5174.5 5226.7 5012.1 5138.4 5148.2 5152.0 5159.1 4295.0 4295.6 4296.8 4297.9 4306.1 3781.5 3787.7 3814.1 3825.8 3876.3 4470.1 4481.8 4493.3 4493.8 4535.3 4998.5 5131.0 5147.3 5178.1 5244.8 4455.7 4494.3 4503.4 4506.1 4552.0 4646.8 4653.5 4655.3 4662.6 4706.7 4718.2 4859.1 4876.4 4913.9 4923.0 5229.1 5242.4 5245.4 5245.4 5250.3 4874.2 4889.6 4894.1 4917.9 4982.0 4933.0 5043.4 5077.5 5112.3 5118.8 5155.7 5177.4 5177.6 5184.0 5235.6 4927.8 5017.6 5027.9 5033.2 5036.1 4997.6 5025.0 5054.6 5060.3 5066.2 4987.6 4992.8 5030.6 5036.4 5045.8 4924.0 4988.9 5089.3 5125.5 5145.5 4816.0 4870.4 4882.4 4907.7 4933.9 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#1] ext.html Cycles:180 Average:42562.25 Median:331194.50 stddev:69561.72 (21.0%) stddev-sans-first:69685.42 18:50:56 INFO - PROCESS | 11269 | Values: 574.6 605.3 611.5 616.7 635.9 27632.2 41749.8 42323.0 42343.8 42458.8 43568.3 43833.6 43925.6 44004.8 44017.0 7568.1 7856.8 8033.2 8035.2 8035.8 7397.6 7728.2 7730.7 10088.4 10422.2 10175.9 10229.6 10243.2 10243.3 10305.8 10031.7 10096.3 10114.6 10123.7 10124.3 7448.7 9728.6 10112.4 10115.4 10121.6 37154.0 37843.2 37917.8 41672.2 41730.0 3155.3 3177.3 3226.0 3267.4 3618.5 30553.2 30896.2 31231.0 31323.5 31362.4 3528.7 3548.7 3578.2 3597.6 3707.3 288544.0 290153.0 290212.0 290276.0 290462.0 61129.4 62134.0 62189.7 62338.0 62457.4 36009.8 37099.8 37146.6 39014.0 39096.2 14470.8 14476.5 14540.8 14572.3 14573.1 10352.1 11667.5 11794.1 11796.2 11797.1 20167.7 20925.9 21082.9 21671.3 21782.0 7622.4 7816.7 7878.5 7909.6 7962.6 909.3 1013.8 1029.5 1052.4 1082.8 29718.9 29808.6 29841.7 30119.4 30222.2 998.4 1044.8 1065.5 1080.8 1114.6 15531.7 15713.7 15746.2 15813.3 16004.8 127764.0 128271.0 128816.4 129727.0 130116.0 51663.7 52035.5 52084.0 52103.2 52150.0 1164.5 1276.4 1293.8 1300.1 1316.4 29011.0 30741.8 30793.4 30915.1 31110.5 45338.0 45465.0 45793.1 45815.8 45858.5 329446.0 330946.0 331443.0 331480.0 331708.0 23847.6 24298.6 24356.9 25159.6 27272.6 43596.6 44090.0 44310.3 44414.6 45200.0 37845.6 37928.6 38277.8 38368.6 38468.4 37258.5 37940.6 37991.8 38080.2 38164.4 36743.6 37092.4 37456.3 37883.4 37922.2 32658.7 33383.0 34332.3 34415.1 34661.7 26060.2 26342.2 26374.3 26408.9 26516.2 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#2] jquery.html Cycles:180 Average:25289.72 Median:20478.86 stddev:67478.20 (329.5%) stddev-sans-first:67641.56 18:50:56 INFO - PROCESS | 11269 | Values: 373.4 383.2 395.6 400.1 410.1 16202.8 17559.6 18368.9 18399.7 18433.9 17207.7 17299.8 17798.6 17977.9 18298.3 5066.6 5211.1 5211.5 5240.8 5262.8 3729.7 3856.4 5040.5 5981.9 5994.2 5984.1 6026.9 6028.7 6045.8 6057.5 5790.2 5901.1 5923.2 5934.6 6045.7 3416.5 3574.9 3576.7 3610.5 4868.1 20988.0 21689.2 21789.9 21814.8 21881.1 1997.3 2054.3 2108.8 2130.2 2157.1 13182.1 13387.9 13421.6 13567.1 13925.7 1722.2 1755.1 1763.1 1901.2 1904.9 63709.0 66832.3 71157.3 72497.6 74237.3 10237.4 10314.6 10489.8 10644.5 10777.0 14870.7 14965.0 14965.6 14971.5 14973.2 7153.6 7212.0 7242.3 7359.7 7391.9 6683.8 6692.3 6819.7 6851.7 6950.5 4587.8 4604.6 4604.6 4639.1 4728.6 1657.7 1708.8 1766.4 1793.2 1820.8 857.5 913.6 937.3 965.2 980.2 16932.4 17712.8 17856.2 17969.6 18261.1 856.1 899.9 953.6 961.9 1019.6 9110.6 9855.7 9989.2 10014.6 10020.4 393086.0 410450.0 410991.0 413442.0 413725.0 81164.6 84530.0 85905.6 87746.6 87800.6 997.7 1000.5 1018.9 1026.2 1028.6 15296.7 15420.1 15578.1 15610.5 15861.0 34806.8 35033.6 36076.3 37228.0 38175.8 46682.3 47514.5 50416.5 52853.7 52999.5 7071.2 7391.7 7821.2 8264.1 8275.5 11522.9 11561.9 11718.6 12278.6 12310.0 10527.4 10567.9 10581.5 10807.9 10929.5 5421.4 9375.8 10293.6 10755.9 10934.8 6144.0 9207.9 10217.8 10583.4 11068.4 7517.8 7647.3 7666.3 7683.6 7685.9 10789.1 11167.9 11265.4 11285.9 11330.7 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#3] mootools.html Cycles:180 Average:5236.79 Median:4797.68 stddev:2920.06 (60.9%) stddev-sans-first:2913.47 18:50:56 INFO - PROCESS | 11269 | Values: 1327.7 1512.6 1513.9 1708.9 1843.9 6822.7 7817.8 8029.5 8033.0 8270.7 7968.4 8132.6 8146.4 8146.5 8155.3 2289.6 2329.4 2330.5 2331.1 2332.5 2273.0 2293.6 2316.4 2316.9 2318.8 2264.6 2272.6 2283.5 2316.0 2318.1 2194.3 2194.9 2197.8 2199.6 2212.5 2234.7 2238.5 2242.9 2247.0 2249.7 7842.1 8043.2 8088.4 8090.8 8094.4 4689.8 4791.9 4796.5 4798.8 4808.0 3094.9 3182.0 3208.1 3211.0 3240.6 1006.5 1007.5 1012.2 1031.6 1051.7 10982.5 10988.0 11037.6 11054.1 11081.8 4254.0 4358.5 4364.6 4366.3 4366.5 8552.0 8624.5 8624.5 8629.4 8659.3 4619.2 4715.0 4716.1 4722.3 4724.0 3784.7 3853.9 3857.6 4045.2 4398.1 3278.6 3370.2 3371.0 3573.5 3581.0 1082.4 1088.9 1095.4 1111.7 1114.8 791.6 905.8 909.8 911.7 935.8 5460.6 5590.0 5597.6 5618.6 5619.1 449.5 450.7 454.2 457.2 459.3 3829.0 3842.8 3890.5 3891.2 3927.0 9420.4 9706.6 9802.4 9827.6 9851.9 9677.7 9722.5 9725.3 9735.6 9743.4 7407.7 7431.7 7434.7 7491.7 7532.5 5523.5 5560.2 5685.9 5754.9 5820.4 8950.1 8984.9 9212.8 9249.4 9250.0 9014.7 9161.4 9187.9 9218.0 9334.3 7033.3 7077.8 7131.9 7138.3 7167.3 6699.4 7257.5 7473.9 7479.0 7710.0 6597.8 6916.5 7029.3 7079.2 7179.9 6534.7 6692.1 6735.3 6937.7 6963.2 6092.5 6168.6 6219.8 6232.4 6237.2 4453.5 4472.8 4746.7 4761.2 4785.4 4707.1 4723.6 4763.7 4801.2 4844.5 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#4] prototype.html Cycles:180 Average:4229.44 Median:4804.57 stddev:1221.78 (25.4%) stddev-sans-first:1189.28 18:50:56 INFO - PROCESS | 11269 | Values: 310.7 314.8 324.1 324.9 325.9 4658.8 4803.6 4837.3 4891.2 4900.7 4646.3 4763.7 4767.1 4805.5 4806.7 3774.2 3779.8 3781.9 3814.8 3846.8 3604.7 3700.4 3796.1 3813.5 3873.7 3788.9 3808.8 3824.4 3829.8 3835.8 3785.0 3796.4 3804.4 3816.6 3835.5 3383.9 3390.1 3392.4 3398.2 3431.3 4595.2 4628.6 4630.0 4647.3 4663.6 4350.4 4366.7 4376.6 4391.4 4392.6 5032.6 5039.6 5059.4 5063.5 5064.4 3544.2 3712.2 3720.3 3729.0 3737.3 5230.2 5235.7 5240.4 5246.6 5258.9 3814.9 3816.3 3818.7 3825.0 3845.5 3561.6 3851.3 3873.5 3875.7 3895.9 4239.4 4284.5 4290.3 4297.5 4301.9 5042.7 5049.4 5057.7 5061.0 5123.4 1225.3 1242.9 1249.5 1255.6 1257.5 886.6 896.9 899.5 901.6 907.3 4448.5 4492.9 4501.5 4507.7 4527.6 4995.7 5140.6 5203.7 5221.7 5237.2 4409.0 4419.7 4427.9 4441.4 4493.1 2737.5 2739.2 2744.5 2745.2 2766.6 4709.7 4849.3 4854.0 4859.7 4997.8 5338.1 5342.3 5367.4 5373.5 5389.6 4911.6 4964.0 4990.8 5032.9 5044.8 5050.9 5297.8 5307.4 5307.8 5332.2 5072.6 5101.7 5180.1 5198.4 5221.6 4940.2 4971.0 4989.1 4999.3 5014.7 3596.9 3655.4 3667.4 3693.5 3701.7 5248.8 5275.9 5278.0 5283.5 5288.5 5111.9 5145.3 5162.6 5163.5 5172.6 4908.2 4913.7 5068.4 5144.8 5148.6 4935.7 5002.5 5002.6 5023.2 5030.5 5087.3 5099.2 5110.1 5134.5 5135.6 4808.8 5016.3 5021.4 5024.8 5031.4 18:50:56 INFO - PROCESS | 11269 | 18:50:56 INFO - PROCESS | 11269 | [#5] yui.html Cycles:180 Average:13613.99 Median:45780.66 stddev:15772.74 (34.5%) stddev-sans-first:15787.17 18:50:56 INFO - PROCESS | 11269 | Values: 698.9 782.0 792.9 798.9 813.4 12334.0 12388.4 12399.3 12464.4 12534.7 12763.2 12785.2 12798.1 12802.6 12808.2 668.1 682.5 683.1 835.7 850.9 677.8 820.9 849.3 850.5 852.5 895.6 900.6 903.4 904.9 905.9 895.1 900.1 900.9 901.9 902.4 518.5 648.6 663.2 663.6 666.4 12315.1 12326.6 12340.9 12351.4 12369.1 12063.7 12604.2 12625.7 12781.8 12903.7 10660.6 10941.1 11000.9 11334.0 11644.7 4183.9 4237.3 4262.5 4383.6 4387.7 45605.5 45777.0 45784.3 46208.5 46266.5 9736.7 10049.1 10171.8 10180.1 10441.8 17746.6 17767.4 17775.4 17797.4 17799.9 6557.0 6633.3 6654.0 6657.5 6820.4 3581.2 3723.3 3737.6 3783.3 3795.1 2669.8 2752.5 2770.4 2772.5 2773.1 496.4 507.0 515.5 521.7 533.9 547.9 564.5 582.4 583.9 607.0 7953.8 8054.2 8077.6 8161.4 8225.0 501.2 544.9 595.7 617.7 620.3 3873.7 4023.6 4085.8 4119.1 4239.7 55487.4 56368.0 56584.7 56921.4 57040.7 47463.3 50897.7 51409.0 52520.0 53086.0 48726.5 49610.5 50108.0 50311.0 50395.2 8569.4 8589.8 8697.6 8755.3 8978.5 33181.3 33358.2 33424.3 33449.0 34054.8 39714.0 42076.8 42479.4 42957.6 43673.3 11030.6 11179.4 11286.8 11364.5 11711.0 11852.9 12097.5 12185.6 12512.7 12810.2 11229.6 11521.6 11664.6 11720.2 11774.6 11148.8 11602.4 11910.7 11916.9 11924.6 10887.2 11700.5 12103.3 12119.2 12130.9 8550.2 9261.4 9280.5 9341.0 9587.9 9090.4 9092.0 9312.9 9517.9 9641.2 18:50:56 INFO - PROCESS | 11269 | -------- Summary: end -------- 18:50:56 INFO - PROCESS | 11269 | 18:50:57 INFO - TEST-INFO | 11269: exit 0 18:50:57 INFO - TEST-OK | dromaeo_css | took 1119090ms 18:50:57 INFO - TEST-START | kraken 18:50:57 INFO - operating with platform_type : linux_ 18:50:57 INFO - Initialising browser for kraken test... 18:50:57 INFO - TEST-INFO | started process 11444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3tSboI/profile http://localhost:40243/getInfo.html) 18:51:01 INFO - PROCESS | 11444 | __metrics Screen width/height:1600/1200 18:51:01 INFO - PROCESS | 11444 | colorDepth:24 18:51:01 INFO - PROCESS | 11444 | Browser inner width/height: 1024/697 18:51:01 INFO - PROCESS | 11444 | __metrics 18:51:02 ERROR - PROCESS | 11444 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:51:03 INFO - TEST-INFO | 11444: exit 0 18:51:03 INFO - Browser initialized. 18:51:03 INFO - Running cycle 1/1 for kraken test... 18:51:03 INFO - TEST-INFO | started process 11523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3tSboI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:51:15 INFO - PROCESS | 11523 | RSS: Main: 154497024 18:51:15 INFO - PROCESS | 11523 | 18:51:18 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40243/tests/kraken/driver.html?testName=audio-beat-detection) 18:51:19 INFO - PROCESS | 11523 | RSS: Main: 210657280 18:51:19 INFO - PROCESS | 11523 | 18:51:22 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40243/tests/kraken/driver.html?testName=audio-dft) 18:51:22 INFO - PROCESS | 11523 | RSS: Main: 198471680 18:51:22 INFO - PROCESS | 11523 | 18:51:25 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40243/tests/kraken/driver.html?testName=audio-fft) 18:51:26 INFO - PROCESS | 11523 | RSS: Main: 267575296 18:51:26 INFO - PROCESS | 11523 | 18:51:28 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40243/tests/kraken/driver.html?testName=audio-oscillator) 18:51:29 INFO - PROCESS | 11523 | RSS: Main: 176603136 18:51:29 INFO - PROCESS | 11523 | 18:51:31 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:51:32 INFO - PROCESS | 11523 | RSS: Main: 180068352 18:51:32 INFO - PROCESS | 11523 | 18:51:35 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40243/tests/kraken/driver.html?testName=imaging-darkroom) 18:51:36 INFO - PROCESS | 11523 | RSS: Main: 215920640 18:51:36 INFO - PROCESS | 11523 | 18:51:39 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40243/tests/kraken/driver.html?testName=imaging-desaturate) 18:51:40 INFO - PROCESS | 11523 | RSS: Main: 215461888 18:51:40 INFO - PROCESS | 11523 | 18:51:43 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40243/tests/kraken/driver.html?testName=json-parse-financial) 18:51:44 INFO - PROCESS | 11523 | RSS: Main: 215543808 18:51:44 INFO - PROCESS | 11523 | 18:51:46 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:46 INFO - PROCESS | 11523 | RSS: Main: 201994240 18:51:46 INFO - PROCESS | 11523 | 18:51:48 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:49 INFO - PROCESS | 11523 | RSS: Main: 206217216 18:51:49 INFO - PROCESS | 11523 | 18:51:51 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:52 INFO - PROCESS | 11523 | RSS: Main: 216039424 18:51:52 INFO - PROCESS | 11523 | 18:51:55 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:55 INFO - PROCESS | 11523 | RSS: Main: 224120832 18:51:55 INFO - PROCESS | 11523 | 18:51:58 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:59 INFO - PROCESS | 11523 | RSS: Main: 220897280 18:51:59 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | Cycle 1(1): loaded http://localhost:40243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40243/tests/kraken/driver.html?testName=ai-astar) 18:52:01 INFO - PROCESS | 11523 | RSS: Main: 267534336 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | __start_tp_report 18:52:01 INFO - PROCESS | 11523 | _x_x_mozilla_page_load 18:52:01 INFO - PROCESS | 11523 | _x_x_mozilla_page_load_details 18:52:01 INFO - PROCESS | 11523 | |i|pagename|runs| 18:52:01 INFO - PROCESS | 11523 | |0;ai-astar;113;107;112;115;115;114;112;113;111;114 18:52:01 INFO - PROCESS | 11523 | |1;audio-beat-detection;165;128;167;212;131;173;165;131;181;130 18:52:01 INFO - PROCESS | 11523 | |2;audio-dft;162;164;162;162;162;163;163;163;161;160 18:52:01 INFO - PROCESS | 11523 | |3;audio-fft;77;76;76;147;76;75;77;75;141;75 18:52:01 INFO - PROCESS | 11523 | |4;audio-oscillator;94;95;156;94;95;96;130;94;93;129 18:52:01 INFO - PROCESS | 11523 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 18:52:01 INFO - PROCESS | 11523 | |6;imaging-darkroom;146;145;147;146;146;145;146;146;146;146 18:52:01 INFO - PROCESS | 11523 | |7;imaging-desaturate;94;95;96;95;95;94;94;95;94;94 18:52:01 INFO - PROCESS | 11523 | |8;json-parse-financial;64;65;65;68;66;63;64;138;61;62 18:52:01 INFO - PROCESS | 11523 | |9;json-stringify-tinderbox;64;65;65;64;65;65;64;65;65;65 18:52:01 INFO - PROCESS | 11523 | |10;stanford-crypto-aes;94;84;83;88;82;82;83;82;88;82 18:52:01 INFO - PROCESS | 11523 | |11;stanford-crypto-ccm;133;130;127;133;126;135;135;129;198;128 18:52:01 INFO - PROCESS | 11523 | |12;stanford-crypto-pbkdf2;167;168;166;172;168;169;166;170;170;170 18:52:01 INFO - PROCESS | 11523 | |13;stanford-crypto-sha256-iterative;67;66;71;66;67;65;66;66;65;64 18:52:01 INFO - PROCESS | 11523 | __end_tp_report 18:52:01 INFO - PROCESS | 11523 | __start_cc_report 18:52:01 INFO - PROCESS | 11523 | _x_x_mozilla_cycle_collect,2157 18:52:01 INFO - PROCESS | 11523 | __end_cc_report 18:52:01 INFO - PROCESS | 11523 | __startTimestamp1463622721356__endTimestamp 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | ------- Summary: start ------- 18:52:01 INFO - PROCESS | 11523 | Number of tests: 14 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:2.37 (2.1%) stddev-sans-first:2.51 18:52:01 INFO - PROCESS | 11523 | Values: 113.0 107.0 112.0 115.0 115.0 114.0 112.0 113.0 111.0 114.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#1] audio-beat-detection Cycles:10 Average:158.30 Median:166.00 stddev:27.87 (16.8%) stddev-sans-first:29.45 18:52:01 INFO - PROCESS | 11523 | Values: 165.0 128.0 167.0 212.0 131.0 173.0 165.0 131.0 181.0 130.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.20 18:52:01 INFO - PROCESS | 11523 | Values: 162.0 164.0 162.0 162.0 162.0 163.0 163.0 163.0 161.0 160.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#3] audio-fft Cycles:10 Average:89.50 Median:76.00 stddev:28.77 (37.9%) stddev-sans-first:30.16 18:52:01 INFO - PROCESS | 11523 | Values: 77.0 76.0 76.0 147.0 76.0 75.0 77.0 75.0 141.0 75.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:94.00 stddev:22.42 (23.8%) stddev-sans-first:23.23 18:52:01 INFO - PROCESS | 11523 | Values: 94.0 95.0 156.0 94.0 95.0 96.0 130.0 94.0 93.0 129.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:52:01 INFO - PROCESS | 11523 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:52:01 INFO - PROCESS | 11523 | Values: 146.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 18:52:01 INFO - PROCESS | 11523 | Values: 94.0 95.0 96.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:64.50 stddev:23.42 (36.3%) stddev-sans-first:24.67 18:52:01 INFO - PROCESS | 11523 | Values: 64.0 65.0 65.0 68.0 66.0 63.0 64.0 138.0 61.0 62.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 18:52:01 INFO - PROCESS | 11523 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 65.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.50 stddev:3.99 (4.8%) stddev-sans-first:2.49 18:52:01 INFO - PROCESS | 11523 | Values: 94.0 84.0 83.0 88.0 82.0 82.0 83.0 82.0 88.0 82.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:133.00 stddev:21.54 (16.2%) stddev-sans-first:22.78 18:52:01 INFO - PROCESS | 11523 | Values: 133.0 130.0 127.0 133.0 126.0 135.0 135.0 129.0 198.0 128.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.50 stddev:1.96 (1.2%) stddev-sans-first:1.99 18:52:01 INFO - PROCESS | 11523 | Values: 167.0 168.0 166.0 172.0 168.0 169.0 166.0 170.0 170.0 170.0 18:52:01 INFO - PROCESS | 11523 | 18:52:01 INFO - PROCESS | 11523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.89 (2.9%) stddev-sans-first:1.99 18:52:01 INFO - PROCESS | 11523 | Values: 67.0 66.0 71.0 66.0 67.0 65.0 66.0 66.0 65.0 64.0 18:52:01 INFO - PROCESS | 11523 | -------- Summary: end -------- 18:52:01 INFO - PROCESS | 11523 | 18:52:02 INFO - TEST-INFO | 11523: exit 0 18:52:02 INFO - TEST-OK | kraken | took 64914ms 18:52:02 INFO - SUITE-END | took 1184s 18:52:02 INFO - Completed test suite (00:19:44) 18:52:02 INFO - javascript benchmark 18:52:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2709.810313278069, 2710.620513128162, 2731.9317017074573, 2753.2703833484115, 2780.3883145707937, 4682.204025315696, 4759.214729569617, 4768.570828625423, 4826.493218212086, 4871.683340582864, 4789.497102804207, 4813.181759100952, 4823.348847905531, 4831.951680483194, 4847.830325938593, 4358.389825424443, 4395.252807022814, 4429.527523713581, 4482.708623939449, 4549.818007279721, 4447.155040542287, 4484.686071974963, 4501.707389019703, 4507.166174257773, 4536.841210557631, 4284.078923031532, 4329.870103896888, 4363.738175709467, 4384.0355121873135, 4409.9118017639785, 4357.477102747691, 4372.038151606642, 4372.19114463822, 4450.399196108517, 4455.866324010285, 4357.542458041923, 4382.824687012516, 4395.549865523365, 4425.380446737459, 4442.777861106932, 4556.453225612914, 4692.859214223578, 4741.5495527924795, 4753.453352864431, 4785.521447855222, 5172.844814655567, 5224.52979231871, 5231.712255825928, 5239.423663397023, 5244.842654720364, 5204.583633309327, 5252.501012403815, 5260.421353651095, 5273.604479664041, 5275.841724748264, 4703.0593881223895, 4766.142094423037, 4797.544233297831, 4806.7836947337455, 4861.95138048615, 5253.527182553588, 5277.102892508283, 5308.946910530923, 5312.04383211018, 5333.280007198979, 5070.909754402747, 5075.061113693979, 5100.846974590768, 5129.589632829365, 5134.306868572769, 4982.128127577659, 5119.0, 5208.296879921238, 5213.817516386908, 5223.085959956992, 5126.333576635014, 5173.430922598511, 5173.767180476812, 5174.456682048406, 5226.712530810766, 5012.097822391932, 5138.3833939927445, 5148.176291793295, 5152.0, 5159.1487404578575, 4294.957050429456, 4295.613394794421, 4296.806643701041, 4297.871063868089, 4306.074194048295, 3781.5084039074745, 3787.696984241254, 3814.1418180909627, 3825.7513261637905, 3876.282887665791, 4470.083632855257, 4481.843135490242, 4493.281075028045, 4493.752843593568, 4535.25168347219, 4998.450170481244, 5131.0, 5147.3051138096625, 5178.093833579184, 5244.763985620656, 4455.6658250631335, 4494.348319493655, 4503.392042074343, 4506.143832671782, 4552.021315417202, 4646.79089440976, 4653.464851542049, 4655.2784318430695, 4662.557057079572, 4706.7411292378565, 4718.174319494144, 4859.1010663027455, 4876.366072410706, 4913.9017219656125, 4923.015396920702, 5229.084910140787, 5242.370915490165, 5245.370555533208, 5245.370555533361, 5250.343707036621, 4874.171390863491, 4889.608831293417, 4894.070126675921, 4917.918058027229, 4982.0, 4932.950670493393, 5043.44522102561, 5077.466865979019, 5112.284280200701, 5118.846434606968, 5155.742212889266, 5177.378714554277, 5177.585793136615, 5183.974080129575, 5235.581153507786, 4927.827526036572, 5017.64876458659, 5027.899442011212, 5033.194688849767, 5036.118679231046, 4997.550220480174, 5025.0, 5054.570361519312, 5060.342155519759, 5066.189409694432, 4987.600991920565, 4992.775325110306, 5030.597552195889, 5036.370453693288, 5045.7981680732355, 4923.950760492493, 4988.8752781180765, 5089.312942752681, 5125.487451254845, 5145.511176438233, 4816.0, 4870.4155501340065, 4882.389701287339, 4907.730074845775, 4933.876653083558], "value": 4738.627091307942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.5977815529128, 605.3039005144085, 611.4649681528663, 616.6618437989562, 635.869646722422, 27632.171034868938, 41749.79125104378, 42323.0, 42343.78828105855, 42458.78770606146, 43568.34647480283, 43833.56166438335, 43925.56074439255, 44004.77997610007, 44017.0, 7568.053993250844, 7856.764297071083, 8033.1565185655545, 8035.2366525180305, 8035.839283214332, 7397.631438183927, 7728.188540203282, 7730.652120654556, 10088.445135517544, 10422.21833362501, 10175.898241017569, 10229.641962531314, 10243.180545556375, 10243.3341832781, 10305.84541231882, 10031.74920626983, 10096.293259471766, 10114.595416183343, 10123.746906327327, 10124.341917775395, 7448.702051917917, 9728.562214700356, 10112.443815590139, 10115.443650599214, 10121.595136194543, 37154.0, 37843.24313513714, 37917.81041094777, 41672.166556669, 41730.0, 3155.2900597365638, 3177.3168768714604, 3225.9999400185784, 3267.4118658641437, 3618.493410922473, 30553.23616909573, 30896.227594310098, 31231.0, 31323.53014704781, 31362.37275254505, 3528.6855049087085, 3548.6983606393487, 3578.2306804037257, 3597.6328994982, 3707.258548290326, 288544.0, 290153.0, 290212.0, 290276.0, 290462.0, 61129.38870611237, 62134.0, 62189.68905155445, 62338.0, 62457.375426245155, 36009.81995090008, 37099.81450092732, 37146.62853371486, 39014.0, 39096.21807563833, 14470.782938255934, 14476.493322733864, 14540.781888271684, 14572.271386430848, 14573.125612463286, 10352.120069794002, 11667.533298668128, 11794.05647548194, 11796.233244839059, 11797.115216358636, 20167.697484537744, 20925.89537052305, 21082.89458552728, 21671.34985950424, 21781.950526926244, 7622.390208783284, 7816.68733250675, 7878.487898286593, 7909.644066016928, 7962.6416811243635, 909.3407279722148, 1013.7871047080048, 1029.4698230411343, 1052.400131924811, 1082.826747720361, 29718.851405742833, 29808.552871706943, 29841.701582983893, 30119.397612047636, 30222.244443889078, 998.4259051045677, 1044.7597052677775, 1065.5098654618962, 1080.773037662084, 1114.5987444519967, 15531.689366212839, 15713.68572628541, 15746.212689365486, 15813.288402021937, 16004.75992860108, 127764.0, 128271.0, 128816.35591822168, 129727.0, 130116.0, 51663.74168129135, 52035.47964520382, 52084.0, 52103.21845172325, 52150.0, 1164.4759858063735, 1276.3809552367095, 1293.7865252233464, 1300.13540995239, 1316.4010375279224, 29011.0, 30741.846290768404, 30793.384132317675, 30915.0725478236, 31110.53334200034, 45338.0, 45465.0, 45793.08413831771, 45815.77092114518, 45858.54141458543, 329446.0, 330946.0, 331443.0, 331480.0, 331708.0, 23847.64228536608, 24298.635520466854, 24356.87821560881, 25159.645549895795, 27272.59091113595, 43596.56403435925, 44090.0, 44310.335344970495, 44414.555854441045, 45200.0, 37845.62154378531, 37928.62071379251, 38277.80861095788, 38368.58307016488, 38468.42297365486, 37258.50736748669, 37940.62059379371, 37991.81004094962, 38080.23839523138, 38164.42753358757, 36743.63256367509, 37092.44361334636, 37456.25087498289, 37883.431748524345, 37922.24155516819, 32658.71389002747, 33383.0, 34332.31335373328, 34415.13962150966, 34661.65338346584, 26060.218193454228, 26342.20973370802, 26374.340641484116, 26408.8679556601, 26516.204513864614], "value": 18141.532296833127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3634153767826, 383.15514290988375, 395.6281095769976, 400.07183334663586, 410.110061167267, 16202.75695864563, 17559.648807023852, 18368.90815545922, 18399.72400413995, 18433.907830460845, 17207.655846883055, 17299.82700172998, 17798.64402711948, 17977.910110449462, 18298.268069277212, 5066.645334826573, 5211.062008838408, 5211.4788521147775, 5240.79036838526, 5262.81580144695, 3729.720270979674, 3856.421536769493, 5040.470750571192, 5981.940180598203, 5994.1608174855555, 5984.132300816379, 6026.9095963560585, 6028.698565071729, 6045.848853778669, 6057.545684073712, 5790.218320526738, 5901.114832775075, 5923.229980102559, 5934.614250073753, 6045.697715114248, 3416.453367461219, 3574.946375804365, 3576.7138628909884, 3610.530631017977, 4868.148074087056, 20988.0, 21689.240876569245, 21789.891050544804, 21814.781852181433, 21881.12475500978, 1997.3209108902897, 2054.311805545144, 2108.81020708137, 2130.2331160782105, 2157.1479265690123, 13182.088597153455, 13387.866121338759, 13421.597352079454, 13567.118137321042, 13925.651858703512, 1722.1733567887484, 1755.1048965027928, 1763.0567646309291, 1901.1919934027983, 1904.8952307623076, 63708.999999999534, 66832.33167668358, 71157.28842711558, 72497.63751181263, 74237.25762742411, 10237.43694096817, 10314.638987635397, 10489.790204195873, 10644.467776611293, 10777.0, 14870.70258594822, 14965.0, 14965.551033469013, 14971.475998340005, 14973.176475293963, 7153.642317884085, 7212.0, 7242.275772422716, 7359.7056117755765, 7391.85216295671, 6683.832904177434, 6692.330766923269, 6819.659017049128, 6851.725930962805, 6950.54821436605, 4587.77061146948, 4604.608608268335, 4604.631629469634, 4639.118567472169, 4728.645351598644, 1657.6684663067435, 1708.8120306766245, 1766.399424195754, 1793.157216108427, 1820.8088150743981, 857.511218605389, 913.5751875377981, 937.3344925103253, 965.16513216069, 980.1962390839585, 16932.407365742387, 17712.822871771117, 17856.19647115883, 17969.550761231072, 18261.086945652663, 856.0797143071223, 899.8830152080319, 953.561361773578, 961.8893827209821, 1019.6125472320471, 9110.633404989172, 9855.655052073143, 9989.200863930868, 10014.599416023277, 10020.398776073458, 393086.0, 410450.0, 410991.0, 413442.0, 413725.0, 81164.59417702873, 84530.0, 85905.5704721485, 87746.56126719326, 87800.56099719461, 997.6807421625156, 1000.5297510170209, 1018.923580731448, 1026.1585499890018, 1028.5628607841638, 15296.694066118838, 15420.072490938634, 15578.143202123538, 15610.531684049496, 15861.0, 34806.82596587001, 35033.64966350406, 36076.27847442984, 37228.0, 38175.80912095422, 46682.29976550287, 47514.524854752395, 50416.49583504118, 52853.735731321096, 52999.470005300995, 7071.151461824614, 7391.667374968032, 7821.217878212134, 8264.090949995376, 8275.469038227706, 11522.884771152181, 11561.942190289332, 11718.589849355232, 12278.570250041206, 12310.0, 10527.420991845522, 10567.947160264457, 10581.52383142745, 10807.891921080689, 10929.453527323443, 5421.430749771375, 9375.765605859908, 10293.639722609672, 10755.946220269161, 10934.781304374028, 6144.0, 9207.907920920705, 10217.846732299171, 10583.417912014913, 11068.446577671246, 7517.849643007218, 7647.311741943252, 7666.271704188093, 7683.615819208905, 7685.884711729217, 10789.136869050613, 11167.944160279147, 11265.380404077854, 11285.943570282425, 11330.660080197607], "value": 8453.252432355865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.720530290183, 1512.56135720641, 1513.9394424223033, 1708.9230984605692, 1843.8985855777935, 6822.7270909163635, 7817.765467035991, 8029.47808392454, 8033.0, 8270.669173233064, 7968.3625309975205, 8132.634031468583, 8146.429749917508, 8146.470479418834, 8155.266026057669, 2289.6222123349626, 2329.3710698111586, 2330.487292795582, 2331.114176612893, 2332.4518738096535, 2272.9545409091807, 2293.587154312223, 2316.444053427182, 2316.895739691718, 2318.7681231876763, 2264.62633665445, 2272.5909336319455, 2283.54329134173, 2316.027268547206, 2318.107528601492, 2194.3416974907464, 2194.8792816395094, 2197.846150769447, 2199.5820794049077, 2212.5132470856547, 2234.6871437998693, 2238.507528343762, 2242.8654280743044, 2247.0337754765446, 2249.7300323961067, 7842.098158711764, 8043.235892590194, 8088.352931765445, 8090.757277281691, 8094.352451803841, 4689.812407503696, 4791.856244312677, 4796.52034796521, 4798.832040878588, 4808.038392321515, 3094.860731267076, 3181.9681803182134, 3208.0856955767495, 3211.020638705194, 3240.643529211785, 1006.4701653486642, 1007.5466040281902, 1012.2205901455911, 1031.6028329093278, 1051.673981065872, 10982.505787239594, 10988.0, 11037.558497660004, 11054.115670746402, 11081.778364432746, 4253.978730106392, 4358.498772641124, 4364.607185353333, 4366.323219900921, 4366.476022877275, 8551.957240213884, 8624.482531048157, 8624.482531048157, 8629.352798540134, 8659.263962563253, 4619.214733495314, 4715.033418149271, 4716.056788642285, 4722.268048452495, 4723.976380118146, 3784.7161462890394, 3853.865114720971, 3857.614238576176, 4045.1707399982934, 4398.120375924827, 3278.6229583597715, 3370.1743072947284, 3371.0, 3573.4997100405963, 3581.0, 1082.3505896462218, 1088.8584484017026, 1095.4194277033184, 1111.7387413957713, 1114.849495318138, 791.5962858941866, 905.7735566108473, 909.7907481279343, 911.7082533589321, 935.7988032572894, 5460.645058071213, 5590.049691552445, 5597.552195824405, 5618.606697531215, 5619.136352992235, 449.53473155284127, 450.6552487347182, 454.19380599435607, 457.19533620826917, 459.31561972660495, 3828.9808550957623, 3842.8462861485787, 3890.4747859038666, 3891.2217556488818, 3927.0378757204667, 9420.387674801115, 9706.563204655808, 9802.411855288705, 9827.557759900821, 9851.852222216672, 9677.661281855102, 9722.465264410384, 9725.319227654138, 9735.561899714388, 9743.366681165702, 7407.703691852265, 7431.702731890772, 7434.665440055211, 7491.66287517063, 7532.472726909174, 5523.475269849358, 5560.2493663356545, 5685.924637507197, 5754.913676294943, 5820.388859169726, 8950.104989500998, 8984.86522702147, 9212.815743684954, 9249.445033298023, 9250.02874698174, 9014.729558113268, 9161.404508706913, 9187.908120918974, 9218.0, 9334.25325973907, 7033.261507541634, 7077.787666370017, 7131.928680713127, 7138.321859423347, 7167.283271672791, 6699.43054840344, 7257.52826066304, 7473.92526074754, 7478.962605186939, 7709.9614501927135, 6597.80206593803, 6916.481263905328, 7029.29707029293, 7079.185893622093, 7179.928200717926, 6534.673266336759, 6692.130023096966, 6735.326467353226, 6937.687804048931, 6963.234044255027, 6092.451679348703, 6168.629882207082, 6219.751209951552, 6232.439080482597, 6237.220347456568, 4453.487848897289, 4472.79872405749, 4746.7389293589185, 4761.2382018876815, 4785.449673287477, 4707.082118986765, 4723.622110231242, 4763.666543341933, 4801.207800712983, 4844.539768721966], "value": 4173.754637881201, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.74984637366924, 314.8268452351207, 324.08930904159314, 324.8814182823267, 325.9136328872848, 4658.813647454106, 4803.591694705946, 4837.346958160647, 4891.239153904596, 4900.705957642544, 4646.3030545418205, 4763.714177149373, 4767.1419144553965, 4805.543473370033, 4806.663533552653, 3774.2451509698035, 3779.848806047755, 3781.8676346327884, 3814.771113733171, 3846.8461261549505, 3604.7476676632646, 3700.3903302063554, 3796.126890815114, 3813.48517950076, 3873.7288389812725, 3788.867389641363, 3808.7714737115725, 3824.4072168813877, 3829.7893615851117, 3835.7698538087666, 3785.0, 3796.4305354196817, 3804.353259945816, 3816.637419445148, 3835.4822099016833, 3383.932321353559, 3390.1016230698883, 3392.3893699134146, 3398.1844357354303, 3431.330890476358, 4595.172868883633, 4628.560286772785, 4630.027694184192, 4647.279671650899, 4663.626909847238, 4350.369196466526, 4366.694331396803, 4376.5842244987, 4391.429114215131, 4392.648588112943, 5032.647714659939, 5039.596832253411, 5059.418166910778, 5063.493650634944, 5064.404712515546, 3544.2025544252597, 3712.2389910068373, 3720.3489389357023, 3728.9627103728885, 3737.336885086138, 5230.215467679878, 5235.712035838027, 5240.410318931506, 5246.580273578104, 5258.92111618326, 3814.8664796731982, 3816.2558301131567, 3818.694504439638, 3824.9808750956067, 3845.5000849889334, 3561.554805649294, 3851.268259030775, 3873.4577159197734, 3875.7093218008763, 3895.8636447724193, 4239.427677263591, 4284.507281662586, 4290.313549832012, 4297.505786834491, 4301.870943871689, 5042.747862606855, 5049.368828896388, 5057.671251368649, 5061.0, 5123.410807757081, 1225.3199474291675, 1242.931638759877, 1249.5193196062514, 1255.6358655989661, 1257.4781465691635, 886.6276164011002, 896.9103089690979, 899.469313105271, 901.5942825728448, 907.2923119966437, 4448.532904045093, 4492.887677808016, 4501.459824820977, 4507.684462087688, 4527.637788976874, 4995.650304478651, 5140.588752899759, 5203.661761985459, 5221.7128057956415, 5237.162054071407, 4408.977955110268, 4419.690621656518, 4427.911441771146, 4441.422615060086, 4493.146302202571, 2737.534619114755, 2739.1782465260344, 2744.533429316981, 2745.203890871665, 2766.5988431677292, 4709.7174169549935, 4849.345338379274, 4853.95146048542, 4859.708417494961, 4997.825076122391, 5338.145896656516, 5342.252084708144, 5367.409584945653, 5373.53407052449, 5389.622726409192, 4911.607071434277, 4963.950360496421, 4990.750462476862, 5032.924506132485, 5044.798208071636, 5050.949490505195, 5297.841064768063, 5307.363116426053, 5307.761150748149, 5332.200169974535, 5072.644914855925, 5101.668391554537, 5180.145276029413, 5198.376194856642, 5221.582273418041, 4940.184869496493, 4971.005798840174, 4989.12690279207, 4999.300097986212, 5014.724190169576, 3596.946045809367, 3655.4151335786146, 3667.394879844796, 3693.501377314136, 3701.7229055975645, 5248.76380562868, 5275.868103297448, 5277.973610131925, 5283.524482796567, 5288.545649946295, 5111.897762044812, 5145.331106956071, 5162.586993040472, 5163.4578369270685, 5172.612054095883, 4908.214685650279, 4913.65604407688, 5068.417132029716, 5144.794208231779, 5148.562372198405, 4935.654504184817, 5002.499750025114, 5002.649814512949, 5023.2214006829, 5030.547250747304, 5087.287779710769, 5099.158638824552, 5110.134800797608, 5134.5378915897745, 5135.563477104339, 4808.831690890802, 5016.3227964225825, 5021.44764075944, 5024.799008039638, 5031.396232452129], "value": 3846.342261244233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.9440844732421, 781.992180078199, 792.8810678398238, 798.9161138080498, 813.4184058398248, 12334.0, 12388.442520086595, 12399.256044637317, 12464.439100240488, 12534.686632834173, 12763.23420594765, 12785.232886026844, 12798.104132710714, 12802.551910683127, 12808.167469114502, 668.1247565688939, 682.4881338995754, 683.0744341417383, 835.7325655790149, 850.9234168924795, 677.844095857953, 820.9055958564782, 849.3163003781953, 850.4812064640595, 852.5353682243192, 895.552223888056, 900.6262401103534, 903.3856977255464, 904.9140331668514, 905.9411138275991, 895.0557162193883, 900.0819164452222, 900.8828852249165, 901.9098090190994, 902.3728508686465, 518.476338897716, 648.6400047973373, 663.1677245057471, 663.6184194088419, 666.373608807724, 12315.137940344179, 12326.630201093982, 12340.876591234151, 12351.38243087851, 12369.13416060876, 12063.698407539794, 12604.243745375306, 12625.684357891034, 12781.808272875915, 12903.677408064874, 10660.62687805931, 10941.12471002318, 11000.944995275053, 11334.036606888425, 11644.708882277926, 4183.895402614929, 4237.300845360512, 4262.509811371701, 4383.561643835623, 4387.714798538117, 45605.543944560464, 45777.0, 45784.31323530116, 46208.537914620756, 46266.53733462656, 9736.707898763048, 10049.072220530395, 10171.796564068825, 10180.083792458714, 10441.84337234942, 17746.645067098587, 17767.378141764977, 17775.377861775036, 17797.377091801725, 17799.911000444914, 6557.0, 6633.2703402625675, 6653.9667301663185, 6657.46740260778, 6820.35206655367, 3581.212133330663, 3723.255348930225, 3737.5514938207043, 3783.3379158647126, 3795.1460921292487, 2669.7864170866283, 2752.545829938038, 2770.404363061911, 2772.487089888377, 2773.1126039667115, 496.4390239029873, 506.95183957524716, 515.4896652314181, 521.7000224870715, 533.8638647144953, 547.9479449452296, 564.4919572384805, 582.4495851420452, 583.9270091238595, 607.0226934635234, 7953.761387158394, 8054.23484768946, 8077.555734434663, 8161.387895907831, 8225.0, 501.24312288444713, 544.8855740294582, 595.7140572525126, 617.7127635649355, 620.2959640807626, 3873.69010479161, 4023.6177563131455, 4085.7752823594988, 4119.114390406077, 4239.745615263094, 55487.445125549035, 56368.0, 56584.71707641435, 56921.43078569244, 57040.71479642575, 47463.288050679264, 50897.74551127221, 51409.0, 52520.0, 53086.0, 48726.51273487291, 49610.50389496059, 50108.0, 50311.0, 50395.24407133896, 8569.442986205877, 8589.785255368666, 8697.608607612547, 8755.25580325654, 8978.461292322481, 33181.33637327288, 33358.16604584808, 33424.33151336911, 33449.0, 34054.82972585121, 39714.0, 42076.78961605173, 42479.362809557264, 42957.57042429536, 43673.34489982716, 11030.613928512785, 11179.385133817717, 11286.774264514499, 11364.488598013275, 11711.0, 11852.940735296268, 12097.516099356279, 12185.573504927284, 12512.74974500523, 12810.167339122927, 11229.550817967516, 11521.596744114251, 11664.586181616383, 11720.179587428798, 11774.587889423829, 11148.832767508331, 11602.419879006186, 11910.749371315887, 11916.880831191924, 11924.642260732191, 10887.23789334739, 11700.47347869331, 12103.273803571814, 12119.212251203644, 12130.878691212974, 8550.230479256898, 9261.398009129385, 9280.535973201448, 9340.953295233481, 9587.856182157133, 9090.409123406956, 9091.954540227256, 9312.906870931203, 9517.857232141385, 9641.228701703987], "value": 6184.555804766872, "unit": "score"}], "name": "dromaeo_css", "value": 6452.291746991042, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 115.0, 115.0, 114.0, 112.0, 113.0, 111.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 167.0, 212.0, 131.0, 173.0, 165.0, 131.0, 181.0, 130.0], "value": 158.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 160.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 147.0, 76.0, 75.0, 77.0, 75.0, 141.0, 75.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 156.0, 94.0, 95.0, 96.0, 130.0, 94.0, 93.0, 129.0], "value": 107.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "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, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 68.0, 66.0, 63.0, 64.0, 138.0, 61.0, 62.0], "value": 71.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 83.0, 88.0, 82.0, 82.0, 83.0, 82.0, 88.0, 82.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 127.0, 133.0, 126.0, 135.0, 135.0, 129.0, 198.0, 128.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 172.0, 168.0, 169.0, 166.0, 170.0, 170.0, 170.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 71.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 64.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1580.8999999999999, "alertThreshold": 2.0}]} 18:52:02 INFO - Return code: 0 18:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:52:02 ERROR - # TBPL SUCCESS # 18:52:02 INFO - Running post-action listener: _resource_record_post_action 18:52:02 INFO - ##### 18:52:02 INFO - ##### Finished run-tests step (success) 18:52:02 INFO - ##### 18:52:02 INFO - Running post-run listener: _resource_record_post_run 18:52:02 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532848640; Read time: 8; Write time: 462876 18:52:02 INFO - TinderboxPrint: CPU usage
13.1% 18:52:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:52:02 INFO - TinderboxPrint: I/O write bytes / time
532,848,640 / 462,876 18:52:02 INFO - TinderboxPrint: CPU idle
8,331.9 (86.9%) 18:52:02 INFO - TinderboxPrint: CPU user
1,211.9 (12.6%) 18:52:02 INFO - TinderboxPrint: Swap in / out
0 / 0 18:52:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236920832; Read time: 0; Write time: 220992 18:52:02 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295927808; Read time: 8; Write time: 241884 18:52:03 INFO - Running post-run listener: _upload_blobber_files 18:52:03 INFO - Blob upload gear active. 18:52:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:52:03 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 18:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:52:03 INFO - (blobuploader) - INFO - Open directory for files ... 18:52:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:52:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:10 INFO - (blobuploader) - INFO - Done attempting. 18:52:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:52:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:52:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:11 INFO - (blobuploader) - INFO - Done attempting. 18:52:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:52:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:52:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:52:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:52:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:52:12 INFO - (blobuploader) - INFO - Done attempting. 18:52:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:52:12 INFO - Return code: 0 18:52:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:52:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:52:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc72f7762435d5b8acee7c36e6a944f8426a1668b059cf9b8eff918fcd6e830cc419d0ff4d53fe1badf112a210a4da48c30a1ec20fe82522115f2ac12363c46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/695de56513330cd8e4acb4a576cb1ee985bbbb8bbcc97ffdcfaed4ac1a0209e277ab8f2bc0c9eedb41a9361e2f8adc5aec1a3ae59b887100435ad5f48832fa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfce7167a8e2e4272640818fa62fdbde6f5b6bcfa1cd9dd8a55e1521db8b48777e4ced7873bf8f8be589bfe6c6e4f427b1fc238a1b2fff762223d2fd237c3eab"} 18:52:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:52:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:52:12 INFO - Contents: 18:52:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc72f7762435d5b8acee7c36e6a944f8426a1668b059cf9b8eff918fcd6e830cc419d0ff4d53fe1badf112a210a4da48c30a1ec20fe82522115f2ac12363c46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/695de56513330cd8e4acb4a576cb1ee985bbbb8bbcc97ffdcfaed4ac1a0209e277ab8f2bc0c9eedb41a9361e2f8adc5aec1a3ae59b887100435ad5f48832fa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfce7167a8e2e4272640818fa62fdbde6f5b6bcfa1cd9dd8a55e1521db8b48777e4ced7873bf8f8be589bfe6c6e4f427b1fc238a1b2fff762223d2fd237c3eab"} 18:52:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:52:12 INFO - Copying logs to upload dir... 18:52:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:52:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.742975 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-18 18:52:12.184741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:12.188143) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc72f7762435d5b8acee7c36e6a944f8426a1668b059cf9b8eff918fcd6e830cc419d0ff4d53fe1badf112a210a4da48c30a1ec20fe82522115f2ac12363c46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/695de56513330cd8e4acb4a576cb1ee985bbbb8bbcc97ffdcfaed4ac1a0209e277ab8f2bc0c9eedb41a9361e2f8adc5aec1a3ae59b887100435ad5f48832fa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfce7167a8e2e4272640818fa62fdbde6f5b6bcfa1cd9dd8a55e1521db8b48777e4ced7873bf8f8be589bfe6c6e4f427b1fc238a1b2fff762223d2fd237c3eab"} build_url:https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/DcYIL8OYRpa9q3tuqiTS4A/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-Non-PGO/sha512/cc72f7762435d5b8acee7c36e6a944f8426a1668b059cf9b8eff918fcd6e830cc419d0ff4d53fe1badf112a210a4da48c30a1ec20fe82522115f2ac12363c46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/695de56513330cd8e4acb4a576cb1ee985bbbb8bbcc97ffdcfaed4ac1a0209e277ab8f2bc0c9eedb41a9361e2f8adc5aec1a3ae59b887100435ad5f48832fa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bfce7167a8e2e4272640818fa62fdbde6f5b6bcfa1cd9dd8a55e1521db8b48777e4ced7873bf8f8be589bfe6c6e4f427b1fc238a1b2fff762223d2fd237c3eab"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:12.350463) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:12.351022) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1463618717.398194-2129202465 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 18:52:12.443263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:52:12.443582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 18:52:12.443896) ========= ========= Total master_lag: 0.34 =========