builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1464200552.98 results: success (0) buildid: 20160525083031 builduid: cb62b481b76c49e5a39bde7ecde65e58 revision: fef64183cb939b13fbfdd5b1b44bd3c63d64d88f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:32.981667) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:32.982730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:32.983312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.038114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.038604) ========= 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=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 11:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-05-25 11:22:33 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.209735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.210042) ========= 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=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019594 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.258890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:33.259216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fef64183cb939b13fbfdd5b1b44bd3c63d64d88f --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 fef64183cb939b13fbfdd5b1b44bd3c63d64d88f --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=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 11:22:33,675 truncating revision to first 12 chars 2016-05-25 11:22:33,675 Setting DEBUG logging. 2016-05-25 11:22:33,675 attempt 1/10 2016-05-25 11:22:33,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fef64183cb93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 11:22:34,213 unpacking tar archive at: fx-team-fef64183cb93/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945670 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:34.217908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:34.218176) ========= script_repo_revision: fef64183cb939b13fbfdd5b1b44bd3c63d64d88f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:34.218539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:34.218811) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 11:22:34.228763) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-25 11:22:34.229284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:34 INFO - MultiFileLogger online at 20160525 11:22:34 in /builds/slave/test 11:22:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:34 INFO - {'append_to_log': False, 11:22:34 INFO - 'base_work_dir': '/builds/slave/test', 11:22:34 INFO - 'blob_upload_branch': 'Fx-Team', 11:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:34 INFO - 'branch': 'Fx-Team', 11:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:34 INFO - 'config_files': ('talos/linux_config.py',), 11:22:34 INFO - 'default_actions': ('clobber', 11:22:34 INFO - 'read-buildbot-config', 11:22:34 INFO - 'download-and-extract', 11:22:34 INFO - 'populate-webroot', 11:22:34 INFO - 'create-virtualenv', 11:22:34 INFO - 'install', 11:22:34 INFO - 'run-tests'), 11:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:34 INFO - 'download_minidump_stackwalk': True, 11:22:34 INFO - 'download_symbols': 'ondemand', 11:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:34 INFO - 'installer_path': 'installer.exe', 11:22:34 INFO - 'log_level': 'info', 11:22:34 INFO - 'log_name': 'talos', 11:22:34 INFO - 'log_to_console': True, 11:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:34 INFO - 'opt_config_files': (), 11:22:34 INFO - 'pip_index': False, 11:22:34 INFO - 'sps_profile': False, 11:22:34 INFO - 'sps_profile_interval': 0, 11:22:34 INFO - 'suite': 'dromaeojs', 11:22:34 INFO - 'system_bits': '32', 11:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:34 INFO - 'title': 'talos-linux64-ix-026', 11:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:34 INFO - 'use_talos_json': True, 11:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:34 INFO - 'work_dir': 'build'} 11:22:34 INFO - ##### 11:22:34 INFO - ##### Running clobber step. 11:22:34 INFO - ##### 11:22:34 INFO - Running pre-action listener: _resource_record_pre_action 11:22:34 INFO - Running main action method: clobber 11:22:34 INFO - rmtree: /builds/slave/test/build 11:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:35 INFO - Running post-action listener: _resource_record_post_action 11:22:35 INFO - ##### 11:22:35 INFO - ##### Finished clobber step (success) 11:22:35 INFO - ##### 11:22:35 INFO - ##### 11:22:35 INFO - ##### Running read-buildbot-config step. 11:22:35 INFO - ##### 11:22:35 INFO - Running pre-action listener: _resource_record_pre_action 11:22:35 INFO - Running main action method: read_buildbot_config 11:22:35 INFO - Using buildbot properties: 11:22:35 INFO - { 11:22:35 INFO - "project": "", 11:22:35 INFO - "product": "firefox", 11:22:35 INFO - "script_repo_revision": "production", 11:22:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:22:35 INFO - "repository": "", 11:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:22:35 INFO - "buildid": "20160525083031", 11:22:35 INFO - "pgo_build": "True", 11:22:35 INFO - "basedir": "/builds/slave/test", 11:22:35 INFO - "buildnumber": 713, 11:22:35 INFO - "slavename": "talos-linux64-ix-026", 11:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:35 INFO - "platform": "ubuntu64_hw", 11:22:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:22:35 INFO - "branch": "fx-team", 11:22:35 INFO - "repo_path": "integration/fx-team", 11:22:35 INFO - "revision": "fef64183cb939b13fbfdd5b1b44bd3c63d64d88f", 11:22:35 INFO - "stage_platform": "linux64-pgo", 11:22:35 INFO - "builduid": "cb62b481b76c49e5a39bde7ecde65e58", 11:22:35 INFO - "slavebuilddir": "test" 11:22:35 INFO - } 11:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:22:35 INFO - Running post-action listener: _resource_record_post_action 11:22:35 INFO - ##### 11:22:35 INFO - ##### Finished read-buildbot-config step (success) 11:22:35 INFO - ##### 11:22:35 INFO - ##### 11:22:35 INFO - ##### Running download-and-extract step. 11:22:35 INFO - ##### 11:22:35 INFO - Running pre-action listener: _resource_record_pre_action 11:22:35 INFO - Running main action method: download_and_extract 11:22:35 INFO - mkdir: /builds/slave/test/build/tests 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:44 INFO - Downloaded 1361 bytes. 11:22:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:22:44 INFO - Using the following test package requirements: 11:22:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:22:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'jsshell-linux-x86_64.zip'], 11:22:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:22:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:22:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:22:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:22:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22: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')]} 11:22:44 INFO - https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:45 INFO - Downloaded 24421009 bytes. 11:22:45 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'] 11:22:45 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 11:22:46 INFO - Return code: 0 11:22:46 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 11:22:46 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')]} 11:22:46 INFO - https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:22:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:50 INFO - Downloaded 24421009 bytes. 11:22:50 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'] 11:22:50 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 11:22:51 INFO - Return code: 0 11:22: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')]} 11:22:51 INFO - https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:52 INFO - Downloaded 10834034 bytes. 11:22:52 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'] 11:22:52 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 11:22:53 INFO - Return code: 0 11:22:53 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')]} 11:22:53 INFO - https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Evkeq05TTlyY3RZbGV7t-Q/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 11:22:54 INFO - Downloaded 58672365 bytes. 11:22:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:54 INFO - mkdir: /builds/slave/test/properties 11:22:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:54 INFO - Contents: 11:22:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:22:55 INFO - Running post-action listener: _resource_record_post_action 11:22:55 INFO - Running post-action listener: set_extra_try_arguments 11:22:55 INFO - ##### 11:22:55 INFO - ##### Finished download-and-extract step (success) 11:22:55 INFO - ##### 11:22:55 INFO - ##### 11:22:55 INFO - ##### Running populate-webroot step. 11:22:55 INFO - ##### 11:22:55 INFO - Running pre-action listener: _resource_record_pre_action 11:22:55 INFO - Running main action method: populate_webroot 11:22:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:55 INFO - '--tppagecycles', 11:22:55 INFO - '7'], 11:22:55 INFO - 'tests': ['tsvgm']}}, 11:22:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['damp', 'tps']}, 11:22:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'tests': ['damp', 'tps']}, 11:22:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['dromaeo_dom']}, 11:22:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['a11yr', 11:22:55 INFO - 'ts_paint', 11:22:55 INFO - 'tpaint', 11:22:55 INFO - 'sessionrestore', 11:22:55 INFO - 'sessionrestore_no_auto_restore', 11:22:55 INFO - 'tabpaint']}, 11:22:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['tsvgx', 11:22:55 INFO - 'tsvgr_opacity', 11:22:55 INFO - 'tart', 11:22:55 INFO - 'tscrollx', 11:22:55 INFO - 'cart']}, 11:22:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:55 INFO - 'tsvgr_opacity', 11:22:55 INFO - 'tart', 11:22:55 INFO - 'tscrollx', 11:22:55 INFO - 'cart']}, 11:22:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'talos_options': ['--disable-e10s'], 11:22:55 INFO - 'tests': ['tp5o']}, 11:22:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'tests': ['tp5o']}, 11:22:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'talos_options': ['--disable-e10s', 11:22:55 INFO - '--xperf_path', 11:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:55 INFO - 'tests': ['tp5n']}, 11:22:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:55 INFO - 'talos_options': ['--xperf_path', 11:22:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:55 INFO - 'tests': ['tp5n']}}, 11:22:55 INFO - 'talos.zip': {'path': '', 11:22:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:55 INFO - Running post-action listener: _resource_record_post_action 11:22:55 INFO - ##### 11:22:55 INFO - ##### Finished populate-webroot step (success) 11:22:55 INFO - ##### 11:22:55 INFO - ##### 11:22:55 INFO - ##### Running create-virtualenv step. 11:22:55 INFO - ##### 11:22:55 INFO - Running pre-action listener: _resource_record_pre_action 11:22:55 INFO - Running main action method: create_virtualenv 11:22:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:55 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 11:22:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:55 INFO - Using real prefix '/usr' 11:22:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:57 INFO - Installing pip.................done. 11:22:57 INFO - Return code: 0 11:22:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:22: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', 'pip>=1.5'] in /builds/slave/test/build 11:22: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 pip>=1.5 11:22:57 INFO - Using env: {'DISPLAY': ':0', 11:22:57 INFO - 'HOME': '/home/cltbld', 11:22:57 INFO - 'LANG': 'en_US.UTF-8', 11:22:57 INFO - 'LANGUAGE': 'en_US:en', 11:22:57 INFO - 'LOGNAME': 'cltbld', 11:22:57 INFO - 'MAIL': '/var/mail/cltbld', 11:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:57 INFO - 'MOZ_NO_REMOTE': '1', 11:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:57 INFO - 'NO_EM_RESTART': '1', 11:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:57 INFO - 'PWD': '/builds/slave/test', 11:22:57 INFO - 'SHELL': '/bin/bash', 11:22:57 INFO - 'SHLVL': '1', 11:22:57 INFO - 'TERM': 'linux', 11:22:57 INFO - 'TMOUT': '86400', 11:22:57 INFO - 'USER': 'cltbld', 11:22:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:57 INFO - '_': '/tools/buildbot/bin/python'} 11:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:58 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 11:22:58 INFO - Cleaning up... 11:22:58 INFO - Return code: 0 11:22:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:58 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')]} 11:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:58 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')]} 11:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:58 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:22:58 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 11:22:58 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 11:22:58 INFO - Using env: {'DISPLAY': ':0', 11:22:58 INFO - 'HOME': '/home/cltbld', 11:22:58 INFO - 'LANG': 'en_US.UTF-8', 11:22:58 INFO - 'LANGUAGE': 'en_US:en', 11:22:58 INFO - 'LOGNAME': 'cltbld', 11:22:58 INFO - 'MAIL': '/var/mail/cltbld', 11:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:58 INFO - 'MOZ_NO_REMOTE': '1', 11:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:58 INFO - 'NO_EM_RESTART': '1', 11:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:58 INFO - 'PWD': '/builds/slave/test', 11:22:58 INFO - 'SHELL': '/bin/bash', 11:22:58 INFO - 'SHLVL': '1', 11:22:58 INFO - 'TERM': 'linux', 11:22:58 INFO - 'TMOUT': '86400', 11:22:58 INFO - 'USER': 'cltbld', 11:22:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:58 INFO - '_': '/tools/buildbot/bin/python'} 11:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:58 INFO - Downloading/unpacking psutil>=3.1.1 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:22: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 11:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:00 INFO - Installing collected packages: psutil 11:23:00 INFO - Running setup.py install for psutil 11:23:00 INFO - building 'psutil._psutil_linux' extension 11:23:00 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 11:23:00 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 11:23:00 INFO - building 'psutil._psutil_posix' extension 11:23:00 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 11:23:00 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 11:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:00 INFO - Successfully installed psutil 11:23:00 INFO - Cleaning up... 11:23:00 INFO - Return code: 0 11:23:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:00 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')]} 11:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:00 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')]} 11:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:00 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:00 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 11:23:00 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 11:23:00 INFO - Using env: {'DISPLAY': ':0', 11:23:00 INFO - 'HOME': '/home/cltbld', 11:23:00 INFO - 'LANG': 'en_US.UTF-8', 11:23:00 INFO - 'LANGUAGE': 'en_US:en', 11:23:00 INFO - 'LOGNAME': 'cltbld', 11:23:00 INFO - 'MAIL': '/var/mail/cltbld', 11:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:00 INFO - 'MOZ_NO_REMOTE': '1', 11:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:00 INFO - 'NO_EM_RESTART': '1', 11:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:00 INFO - 'PWD': '/builds/slave/test', 11:23:00 INFO - 'SHELL': '/bin/bash', 11:23:00 INFO - 'SHLVL': '1', 11:23:00 INFO - 'TERM': 'linux', 11:23:00 INFO - 'TMOUT': '86400', 11:23:00 INFO - 'USER': 'cltbld', 11:23:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:00 INFO - '_': '/tools/buildbot/bin/python'} 11:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:02 INFO - Installing collected packages: mozsystemmonitor 11:23:02 INFO - Running setup.py install for mozsystemmonitor 11:23:03 INFO - Successfully installed mozsystemmonitor 11:23:03 INFO - Cleaning up... 11:23:03 INFO - Return code: 0 11:23:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:23:03 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')]} 11:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:03 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')]} 11:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:03 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:03 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 11:23:03 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 11:23:03 INFO - Using env: {'DISPLAY': ':0', 11:23:03 INFO - 'HOME': '/home/cltbld', 11:23:03 INFO - 'LANG': 'en_US.UTF-8', 11:23:03 INFO - 'LANGUAGE': 'en_US:en', 11:23:03 INFO - 'LOGNAME': 'cltbld', 11:23:03 INFO - 'MAIL': '/var/mail/cltbld', 11:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:03 INFO - 'MOZ_NO_REMOTE': '1', 11:23:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:03 INFO - 'NO_EM_RESTART': '1', 11:23:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:03 INFO - 'PWD': '/builds/slave/test', 11:23:03 INFO - 'SHELL': '/bin/bash', 11:23:03 INFO - 'SHLVL': '1', 11:23:03 INFO - 'TERM': 'linux', 11:23:03 INFO - 'TMOUT': '86400', 11:23:03 INFO - 'USER': 'cltbld', 11:23:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:03 INFO - '_': '/tools/buildbot/bin/python'} 11:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:03 INFO - Downloading/unpacking blobuploader==1.2.4 11:23:03 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 11:23:03 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 11:23:03 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 11:23:03 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 11:23:03 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 11:23:03 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 11:23:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 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 11:23:05 INFO - Downloading docopt-0.6.1.tar.gz 11:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:05 INFO - Running setup.py install for blobuploader 11:23:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:06 INFO - Running setup.py install for requests 11:23:06 INFO - Running setup.py install for docopt 11:23:06 INFO - Successfully installed blobuploader requests docopt 11:23:06 INFO - Cleaning up... 11:23:06 INFO - Return code: 0 11:23:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:06 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')]} 11:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:06 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')]} 11:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:06 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:06 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 11:23:06 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 11:23:06 INFO - Using env: {'DISPLAY': ':0', 11:23:06 INFO - 'HOME': '/home/cltbld', 11:23:06 INFO - 'LANG': 'en_US.UTF-8', 11:23:06 INFO - 'LANGUAGE': 'en_US:en', 11:23:06 INFO - 'LOGNAME': 'cltbld', 11:23:06 INFO - 'MAIL': '/var/mail/cltbld', 11:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:06 INFO - 'MOZ_NO_REMOTE': '1', 11:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:06 INFO - 'NO_EM_RESTART': '1', 11:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:06 INFO - 'PWD': '/builds/slave/test', 11:23:06 INFO - 'SHELL': '/bin/bash', 11:23:06 INFO - 'SHLVL': '1', 11:23:06 INFO - 'TERM': 'linux', 11:23:06 INFO - 'TMOUT': '86400', 11:23:06 INFO - 'USER': 'cltbld', 11:23:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:06 INFO - '_': '/tools/buildbot/bin/python'} 11:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:06 INFO - Running setup.py (path:/tmp/pip-2w0xXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:06 INFO - Running setup.py (path:/tmp/pip-oLP4ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:06 INFO - Running setup.py (path:/tmp/pip-E9M3kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:06 INFO - Running setup.py (path:/tmp/pip-jQZUhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:07 INFO - Running setup.py (path:/tmp/pip-1JVHEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:07 INFO - Running setup.py (path:/tmp/pip-L5Is1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:07 INFO - Running setup.py (path:/tmp/pip-SY2jTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:07 INFO - Running setup.py (path:/tmp/pip-xdizMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:07 INFO - Running setup.py (path:/tmp/pip-3DmtpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:07 INFO - Running setup.py (path:/tmp/pip-u99iZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:07 INFO - Running setup.py (path:/tmp/pip-1k8rGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:07 INFO - Running setup.py (path:/tmp/pip-7dybSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:07 INFO - Running setup.py (path:/tmp/pip-eGGdr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:07 INFO - Running setup.py (path:/tmp/pip-Qp_hXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:07 INFO - Running setup.py (path:/tmp/pip-ozKsqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:07 INFO - Running setup.py (path:/tmp/pip-dMO7pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:07 INFO - Running setup.py (path:/tmp/pip-_rRv2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:07 INFO - Running setup.py install for manifestparser 11:23:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Running setup.py install for mozcrash 11:23:08 INFO - Running setup.py install for mozdebug 11:23:08 INFO - Running setup.py install for mozdevice 11:23:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Running setup.py install for mozfile 11:23:08 INFO - Running setup.py install for mozhttpd 11:23:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Running setup.py install for mozinfo 11:23:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Running setup.py install for mozInstall 11:23:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:08 INFO - Running setup.py install for mozleak 11:23:08 INFO - Running setup.py install for mozlog 11:23:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Running setup.py install for moznetwork 11:23:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Running setup.py install for mozprocess 11:23:09 INFO - Running setup.py install for mozprofile 11:23:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Running setup.py install for mozrunner 11:23:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Running setup.py install for mozscreenshot 11:23:09 INFO - Running setup.py install for moztest 11:23:09 INFO - Running setup.py install for mozversion 11:23:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:09 INFO - Cleaning up... 11:23:09 INFO - Return code: 0 11:23:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:09 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:09 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 11:23:09 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 11:23:09 INFO - Using env: {'DISPLAY': ':0', 11:23:09 INFO - 'HOME': '/home/cltbld', 11:23:09 INFO - 'LANG': 'en_US.UTF-8', 11:23:09 INFO - 'LANGUAGE': 'en_US:en', 11:23:09 INFO - 'LOGNAME': 'cltbld', 11:23:09 INFO - 'MAIL': '/var/mail/cltbld', 11:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:09 INFO - 'MOZ_NO_REMOTE': '1', 11:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:09 INFO - 'NO_EM_RESTART': '1', 11:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:09 INFO - 'PWD': '/builds/slave/test', 11:23:09 INFO - 'SHELL': '/bin/bash', 11:23:09 INFO - 'SHLVL': '1', 11:23:09 INFO - 'TERM': 'linux', 11:23:09 INFO - 'TMOUT': '86400', 11:23:09 INFO - 'USER': 'cltbld', 11:23:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:09 INFO - '_': '/tools/buildbot/bin/python'} 11:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:10 INFO - Running setup.py (path:/tmp/pip-KNeBnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:10 INFO - Running setup.py (path:/tmp/pip-rkhGNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:10 INFO - Running setup.py (path:/tmp/pip-CF0w5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:10 INFO - Running setup.py (path:/tmp/pip-9RdNGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:10 INFO - Running setup.py (path:/tmp/pip-QGbd3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:10 INFO - Running setup.py (path:/tmp/pip-mBCuD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:10 INFO - Running setup.py (path:/tmp/pip-xQ1ykD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:10 INFO - Running setup.py (path:/tmp/pip-I6iuvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:10 INFO - Running setup.py (path:/tmp/pip-Xuwh46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:10 INFO - Running setup.py (path:/tmp/pip-OU11fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:10 INFO - Running setup.py (path:/tmp/pip-toPrv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:10 INFO - Running setup.py (path:/tmp/pip-fINR0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:10 INFO - Running setup.py (path:/tmp/pip-4ETo0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:10 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)) 11:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:10 INFO - Running setup.py (path:/tmp/pip-2fn9e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:11 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)) 11:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:11 INFO - Running setup.py (path:/tmp/pip-aF_Pee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:11 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)) 11:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:11 INFO - Running setup.py (path:/tmp/pip-uuHLy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:11 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)) 11:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:11 INFO - Running setup.py (path:/tmp/pip-3fd27s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:11 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)) 11:23:11 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)) 11:23:11 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)) 11:23:11 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)) 11:23:11 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)) 11:23:11 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)) 11:23:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23:11 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 11:23:11 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 11:23:11 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 11:23:11 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 11:23:11 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 11:23:11 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 11:23:13 INFO - Downloading blessings-1.6.tar.gz 11:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:13 INFO - Installing collected packages: blessings 11:23:13 INFO - Running setup.py install for blessings 11:23:13 INFO - Successfully installed blessings 11:23:13 INFO - Cleaning up... 11:23:13 INFO - Return code: 0 11:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:13 INFO - Reading from file tmpfile_stdout 11:23:13 INFO - Current package versions: 11:23:13 INFO - argparse == 1.2.1 11:23:13 INFO - blessings == 1.6 11:23:13 INFO - blobuploader == 1.2.4 11:23:13 INFO - docopt == 0.6.1 11:23:13 INFO - manifestparser == 1.1 11:23:13 INFO - mozInstall == 1.12 11:23:13 INFO - mozcrash == 0.17 11:23:13 INFO - mozdebug == 0.1 11:23:13 INFO - mozdevice == 0.48 11:23:13 INFO - mozfile == 1.2 11:23:13 INFO - mozhttpd == 0.7 11:23:13 INFO - mozinfo == 0.9 11:23:13 INFO - mozleak == 0.1 11:23:13 INFO - mozlog == 3.2 11:23:13 INFO - moznetwork == 0.27 11:23:13 INFO - mozprocess == 0.22 11:23:13 INFO - mozprofile == 0.28 11:23:13 INFO - mozrunner == 6.11 11:23:13 INFO - mozscreenshot == 0.1 11:23:13 INFO - mozsystemmonitor == 0.3 11:23:13 INFO - moztest == 0.7 11:23:13 INFO - mozversion == 1.4 11:23:13 INFO - psutil == 3.1.1 11:23:13 INFO - requests == 1.2.3 11:23:13 INFO - wsgiref == 0.1.2 11:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:13 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')]} 11:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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')]} 11:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:13 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 11:23:13 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 11:23:13 INFO - Using env: {'DISPLAY': ':0', 11:23:13 INFO - 'HOME': '/home/cltbld', 11:23:13 INFO - 'LANG': 'en_US.UTF-8', 11:23:13 INFO - 'LANGUAGE': 'en_US:en', 11:23:13 INFO - 'LOGNAME': 'cltbld', 11:23:13 INFO - 'MAIL': '/var/mail/cltbld', 11:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:13 INFO - 'MOZ_NO_REMOTE': '1', 11:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:13 INFO - 'NO_EM_RESTART': '1', 11:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:13 INFO - 'PWD': '/builds/slave/test', 11:23:13 INFO - 'SHELL': '/bin/bash', 11:23:13 INFO - 'SHLVL': '1', 11:23:13 INFO - 'TERM': 'linux', 11:23:13 INFO - 'TMOUT': '86400', 11:23:13 INFO - 'USER': 'cltbld', 11:23:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:13 INFO - '_': '/tools/buildbot/bin/python'} 11:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 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)) 11:23:13 INFO - Cleaning up... 11:23:13 INFO - Return code: 0 11:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:13 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')]} 11:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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')]} 11:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:13 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:13 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 11:23:13 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 11:23:13 INFO - Using env: {'DISPLAY': ':0', 11:23:13 INFO - 'HOME': '/home/cltbld', 11:23:13 INFO - 'LANG': 'en_US.UTF-8', 11:23:13 INFO - 'LANGUAGE': 'en_US:en', 11:23:13 INFO - 'LOGNAME': 'cltbld', 11:23:13 INFO - 'MAIL': '/var/mail/cltbld', 11:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:13 INFO - 'MOZ_NO_REMOTE': '1', 11:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:13 INFO - 'NO_EM_RESTART': '1', 11:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:13 INFO - 'PWD': '/builds/slave/test', 11:23:13 INFO - 'SHELL': '/bin/bash', 11:23:13 INFO - 'SHLVL': '1', 11:23:13 INFO - 'TERM': 'linux', 11:23:13 INFO - 'TMOUT': '86400', 11:23:13 INFO - 'USER': 'cltbld', 11:23:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:13 INFO - '_': '/tools/buildbot/bin/python'} 11:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:14 INFO - Downloading/unpacking jsonschema 11:23:14 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 11:23:14 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 11:23:14 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 11:23:14 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 11:23:14 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 11:23:14 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 11:23:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:23:15 INFO - Downloading/unpacking functools32 (from jsonschema) 11:23:15 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 11:23:15 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 11:23:15 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 11:23:15 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 11:23:15 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 11:23:15 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 11:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:23:16 INFO - warning: no files found matching '*.txt' 11:23:16 INFO - no previously-included directories found matching 'build' 11:23:16 INFO - no previously-included directories found matching 'dist' 11:23:16 INFO - no previously-included directories found matching '.git*' 11:23:16 INFO - Installing collected packages: jsonschema, functools32 11:23:16 INFO - Running setup.py install for functools32 11:23:16 INFO - warning: no files found matching '*.txt' 11:23:16 INFO - no previously-included directories found matching 'build' 11:23:16 INFO - no previously-included directories found matching 'dist' 11:23:16 INFO - no previously-included directories found matching '.git*' 11:23:16 INFO - Successfully installed jsonschema functools32 11:23:16 INFO - Cleaning up... 11:23:16 INFO - Return code: 0 11:23:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:23:16 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')]} 11:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:16 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')]} 11:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:16 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 0x7f7e326d3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25ad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2678770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, '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': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', '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 11:23:16 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 11:23:16 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 11:23:16 INFO - Using env: {'DISPLAY': ':0', 11:23:16 INFO - 'HOME': '/home/cltbld', 11:23:16 INFO - 'LANG': 'en_US.UTF-8', 11:23:16 INFO - 'LANGUAGE': 'en_US:en', 11:23:16 INFO - 'LOGNAME': 'cltbld', 11:23:16 INFO - 'MAIL': '/var/mail/cltbld', 11:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:16 INFO - 'MOZ_NO_REMOTE': '1', 11:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:16 INFO - 'NO_EM_RESTART': '1', 11:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:16 INFO - 'PWD': '/builds/slave/test', 11:23:16 INFO - 'SHELL': '/bin/bash', 11:23:16 INFO - 'SHLVL': '1', 11:23:16 INFO - 'TERM': 'linux', 11:23:16 INFO - 'TMOUT': '86400', 11:23:16 INFO - 'USER': 'cltbld', 11:23:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:16 INFO - '_': '/tools/buildbot/bin/python'} 11:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:16 INFO - Downloading/unpacking flake8 11:23:16 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 11:23:16 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 11:23:16 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 11:23:16 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 11:23:16 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 11:23:16 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 11:23:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:23:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:23:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 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 11:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:23:19 INFO - no previously-included directories found matching 'docs/_build' 11:23:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:23:19 INFO - Running setup.py install for pep8 11:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:23:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:23:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:23:19 INFO - no previously-included directories found matching 'docs/_build' 11:23:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:23:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:23:19 INFO - Cleaning up... 11:23:19 INFO - Return code: 0 11:23:19 INFO - Running post-action listener: _resource_record_post_action 11:23:19 INFO - Running post-action listener: _start_resource_monitoring 11:23:19 INFO - Starting resource monitoring. 11:23:19 INFO - ##### 11:23:19 INFO - ##### Finished create-virtualenv step (success) 11:23:19 INFO - ##### 11:23:19 INFO - ##### 11:23:19 INFO - ##### Running install step. 11:23:19 INFO - ##### 11:23:19 INFO - Running pre-action listener: _resource_record_pre_action 11:23:19 INFO - Running main action method: install 11:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:19 INFO - Reading from file tmpfile_stdout 11:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:19 INFO - Reading from file tmpfile_stdout 11:23:19 INFO - Output received: 11:23:19 INFO - Usage: mozinstall [options] installer 11:23:19 INFO - Options: 11:23:19 INFO - -h, --help show this help message and exit 11:23:19 INFO - -d DEST, --destination=DEST 11:23:19 INFO - Directory to install application into. [default: 11:23:19 INFO - "/builds/slave/test"] 11:23:19 INFO - --app=APP Application being installed. [default: firefox] 11:23:19 INFO - mkdir: /builds/slave/test/build/application 11:23:19 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'] 11:23:19 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 11:23:36 INFO - Reading from file tmpfile_stdout 11:23:36 INFO - Output received: 11:23:36 INFO - /builds/slave/test/build/application/firefox/firefox 11:23:36 INFO - Running post-action listener: _resource_record_post_action 11:23:36 INFO - ##### 11:23:36 INFO - ##### Finished install step (success) 11:23:36 INFO - ##### 11:23:36 INFO - ##### 11:23:36 INFO - ##### Running run-tests step. 11:23:36 INFO - ##### 11:23:36 INFO - Running pre-action listener: _resource_record_pre_action 11:23:36 INFO - Running main action method: run_tests 11:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:36 INFO - Python 2.7.3 11:23:36 INFO - Return code: 0 11:23:36 INFO - grabbing minidump binary from tooltool 11:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:23:36 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 0x27079c0>, '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 0x27088c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2708d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:36 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 11:23:36 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 11:23:36 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 11:23:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:36 INFO - Return code: 0 11:23:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:23:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:23:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:23:37 INFO - Return code: 0 11:23:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:23:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 11:23:37 INFO - Using env: {'DISPLAY': ':0', 11:23:37 INFO - 'HOME': '/home/cltbld', 11:23:37 INFO - 'LANG': 'en_US.UTF-8', 11:23:37 INFO - 'LANGUAGE': 'en_US:en', 11:23:37 INFO - 'LOGNAME': 'cltbld', 11:23:37 INFO - 'MAIL': '/var/mail/cltbld', 11:23:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:37 INFO - 'MOZ_NO_REMOTE': '1', 11:23:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:37 INFO - 'NO_EM_RESTART': '1', 11:23:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:37 INFO - 'PWD': '/builds/slave/test', 11:23:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:37 INFO - 'SHELL': '/bin/bash', 11:23:37 INFO - 'SHLVL': '1', 11:23:37 INFO - 'TERM': 'linux', 11:23:37 INFO - 'TMOUT': '86400', 11:23:37 INFO - 'USER': 'cltbld', 11:23:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788', 11:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:37 INFO - '_': '/tools/buildbot/bin/python'} 11:23:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 11:23:37 INFO - mozversion application_buildid: 20160525083031 11:23:37 INFO - mozversion application_changeset: fef64183cb939b13fbfdd5b1b44bd3c63d64d88f 11:23:37 INFO - mozversion application_display_name: Nightly 11:23:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:37 INFO - mozversion application_name: Firefox 11:23:37 INFO - mozversion application_remotingname: firefox 11:23:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:23:37 INFO - mozversion application_vendor: Mozilla 11:23:37 INFO - mozversion application_version: 49.0a1 11:23:37 INFO - mozversion platform_buildid: 20160525083031 11:23:37 INFO - mozversion platform_changeset: fef64183cb939b13fbfdd5b1b44bd3c63d64d88f 11:23:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:23:37 INFO - mozversion platform_version: 49.0a1 11:23:37 INFO - using testdate: 1464200617 11:23:37 INFO - actual date: 1464200617 11:23:37 INFO - starting webserver on 'localhost:47794' 11:23:37 INFO - SUITE-START | Running 2 tests 11:23:37 INFO - TEST-START | dromaeo_css 11:23:37 INFO - operating with platform_type : linux_ 11:23:37 INFO - Initialising browser for dromaeo_css test... 11:23:37 INFO - TEST-INFO | started process 15385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwH8KE/profile http://localhost:47794/getInfo.html) 11:23:41 INFO - PROCESS | 15385 | __metrics Screen width/height:1600/1200 11:23:41 INFO - PROCESS | 15385 | colorDepth:24 11:23:41 INFO - PROCESS | 15385 | Browser inner width/height: 1024/697 11:23:41 INFO - PROCESS | 15385 | __metrics 11:23:42 ERROR - PROCESS | 15385 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:23:43 INFO - TEST-INFO | 15385: exit 0 11:23:43 INFO - Browser initialized. 11:23:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:43 INFO - TEST-INFO | started process 15466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwH8KE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:55 INFO - PROCESS | 15466 | RSS: Main: 155279360 11:23:55 INFO - PROCESS | 15466 | 11:24:46 INFO - PROCESS | 15466 | 1464200686752 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] 11:26:54 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47794/tests/dromaeo/cssquery-ext.html) 11:26:55 INFO - PROCESS | 15466 | RSS: Main: 252956672 11:26:55 INFO - PROCESS | 15466 | 11:29:58 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-ext.html (next: http://localhost:47794/tests/dromaeo/cssquery-jquery.html) 11:29:58 INFO - PROCESS | 15466 | RSS: Main: 238202880 11:29:58 INFO - PROCESS | 15466 | 11:33:00 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47794/tests/dromaeo/cssquery-mootools.html) 11:33:01 INFO - PROCESS | 15466 | RSS: Main: 246644736 11:33:01 INFO - PROCESS | 15466 | 11:36:03 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47794/tests/dromaeo/cssquery-prototype.html) 11:36:04 INFO - PROCESS | 15466 | RSS: Main: 248999936 11:36:04 INFO - PROCESS | 15466 | 11:39:06 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47794/tests/dromaeo/cssquery-yui.html) 11:39:07 INFO - PROCESS | 15466 | RSS: Main: 227643392 11:39:07 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-yui.html (next: http://localhost:47794/tests/dromaeo/cssquery-dojo.html) 11:42:10 INFO - PROCESS | 15466 | RSS: Main: 293621760 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | __start_tp_report 11:42:10 INFO - PROCESS | 15466 | _x_x_mozilla_page_load 11:42:10 INFO - PROCESS | 15466 | _x_x_mozilla_page_load_details 11:42:10 INFO - PROCESS | 15466 | |i|pagename|runs| 11:42:10 INFO - PROCESS | 15466 | |0;dojo.html;3121.0636808957306;3123.4846250368705;3148.0241125251173;3172.5875636167293;3190.282186508036;5318.042752304584;5349.652272602279;5410.48600382964;5461.672299662018;5497.532709719673;5406.999705054558;5426.484483974016;5490.835274941748;5530.446955304467;5565.582581306408;4890.8043678252825;4957.058158949806;4978.850634480953;4991.226359914219;5133.974330128344;5036.471170527097;5053.84838454847;5085.5423011928915;5102.744862756866;5103.2090026045835;4878.438979517366;4896.877578060541;4922.950770492285;4972.204447288416;5079.161938280179;4921.8523444296725;4939.333190019337;4943.4809345018975;5005.0990821652085;5048.495150484959;4948.67833590819;4977.7262250576205;4979.178435558165;4993.350864387643;5044.873878153076;5252.894942101175;5331.386890507602;5399.919001214985;5483.2049352844015;5484;5880.353161152269;5887.234659494238;5912.645241285493;5933.851653708692;5938.228030356069;5712.542996560265;5939.643621382731;5949.464548190684;5951.3751056139345;5952.851178720523;5395.5953303502;5439.129739241742;5465.07093794056;5516.558675305966;5527.198556209368;6052.969735151384;6074.51403887688;6075.574709770273;6081.087836824512;6082.908756368658;5627.859303517363;5657.377688454267;5800.0429929062075;5808.82573522795;5809.099589563624;5797.623154494944;5850.034744267148;5902.822915312548;5902.940970590325;5906.734196961147;5803.5357171426185;5815.098659707752;5831.387704290988;5832.096025116114;5856.443637854397;5663.546916246691;5802.390748971382;5846.94153058464;5853.356130825606;5854.268216472941;4460.085682435093;4466.39703640011;4470.396496472999;4506.098780243964;4508.819647214074;3967.662748666338;3984.442178095069;3992.301347264217;3992.8802135935966;4023.3562629979065;5370.489803468664;5405.7837686492885;5502.147167189092;5533.170024496278;5564.360098588714;5883.823485295448;5891.734871930774;5903.675297858573;5911.852203694942;5950.166976623276;5569.610127291051;5578.3584887738425;5582.134769110794;5585.413531579207;5586.24585680936;4896;4938.333325001151;4985.9750701246985;5007.549320561094;5072.568831649277;6012.939870601325;6016.458518733335;6018.368071352533;6019.759209631566;6024.698765061729;5799.797007104731;5811.506021988178;5814.825555233349;5815.5929084963645;5817.214676018683;5842.123681447647;6011.789587364421;6043.12374705674;6096.603720758137;6143.56995010345;5787.94212057874;5819.854503637443;5821.912671310019;5825.737841797045;5830.47525722687;5678.290213723285;5909.379515151019;5925.377835327228;5933.110033494838;5933.228680271537;5668.574856885833;5738.540916726568;5738.942610573841;5770.221020162225;5780.971095144498;5715.942840571707;5733;5733.483986441241;5745.3105627324985;5756.30924289088;5479.890402191854;5561.3882472927135;5577.414371490935;5578.944210557843;5586.273784408001;5763.193152958673;5859.062549991981;5875.265591801025;5876.1773351729935;5878.147668588116;5622.550195984393;5678.886422271449;5680.630759000652;5685.516731077904;5686.488216060575 11:42:10 INFO - PROCESS | 15466 | |1;ext.html;583.0991118721574;622.1911515030461;629.483823264923;630.7886857902603;645.9547831651785;33108.66891331086;43847.342289865635;44518.10963780726;44680.10639787211;44689.55310446895;46920.48096392767;47207.52792472074;47332.52667473324;47344;47458.81352966169;8045.477043992122;8774.078721734222;8983.95508022459;8988.235999940012;10405.739856503573;10247.385156890574;10664.30682005671;10674.519646615881;10677.039066484014;10678.305910115856;10688;10738.838917416246;10754.139668826514;10754.408507532082;10755.569777208902;8126.715564955257;8331.50010999342;8351.33189344857;10371.11845493134;10671.83992240117;10253.128484078863;10709.571617135305;10713.83929241062;10721.195910306758;10730.570777168903;42196.78901605503;42837.35743963843;42899.57100428987;42925;42935.14129717388;3483.170163635198;3800.63893930079;3988.3219852625125;4136.627703506669;4199.370094485821;32645.6735432645;33502.32995340104;33604.83197584021;33628.49557256643;33681.326373472395;4100.7334523256195;4355.716878402894;4363.410939523155;4382.6055654991205;4511.842085526991;338545;338582;338794;339292;340901;60188.69905650444;60732.392676073556;60991.695041525396;61248.69375653182;61345;64339;64450.35549644537;64598.67700661561;64739.67630161913;64751.35248647547;16206.189690515426;16454.095024773753;16457.91771041137;16460.506184814476;16470.6705865882;12280.201786883825;12360.196587221802;12363.814542781865;12364.690882727824;12373;16693.248803803857;18112.909435452737;18163.36428225006;18166.5458363542;18255.90872045631;6904.896426553606;6925.134358205224;7071.116110486189;7129.215786263507;7130.286971302932;823.3865770001267;867.4578388507183;998.3460833154296;1004.7588578741049;1045.5033858916954;33022.5046624296;33451.49822752661;33526.66473335236;33555;34094.48858267128;1055.4089709762557;1131.9151063670092;1141.2011591885714;1147.718808891827;1154.809456439695;16288.42990495327;16894.408695695838;16947.237374318185;16959.576010599587;17088.23102960345;586636;587396;589360;592002;593601;59064.70467647634;59858;59997;60341.39658603358;60457;1192.8151136573845;1358.660334916271;1370.8971827112807;1403.8806701430492;1420.6732451535997;31463.269520175694;34080.829595851865;34146.31707365889;34308.48537271993;34674.65325346714;50794.74602626963;50864.745676271385;50885.236721449946;51139.74430127825;51437.22844157415;322598;323335;323570;323781;325712;24620.6306905393;27719.445611087263;28427.147185584465;28556.85721571462;29685.5547166797;48435.51564484451;48552.27171592358;49464;50559.74720126376;50712.49287507078;40774.59225407708;42084.789576051924;42350.788246058575;42422;43041.78479107584;41002.58997410107;41282.587174127875;41667.7916610415;41969.580304197785;42264.366034508894;41108.177836443705;41995.7900210497;42387.5761242396;42417.78791106148;42488;34803;36914.63085369219;37749.245015100096;38025.619743802206;38036.42945355877;28099.157025289274;28223.858880705466;28373.858130709214;28736.281592960342;28866.711332886403 11:42:10 INFO - PROCESS | 15466 | |2;jquery.html;385.2835617324818;386.46860566720767;389.9727019108662;400.16166131953554;415.97296175748573;18927;19500;19600.31398901039;19612.509687257825;20815.583688326224;18891;19394.806051939475;19452.22191112357;19592.510187245327;19953.800461995375;5559.499645031946;5630.521405680502;5689.9146512802345;5721.427857214266;5732.885342293152;5438.83683489494;5542.612017158801;5548.611597188198;5580;5595.104783234683;5316.12283973144;5555.694436805974;5608.887822243552;5615.7472913718775;5660.433956604348;5505.476979686923;5555.111182210867;5594.0769772987815;5613.466720661551;5623.297087863976;4921.876953076166;5181.896362072775;5217.139172036609;5250.789968401259;5251.4485978972425;13710.862891371058;13855.722885542233;13862.58412247624;19330.323438679578;22069.33791986243;2223.788740069691;2282.6918366020705;2302.1597117052324;2414.613661814119;2416.649585810065;9902.108810207115;10256.384616922935;10290.176785857113;10425.270231083827;12765.170263932814;1823.5441139715072;1902.5624106455593;1945.843514686079;1974.5359840437486;1987.175322241268;60508.394916051155;75160.62419687922;76566.23433765702;76777;85160.57419712924;10631.574737010433;10681.786364272672;11000.834987475195;11003.22977391575;11631.95312421886;14864.256787160599;14985.475508357154;14985.850141498664;15046.247687615794;15064.849351506564;8003.559804210708;8035.879461808077;8064.153263907323;8186.222308880647;8215.548144852091;7683.923160768432;7734.110577283572;7746.845063098706;7835.333996610352;7868.842623147505;4612.561806628365;4722.362481065081;4735.076660051257;4770.666053376231;4800.183968725255;1841.2232195930992;1940.4372731907872;1972.8717633353785;1980.8514361422663;1985.9404217873487;877.4165180155253;932.883389576303;958.2669258017622;1031.9886511219047;1039.2673165418362;19320.613587728447;19425.22299108048;19505;19557.31549395793;19814.70277945832;998.7952469743685;1013.7465633591602;1018.1854516386861;1018.7962407518378;1039.656913218636;10609.734756631146;10750.677479675465;11047.779044419067;11302.830457543143;11430.371329576787;334633;339433;496040;498604;503833;62812;67961.66019169873;95859.04140958501;97340.51329743447;99416;1038.5170895533613;1057.513543769859;1063.8989296016866;1064.7976884392097;1081.778235461744;17497.650046999242;18363.449096527125;18383.54041148982;18396;18453.63092738111;41081.38377924274;41221;41223.1755364885;41299.38050929178;41698.374524382765;58324.416755831895;58480.4151958492;59974;60132.699336503036;60654;7374.262573742582;7710.267524585155;7748.535087894745;8179.713710020121;8196.467229630054;9344.766380840261;11733.706657333634;13373.933130334286;13415.731685366432;14037.859621404064;6351.809445716636;9215.354925155174;11849.565169611367;11988.520459181535;12028.15802893789;11560.595379161688;11841.526338946345;11992.160548761503;12358.258504489759;12559.811602825783;9244;11699.473523691284;11840.111991600492;11897.345645989208;12175;8704.825903482022;8817.867731984154;8865.512396818236;8905;9182.862257066283;11264;11845.11161662896;11898.881011189776;11976.76046479083;12085.879141208827 11:42:10 INFO - PROCESS | 15466 | |3;mootools.html;1352.4522568359805;1513.21312917283;1533.9693206135878;1716.8626509879211;1858.2566973210724;8297.211764882342;8715.128487151282;8715.172058654418;8973.730788076351;8986.056464071276;8678.956605216965;8894.644214231423;8898.288136949044;8902.599383027764;8911.153440423166;1982.623301572704;2269.251147121446;2330.9883450582765;2357.0571771291447;2361.551305252005;2317.4553979814814;2335.5212181502834;2343.320437073247;2344.0272287000957;2344.050659482912;2316.6061769499224;2377.3818807110188;2378.369732021016;2380.321608341623;2384.463495713468;2006.4482267376516;2292.0946226240626;2353.082297903819;2355.9057637694473;2395.532871090121;2298.184144628666;2301.4131396493954;2305.988470057656;2306.757790432014;2348.4011577047913;8817.470951742851;8931.062238464932;8935.463872167691;8938.821223575493;8942.821143577157;5274;5388.649737767033;5401.567874570025;5407.486288802557;5411.972940135313;3210.2776875203126;3281.2289112058647;3333.683300086488;3334.583177102862;3351.4805205193234;1030.9793804123876;1050.8056009638242;1058.973525661857;1099.4887377369562;1105.0496572947259;12360.258384496869;12445.875541244563;12463;12478.064145189057;12485.188462749982;4597.218472859622;4724.71651700899;4747.098051370229;4845.3216549683075;4849.393825771778;10518;10520.579176832842;10524.473776311306;10534.683959481228;10539.473026348653;4856.660033797671;5362.65142765719;5362.946370536322;5363.329583802025;5364.275822763877;4771.188897887368;4886.755662216875;4890.559849613552;4970.751462426864;4970.801167953241;4024.939625905614;4049.271131196413;4118.794494305225;4263.616274535245;4271.722338048017;1218.3055658274875;1251.28676654308;1252.9812052819216;1275.8724127587168;1298.1756584568866;934.2059249637754;1015.4161357219481;1016.364772017489;1024.3341827811983;1038.2680210451613;6091.5735898487565;6309.842253943596;6322.9051564226575;6325.9051114233325;6339.746410143634;423.9448871646666;426.23916309388215;428.20567846644025;428.3296640757205;1065.6536625596711;3981.243563722883;4227.577242275809;4227.725197862129;4303.268444364466;4316.892077698083;11008.779824403468;11309.434528273554;11319.830202546967;11333.829992550118;11339.943300283447;11043.503042363112;11089.27919685218;11104.666859994213;11129.666110016713;11151.38667373286;7939.245771651684;8171.264586187272;8294.460860044077;8296.83406331882;8310.21052999964;6244.5325348543965;6369.172007638977;6377.0753240778895;6403.359664033559;6461.256955450183;9937.453440060866;10117.544710488193;10295.3822770634;10312.432816195182;10322.225833062701;10387.740306492398;10478.109360704426;10514;10519;10522.263441559018;7270.454715896223;7436.144843342869;7519.097708274823;7998.160193179865;8146.389020823581;8660.870086948575;8843.204111629984;8851.026387097543;8857.335699822668;8872.955635221782;7643.4267429941865;7930.881036784337;7985.760427187193;7988.760337189894;8137.471064380797;7756.108047574376;7806.882896756667;7866.056073271244;7907.9604601976625;7930.088039875488;7065.222825489295;7073.929260707327;7148.535345202546;7155.248698886542;7160.212376638669;5518.420565840529;5552.222688823487;5564.749586268546;5619.915701264566;5622.922842001251;5296.496832800878;5403.945960540502;5448.291722076263;5557.888842223052;5562.054450743302 11:42:10 INFO - PROCESS | 15466 | |4;prototype.html;315.879965613067;325.6564324637508;334.5466892360851;335.37954783650235;336.70706485357744;5323.787048518059;5379.6503227290195;5385.434529374418;5426.294581704378;5506.531944784698;5358.258565966057;5371.382291036532;5391.245225668409;5410.621256512046;5427.317531565218;4222.408862759216;4224.366345048252;4233.645233525273;4236.585146466516;4245.851395201169;4104.42538044674;4230.238557059728;4236.771336312481;4241.703080784347;4243.278642630745;4169.6455801256925;4185.748855068706;4196.832126714943;4200.97899510502;4230.725002874803;4213.389058586518;4251.022264879064;4252.893677658068;4264.616184543391;4266.552012038738;3699.593044765101;3778.1499162688174;3799.525059367579;3802.3535998880257;3803.220339830328;5194.961007798455;5202.358349155568;5202.777347323376;5229.294045303874;5253.395859476171;4797.2564252540915;4827.227643577011;4843.200871856139;4845.3216549683075;4941.703497790144;5453.618246722731;5632.436756324335;5643.209950606918;5643.322801263875;5701.828945131652;4126.587341265879;4132.834686612532;4135.462389889325;4138.6482149017365;4143.316352801784;5634.943650563483;5676.631018983753;5961;5972.850678733023;6008.128821320927;4147.212029714345;4156.376543518496;4156.625903668624;4159.542450330461;4204.348326009474;4237.6821738369745;4251.128518653669;4251.787410629456;4254.255505286563;4262.318029115327;4637.814487420465;4645.674802763841;4801.51984801517;4823.155947709137;4875.853724388274;5621.9360448555635;5639.915401268984;5671.476193094116;5672.546196304285;5672.914906276409;1451.165579791624;1462.612407711957;1469.9485518006818;1472.7275454040823;1474.402866838932;938.3572253006712;947.2989987409268;951.362587066667;954.513198268874;964.8311545479653;4816.181249187646;4836.806527738921;4855.927161092586;4876.244551961291;4916.901661966741;4976.527229913152;5097.852983078852;5148.021875843578;5189.028169295643;5209.613751061765;4901.730404827697;4946.653734238641;4955.876103097451;5091.66904151229;5450.22867568042;3059.990203232928;3065.601471808651;3068.969310306913;3085.645150807641;3100.534919762054;5954.583179177416;5959.553033522417;5960.463558279689;6007.909881351783;6021.217241758543;5597.720113994284;5844.707764611752;5863.413658634103;5864.182103547829;5890.4993075589055;5959.612625179349;5978.521718262528;6005.189299444606;6012.879742405127;6096.207493025967;5743.396943321059;5874.383189765013;5880.529557635465;5929.140274660236;5961.91057134152;5548.445155484419;5757.424257574209;5808.128780682931;5814.709264536841;5815.86590614826;5745.8563535911935;5859.794907178229;5893.499052580407;5897.705114744332;5991;3973.2252210818615;4005.35914253718;4016.096378314856;4021.336479480853;4040.777757223381;5681.2330335404195;5790.305163380422;5798.507126894261;5834.599696072827;5902.911456328073;5604.635698679573;5606.822567260758;5614.747336369792;5633.661980281032;5651.378348381757;5552.250446189712;5572.192032155396;5618.775248990158;5624.521915637217;5661.037623604079;5370.543503802064;5568.415316391721;5589.133684278943;5599.552035837041;5610;5676.68778217202;5677.51741102011;5733.369329373682;5753.252077229933;5768.653880767168;5321.521063104185;5555.944230673194;5555.944440555542;5566.385748133158;5586.581006424453 11:42:10 INFO - PROCESS | 15466 | |5;yui.html;745.3366503811608;771.8449968789322;829.4194064155089;843.7974886027355;847.3009766942271;12699.238045717251;12939.676508087303;12950.935245323784;12968;12970;12693.174943628681;13229.933850330759;13233.073684842066;13657.180569165832;13998.720025599481;673.4376795375867;819.5943008210944;820.335528222142;825.5459497276504;825.6738588257634;683.4122654517112;688.8828899087167;689.2556039477353;801.3789313282224;824.1593574553951;856.644492535597;857.5283594023293;857.5626430520448;858.0389963241179;858.2147335188296;850.0139837788136;851.9488830670149;852.3096292003497;853.0488505316589;854.9487030778142;520.3261776000052;615.2063837649426;620.6338260426324;626.1765778001912;626.9717862696144;14675.412983480755;14786.112833230041;14826;14914.850851491454;14945.850541494554;12928.54750083752;13323.86676133236;13451.192928424229;13503.189808611514;13509.256990865499;12050.683229813665;12127.151099423045;12336.81494777579;12350.567730129493;13087.738245235138;4351.108022855307;4388.846390376353;4402.845900393503;4529.614982726473;4607.861764147081;58269.70865145647;59130.40869591292;59424.405755942316;59703.40296597022;60198;10665.573377064831;10781.568737250422;10910.563577456971;11039.227254092297;11141.498632561554;18588;19561.217551298072;19609.117589708498;19634.803651963583;19658.213671453268;8318.916810831814;8374.916250837536;8433.072362040171;8679.6528138875;8727.214550690469;4550.726956382561;4577.267637178102;4681.227597446383;4729.763511824395;4774.140654682191;3392.9830350848088;3431.1422144463886;3442.0534353053113;3442.896713098611;3452.223249768782;628.9622622642656;639.2903876696863;654.7904670505487;657.1949362031569;668.0313545359248;571.4885177765959;635.8632893927828;706.1349846438072;717.178830239373;722.7181399254295;9612.782424166771;10233.181345492492;10303.536340864679;10336.948315258376;10398.68803935883;627.2942939193407;674.5547938360659;692.1590267824618;716.8279612892868;748.3900620993873;4570.88572785683;4694.366260554782;4727.220008698595;4738.491703925955;4800.399950006249;69307.3069269311;69985.65007175034;71437.64281178561;72052;72243;53481.465185348425;64661.06016819503;65593.34406655873;66098.33901661017;68320.65839670869;56177.43822561804;56401.153982690295;57219.711211552734;58358;58442.70778646079;9523.333366664267;9540.093691099335;9544.284178686488;9683.612655493702;9781.902180978099;36441.81779091088;37852.62147378491;38404;38430.231395372495;38888.222235555695;51035.74482127566;51338.122878326496;51528.48471515387;52055.47944520506;52391.73804130955;12254.693632659255;12440.875591243972;12656.620301390973;13001.284929328978;13174.670633234246;13632;13919.791203132163;14130.15219086858;14201.076929999517;14320.641983950485;12867.227966321676;13217.669558261121;13347.532836350681;13444.993456637269;13795.862041379458;13156.276404797827;13210.339483025618;13328.200307981551;13445.865541344461;13505.662358441117;13286.468541258242;13311.933440332736;13370.665733356744;13405.530806421728;13561.321933903462;10772.515236814206;11137.276077054965;11163.162762792661;11199.776004480027;11323.830142547704;10300.278980471296;10567.260291779501;10647.666081575433;10654.57381704723;10897.182711296842 11:42:10 INFO - PROCESS | 15466 | __end_tp_report 11:42:10 INFO - PROCESS | 15466 | __start_cc_report 11:42:10 INFO - PROCESS | 15466 | _x_x_mozilla_cycle_collect,881 11:42:10 INFO - PROCESS | 15466 | __end_cc_report 11:42:10 INFO - PROCESS | 15466 | __startTimestamp1464201730383__endTimestamp 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | ------- Summary: start ------- 11:42:10 INFO - PROCESS | 15466 | Number of tests: 6 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#0] dojo.html Cycles:165 Average:5440.35 Median:5657.38 stddev:623.76 (11.0%) stddev-sans-first:598.55 11:42:10 INFO - PROCESS | 15466 | Values: 3121.1 3123.5 3148.0 3172.6 3190.3 5318.0 5349.7 5410.5 5461.7 5497.5 5407.0 5426.5 5490.8 5530.4 5565.6 4890.8 4957.1 4978.9 4991.2 5134.0 5036.5 5053.8 5085.5 5102.7 5103.2 4878.4 4896.9 4923.0 4972.2 5079.2 4921.9 4939.3 4943.5 5005.1 5048.5 4948.7 4977.7 4979.2 4993.4 5044.9 5252.9 5331.4 5399.9 5483.2 5484.0 5880.4 5887.2 5912.6 5933.9 5938.2 5712.5 5939.6 5949.5 5951.4 5952.9 5395.6 5439.1 5465.1 5516.6 5527.2 6053.0 6074.5 6075.6 6081.1 6082.9 5627.9 5657.4 5800.0 5808.8 5809.1 5797.6 5850.0 5902.8 5902.9 5906.7 5803.5 5815.1 5831.4 5832.1 5856.4 5663.5 5802.4 5846.9 5853.4 5854.3 4460.1 4466.4 4470.4 4506.1 4508.8 3967.7 3984.4 3992.3 3992.9 4023.4 5370.5 5405.8 5502.1 5533.2 5564.4 5883.8 5891.7 5903.7 5911.9 5950.2 5569.6 5578.4 5582.1 5585.4 5586.2 4896.0 4938.3 4986.0 5007.5 5072.6 6012.9 6016.5 6018.4 6019.8 6024.7 5799.8 5811.5 5814.8 5815.6 5817.2 5842.1 6011.8 6043.1 6096.6 6143.6 5787.9 5819.9 5821.9 5825.7 5830.5 5678.3 5909.4 5925.4 5933.1 5933.2 5668.6 5738.5 5738.9 5770.2 5781.0 5715.9 5733.0 5733.5 5745.3 5756.3 5479.9 5561.4 5577.4 5578.9 5586.3 5763.2 5859.1 5875.3 5876.2 5878.1 5622.6 5678.9 5680.6 5685.5 5686.5 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#1] ext.html Cycles:180 Average:58996.24 Median:20913.13 stddev:115566.18 (552.6%) stddev-sans-first:115807.16 11:42:10 INFO - PROCESS | 15466 | Values: 583.1 622.2 629.5 630.8 646.0 33108.7 43847.3 44518.1 44680.1 44689.6 46920.5 47207.5 47332.5 47344.0 47458.8 8045.5 8774.1 8984.0 8988.2 10405.7 10247.4 10664.3 10674.5 10677.0 10678.3 10688.0 10738.8 10754.1 10754.4 10755.6 8126.7 8331.5 8351.3 10371.1 10671.8 10253.1 10709.6 10713.8 10721.2 10730.6 42196.8 42837.4 42899.6 42925.0 42935.1 3483.2 3800.6 3988.3 4136.6 4199.4 32645.7 33502.3 33604.8 33628.5 33681.3 4100.7 4355.7 4363.4 4382.6 4511.8 338545.0 338582.0 338794.0 339292.0 340901.0 60188.7 60732.4 60991.7 61248.7 61345.0 64339.0 64450.4 64598.7 64739.7 64751.4 16206.2 16454.1 16457.9 16460.5 16470.7 12280.2 12360.2 12363.8 12364.7 12373.0 16693.2 18112.9 18163.4 18166.5 18255.9 6904.9 6925.1 7071.1 7129.2 7130.3 823.4 867.5 998.3 1004.8 1045.5 33022.5 33451.5 33526.7 33555.0 34094.5 1055.4 1131.9 1141.2 1147.7 1154.8 16288.4 16894.4 16947.2 16959.6 17088.2 586636.0 587396.0 589360.0 592002.0 593601.0 59064.7 59858.0 59997.0 60341.4 60457.0 1192.8 1358.7 1370.9 1403.9 1420.7 31463.3 34080.8 34146.3 34308.5 34674.7 50794.7 50864.7 50885.2 51139.7 51437.2 322598.0 323335.0 323570.0 323781.0 325712.0 24620.6 27719.4 28427.1 28556.9 29685.6 48435.5 48552.3 49464.0 50559.7 50712.5 40774.6 42084.8 42350.8 42422.0 43041.8 41002.6 41282.6 41667.8 41969.6 42264.4 41108.2 41995.8 42387.6 42417.8 42488.0 34803.0 36914.6 37749.2 38025.6 38036.4 28099.2 28223.9 28373.9 28736.3 28866.7 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#2] jquery.html Cycles:180 Average:26900.86 Median:168524.82 stddev:73025.95 (43.3%) stddev-sans-first:73203.67 11:42:10 INFO - PROCESS | 15466 | Values: 385.3 386.5 390.0 400.2 416.0 18927.0 19500.0 19600.3 19612.5 20815.6 18891.0 19394.8 19452.2 19592.5 19953.8 5559.5 5630.5 5689.9 5721.4 5732.9 5438.8 5542.6 5548.6 5580.0 5595.1 5316.1 5555.7 5608.9 5615.7 5660.4 5505.5 5555.1 5594.1 5613.5 5623.3 4921.9 5181.9 5217.1 5250.8 5251.4 13710.9 13855.7 13862.6 19330.3 22069.3 2223.8 2282.7 2302.2 2414.6 2416.6 9902.1 10256.4 10290.2 10425.3 12765.2 1823.5 1902.6 1945.8 1974.5 1987.2 60508.4 75160.6 76566.2 76777.0 85160.6 10631.6 10681.8 11000.8 11003.2 11632.0 14864.3 14985.5 14985.9 15046.2 15064.8 8003.6 8035.9 8064.2 8186.2 8215.5 7683.9 7734.1 7746.8 7835.3 7868.8 4612.6 4722.4 4735.1 4770.7 4800.2 1841.2 1940.4 1972.9 1980.9 1985.9 877.4 932.9 958.3 1032.0 1039.3 19320.6 19425.2 19505.0 19557.3 19814.7 998.8 1013.7 1018.2 1018.8 1039.7 10609.7 10750.7 11047.8 11302.8 11430.4 334633.0 339433.0 496040.0 498604.0 503833.0 62812.0 67961.7 95859.0 97340.5 99416.0 1038.5 1057.5 1063.9 1064.8 1081.8 17497.7 18363.4 18383.5 18396.0 18453.6 41081.4 41221.0 41223.2 41299.4 41698.4 58324.4 58480.4 59974.0 60132.7 60654.0 7374.3 7710.3 7748.5 8179.7 8196.5 9344.8 11733.7 13373.9 13415.7 14037.9 6351.8 9215.4 11849.6 11988.5 12028.2 11560.6 11841.5 11992.2 12358.3 12559.8 9244.0 11699.5 11840.1 11897.3 12175.0 8704.8 8817.9 8865.5 8905.0 9182.9 11264.0 11845.1 11898.9 11976.8 12085.9 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#3] mootools.html Cycles:180 Average:5911.16 Median:2365.80 stddev:3380.39 (142.9%) stddev-sans-first:3372.51 11:42:10 INFO - PROCESS | 15466 | Values: 1352.5 1513.2 1534.0 1716.9 1858.3 8297.2 8715.1 8715.2 8973.7 8986.1 8679.0 8894.6 8898.3 8902.6 8911.2 1982.6 2269.3 2331.0 2357.1 2361.6 2317.5 2335.5 2343.3 2344.0 2344.1 2316.6 2377.4 2378.4 2380.3 2384.5 2006.4 2292.1 2353.1 2355.9 2395.5 2298.2 2301.4 2306.0 2306.8 2348.4 8817.5 8931.1 8935.5 8938.8 8942.8 5274.0 5388.6 5401.6 5407.5 5412.0 3210.3 3281.2 3333.7 3334.6 3351.5 1031.0 1050.8 1059.0 1099.5 1105.0 12360.3 12445.9 12463.0 12478.1 12485.2 4597.2 4724.7 4747.1 4845.3 4849.4 10518.0 10520.6 10524.5 10534.7 10539.5 4856.7 5362.7 5362.9 5363.3 5364.3 4771.2 4886.8 4890.6 4970.8 4970.8 4024.9 4049.3 4118.8 4263.6 4271.7 1218.3 1251.3 1253.0 1275.9 1298.2 934.2 1015.4 1016.4 1024.3 1038.3 6091.6 6309.8 6322.9 6325.9 6339.7 423.9 426.2 428.2 428.3 1065.7 3981.2 4227.6 4227.7 4303.3 4316.9 11008.8 11309.4 11319.8 11333.8 11339.9 11043.5 11089.3 11104.7 11129.7 11151.4 7939.2 8171.3 8294.5 8296.8 8310.2 6244.5 6369.2 6377.1 6403.4 6461.3 9937.5 10117.5 10295.4 10312.4 10322.2 10387.7 10478.1 10514.0 10519.0 10522.3 7270.5 7436.1 7519.1 7998.2 8146.4 8660.9 8843.2 8851.0 8857.3 8873.0 7643.4 7930.9 7985.8 7988.8 8137.5 7756.1 7806.9 7866.1 7908.0 7930.1 7065.2 7073.9 7148.5 7155.2 7160.2 5518.4 5552.2 5564.7 5619.9 5622.9 5296.5 5403.9 5448.3 5557.9 5562.1 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#4] prototype.html Cycles:180 Average:4721.46 Median:5341.02 stddev:1377.33 (25.8%) stddev-sans-first:1340.91 11:42:10 INFO - PROCESS | 15466 | Values: 315.9 325.7 334.5 335.4 336.7 5323.8 5379.7 5385.4 5426.3 5506.5 5358.3 5371.4 5391.2 5410.6 5427.3 4222.4 4224.4 4233.6 4236.6 4245.9 4104.4 4230.2 4236.8 4241.7 4243.3 4169.6 4185.7 4196.8 4201.0 4230.7 4213.4 4251.0 4252.9 4264.6 4266.6 3699.6 3778.1 3799.5 3802.4 3803.2 5195.0 5202.4 5202.8 5229.3 5253.4 4797.3 4827.2 4843.2 4845.3 4941.7 5453.6 5632.4 5643.2 5643.3 5701.8 4126.6 4132.8 4135.5 4138.6 4143.3 5634.9 5676.6 5961.0 5972.9 6008.1 4147.2 4156.4 4156.6 4159.5 4204.3 4237.7 4251.1 4251.8 4254.3 4262.3 4637.8 4645.7 4801.5 4823.2 4875.9 5621.9 5639.9 5671.5 5672.5 5672.9 1451.2 1462.6 1469.9 1472.7 1474.4 938.4 947.3 951.4 954.5 964.8 4816.2 4836.8 4855.9 4876.2 4916.9 4976.5 5097.9 5148.0 5189.0 5209.6 4901.7 4946.7 4955.9 5091.7 5450.2 3060.0 3065.6 3069.0 3085.6 3100.5 5954.6 5959.6 5960.5 6007.9 6021.2 5597.7 5844.7 5863.4 5864.2 5890.5 5959.6 5978.5 6005.2 6012.9 6096.2 5743.4 5874.4 5880.5 5929.1 5961.9 5548.4 5757.4 5808.1 5814.7 5815.9 5745.9 5859.8 5893.5 5897.7 5991.0 3973.2 4005.4 4016.1 4021.3 4040.8 5681.2 5790.3 5798.5 5834.6 5902.9 5604.6 5606.8 5614.7 5633.7 5651.4 5552.3 5572.2 5618.8 5624.5 5661.0 5370.5 5568.4 5589.1 5599.6 5610.0 5676.7 5677.5 5733.4 5753.3 5768.7 5321.5 5555.9 5555.9 5566.4 5586.6 11:42:10 INFO - PROCESS | 15466 | 11:42:10 INFO - PROCESS | 15466 | [#5] yui.html Cycles:180 Average:16079.77 Median:4592.56 stddev:19495.51 (424.5%) stddev-sans-first:19516.20 11:42:10 INFO - PROCESS | 15466 | Values: 745.3 771.8 829.4 843.8 847.3 12699.2 12939.7 12950.9 12968.0 12970.0 12693.2 13229.9 13233.1 13657.2 13998.7 673.4 819.6 820.3 825.5 825.7 683.4 688.9 689.3 801.4 824.2 856.6 857.5 857.6 858.0 858.2 850.0 851.9 852.3 853.0 854.9 520.3 615.2 620.6 626.2 627.0 14675.4 14786.1 14826.0 14914.9 14945.9 12928.5 13323.9 13451.2 13503.2 13509.3 12050.7 12127.2 12336.8 12350.6 13087.7 4351.1 4388.8 4402.8 4529.6 4607.9 58269.7 59130.4 59424.4 59703.4 60198.0 10665.6 10781.6 10910.6 11039.2 11141.5 18588.0 19561.2 19609.1 19634.8 19658.2 8318.9 8374.9 8433.1 8679.7 8727.2 4550.7 4577.3 4681.2 4729.8 4774.1 3393.0 3431.1 3442.1 3442.9 3452.2 629.0 639.3 654.8 657.2 668.0 571.5 635.9 706.1 717.2 722.7 9612.8 10233.2 10303.5 10336.9 10398.7 627.3 674.6 692.2 716.8 748.4 4570.9 4694.4 4727.2 4738.5 4800.4 69307.3 69985.7 71437.6 72052.0 72243.0 53481.5 64661.1 65593.3 66098.3 68320.7 56177.4 56401.2 57219.7 58358.0 58442.7 9523.3 9540.1 9544.3 9683.6 9781.9 36441.8 37852.6 38404.0 38430.2 38888.2 51035.7 51338.1 51528.5 52055.5 52391.7 12254.7 12440.9 12656.6 13001.3 13174.7 13632.0 13919.8 14130.2 14201.1 14320.6 12867.2 13217.7 13347.5 13445.0 13795.9 13156.3 13210.3 13328.2 13445.9 13505.7 13286.5 13311.9 13370.7 13405.5 13561.3 10772.5 11137.3 11163.2 11199.8 11323.8 10300.3 10567.3 10647.7 10654.6 10897.2 11:42:10 INFO - PROCESS | 15466 | -------- Summary: end -------- 11:42:10 INFO - PROCESS | 15466 | 11:42:11 INFO - TEST-INFO | 15466: exit 0 11:42:11 INFO - TEST-OK | dromaeo_css | took 1113351ms 11:42:11 INFO - TEST-START | kraken 11:42:11 INFO - operating with platform_type : linux_ 11:42:11 INFO - Initialising browser for kraken test... 11:42:11 INFO - TEST-INFO | started process 15649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX04r9B/profile http://localhost:47794/getInfo.html) 11:42:14 INFO - PROCESS | 15649 | __metrics Screen width/height:1600/1200 11:42:14 INFO - PROCESS | 15649 | colorDepth:24 11:42:14 INFO - PROCESS | 15649 | Browser inner width/height: 1024/697 11:42:14 INFO - PROCESS | 15649 | __metrics 11:42:16 ERROR - PROCESS | 15649 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:42:16 INFO - TEST-INFO | 15649: exit 0 11:42:16 INFO - Browser initialized. 11:42:16 INFO - Running cycle 1/1 for kraken test... 11:42:16 INFO - TEST-INFO | started process 15729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX04r9B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:28 INFO - PROCESS | 15729 | RSS: Main: 155373568 11:42:28 INFO - PROCESS | 15729 | 11:42:31 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:32 INFO - PROCESS | 15729 | RSS: Main: 211922944 11:42:32 INFO - PROCESS | 15729 | 11:42:34 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-dft) 11:42:35 INFO - PROCESS | 15729 | RSS: Main: 199770112 11:42:35 INFO - PROCESS | 15729 | 11:42:38 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-fft) 11:42:39 INFO - PROCESS | 15729 | RSS: Main: 268005376 11:42:39 INFO - PROCESS | 15729 | 11:42:41 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-oscillator) 11:42:41 INFO - PROCESS | 15729 | RSS: Main: 176824320 11:42:41 INFO - PROCESS | 15729 | 11:42:43 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:44 INFO - PROCESS | 15729 | RSS: Main: 181469184 11:42:44 INFO - PROCESS | 15729 | 11:42:47 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:48 INFO - PROCESS | 15729 | RSS: Main: 217571328 11:42:48 INFO - PROCESS | 15729 | 11:42:51 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:52 INFO - PROCESS | 15729 | RSS: Main: 218140672 11:42:52 INFO - PROCESS | 15729 | 11:42:54 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47794/tests/kraken/driver.html?testName=json-parse-financial) 11:42:55 INFO - PROCESS | 15729 | RSS: Main: 218775552 11:42:55 INFO - PROCESS | 15729 | 11:42:57 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:57 INFO - PROCESS | 15729 | RSS: Main: 205238272 11:42:57 INFO - PROCESS | 15729 | 11:42:59 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:00 INFO - PROCESS | 15729 | RSS: Main: 208453632 11:43:00 INFO - PROCESS | 15729 | 11:43:02 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:02 INFO - PROCESS | 15729 | RSS: Main: 218578944 11:43:02 INFO - PROCESS | 15729 | 11:43:05 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:05 INFO - PROCESS | 15729 | RSS: Main: 226971648 11:43:05 INFO - PROCESS | 15729 | 11:43:08 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:09 INFO - PROCESS | 15729 | RSS: Main: 224661504 11:43:09 INFO - PROCESS | 15729 | 11:43:10 INFO - PROCESS | 15729 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47794/tests/kraken/driver.html?testName=ai-astar) 11:43:11 INFO - PROCESS | 15729 | RSS: Main: 270540800 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | __start_tp_report 11:43:11 INFO - PROCESS | 15729 | _x_x_mozilla_page_load 11:43:11 INFO - PROCESS | 15729 | _x_x_mozilla_page_load_details 11:43:11 INFO - PROCESS | 15729 | |i|pagename|runs| 11:43:11 INFO - PROCESS | 15729 | |0;ai-astar;111;104;110;112;109;111;109;108;109;108 11:43:11 INFO - PROCESS | 15729 | |1;audio-beat-detection;155;124;125;172;127;136;157;125;156;131 11:43:11 INFO - PROCESS | 15729 | |2;audio-dft;160;160;160;160;161;161;162;160;160;161 11:43:11 INFO - PROCESS | 15729 | |3;audio-fft;74;74;74;109;74;76;74;75;104;73 11:43:11 INFO - PROCESS | 15729 | |4;audio-oscillator;83;83;128;85;83;84;114;85;84;121 11:43:11 INFO - PROCESS | 15729 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 11:43:11 INFO - PROCESS | 15729 | |6;imaging-darkroom;145;145;145;145;145;146;146;178;145;146 11:43:11 INFO - PROCESS | 15729 | |7;imaging-desaturate;96;95;95;95;95;94;96;95;95;95 11:43:11 INFO - PROCESS | 15729 | |8;json-parse-financial;53;54;53;54;54;55;53;73;52;52 11:43:11 INFO - PROCESS | 15729 | |9;json-stringify-tinderbox;62;62;62;63;63;62;62;62;64;62 11:43:11 INFO - PROCESS | 15729 | |10;stanford-crypto-aes;79;79;80;79;80;79;82;80;80;80 11:43:11 INFO - PROCESS | 15729 | |11;stanford-crypto-ccm;121;120;134;118;120;125;125;120;162;128 11:43:11 INFO - PROCESS | 15729 | |12;stanford-crypto-pbkdf2;161;160;160;158;165;162;159;159;160;160 11:43:11 INFO - PROCESS | 15729 | |13;stanford-crypto-sha256-iterative;62;64;65;63;62;61;62;62;63;65 11:43:11 INFO - PROCESS | 15729 | __end_tp_report 11:43:11 INFO - PROCESS | 15729 | __start_cc_report 11:43:11 INFO - PROCESS | 15729 | _x_x_mozilla_cycle_collect,1666 11:43:11 INFO - PROCESS | 15729 | __end_cc_report 11:43:11 INFO - PROCESS | 15729 | __startTimestamp1464201791181__endTimestamp 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | ------- Summary: start ------- 11:43:11 INFO - PROCESS | 15729 | Number of tests: 14 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#0] ai-astar Cycles:10 Average:109.10 Median:109.50 stddev:2.23 (2.0%) stddev-sans-first:2.26 11:43:11 INFO - PROCESS | 15729 | Values: 111.0 104.0 110.0 112.0 109.0 111.0 109.0 108.0 109.0 108.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:145.50 stddev:17.51 (12.0%) stddev-sans-first:17.80 11:43:11 INFO - PROCESS | 15729 | Values: 155.0 124.0 125.0 172.0 127.0 136.0 157.0 125.0 156.0 131.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 11:43:11 INFO - PROCESS | 15729 | Values: 160.0 160.0 160.0 160.0 161.0 161.0 162.0 160.0 160.0 161.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.00 stddev:13.67 (18.5%) stddev-sans-first:14.28 11:43:11 INFO - PROCESS | 15729 | Values: 74.0 74.0 74.0 109.0 74.0 76.0 74.0 75.0 104.0 73.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:83.50 stddev:18.26 (21.9%) stddev-sans-first:18.84 11:43:11 INFO - PROCESS | 15729 | Values: 83.0 83.0 128.0 85.0 83.0 84.0 114.0 85.0 84.0 121.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:43:11 INFO - PROCESS | 15729 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:145.50 stddev:10.34 (7.1%) stddev-sans-first:10.89 11:43:11 INFO - PROCESS | 15729 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 146.0 178.0 145.0 146.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 11:43:11 INFO - PROCESS | 15729 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:6.29 (11.6%) stddev-sans-first:6.62 11:43:11 INFO - PROCESS | 15729 | Values: 53.0 54.0 53.0 54.0 54.0 55.0 53.0 73.0 52.0 52.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:43:11 INFO - PROCESS | 15729 | Values: 62.0 62.0 62.0 63.0 63.0 62.0 62.0 62.0 64.0 62.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 11:43:11 INFO - PROCESS | 15729 | Values: 79.0 79.0 80.0 79.0 80.0 79.0 82.0 80.0 80.0 80.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:125.00 stddev:13.11 (10.5%) stddev-sans-first:13.70 11:43:11 INFO - PROCESS | 15729 | Values: 121.0 120.0 134.0 118.0 120.0 125.0 125.0 120.0 162.0 128.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.00 stddev:1.96 (1.2%) stddev-sans-first:2.06 11:43:11 INFO - PROCESS | 15729 | Values: 161.0 160.0 160.0 158.0 165.0 162.0 159.0 159.0 160.0 160.0 11:43:11 INFO - PROCESS | 15729 | 11:43:11 INFO - PROCESS | 15729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.37 (2.2%) stddev-sans-first:1.41 11:43:11 INFO - PROCESS | 15729 | Values: 62.0 64.0 65.0 63.0 62.0 61.0 62.0 62.0 63.0 65.0 11:43:11 INFO - PROCESS | 15729 | -------- Summary: end -------- 11:43:11 INFO - PROCESS | 15729 | 11:43:12 INFO - TEST-INFO | 15729: exit 0 11:43:12 INFO - TEST-OK | kraken | took 61091ms 11:43:12 INFO - SUITE-END | took 1174s 11:43:12 INFO - Completed test suite (00:19:34) 11:43:12 INFO - javascript benchmark 11:43:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.0636808957306, 3123.4846250368705, 3148.0241125251173, 3172.5875636167293, 3190.282186508036, 5318.042752304584, 5349.652272602279, 5410.48600382964, 5461.672299662018, 5497.532709719673, 5406.999705054558, 5426.484483974016, 5490.835274941748, 5530.446955304467, 5565.582581306408, 4890.8043678252825, 4957.058158949806, 4978.850634480953, 4991.226359914219, 5133.974330128344, 5036.471170527097, 5053.84838454847, 5085.5423011928915, 5102.744862756866, 5103.2090026045835, 4878.438979517366, 4896.877578060541, 4922.950770492285, 4972.204447288416, 5079.161938280179, 4921.8523444296725, 4939.333190019337, 4943.4809345018975, 5005.0990821652085, 5048.495150484959, 4948.67833590819, 4977.7262250576205, 4979.178435558165, 4993.350864387643, 5044.873878153076, 5252.894942101175, 5331.386890507602, 5399.919001214985, 5483.2049352844015, 5484.0, 5880.353161152269, 5887.234659494238, 5912.645241285493, 5933.851653708692, 5938.228030356069, 5712.542996560265, 5939.643621382731, 5949.464548190684, 5951.3751056139345, 5952.851178720523, 5395.5953303502, 5439.129739241742, 5465.07093794056, 5516.558675305966, 5527.198556209368, 6052.969735151384, 6074.51403887688, 6075.574709770273, 6081.087836824512, 6082.908756368658, 5627.859303517363, 5657.377688454267, 5800.0429929062075, 5808.82573522795, 5809.099589563624, 5797.623154494944, 5850.034744267148, 5902.822915312548, 5902.940970590325, 5906.734196961147, 5803.5357171426185, 5815.098659707752, 5831.387704290988, 5832.096025116114, 5856.443637854397, 5663.546916246691, 5802.390748971382, 5846.94153058464, 5853.356130825606, 5854.268216472941, 4460.085682435093, 4466.39703640011, 4470.396496472999, 4506.098780243964, 4508.819647214074, 3967.662748666338, 3984.442178095069, 3992.301347264217, 3992.8802135935966, 4023.3562629979065, 5370.489803468664, 5405.7837686492885, 5502.147167189092, 5533.170024496278, 5564.360098588714, 5883.823485295448, 5891.734871930774, 5903.675297858573, 5911.852203694942, 5950.166976623276, 5569.610127291051, 5578.3584887738425, 5582.134769110794, 5585.413531579207, 5586.24585680936, 4896.0, 4938.333325001151, 4985.9750701246985, 5007.549320561094, 5072.568831649277, 6012.939870601325, 6016.458518733335, 6018.368071352533, 6019.759209631566, 6024.698765061729, 5799.797007104731, 5811.506021988178, 5814.825555233349, 5815.5929084963645, 5817.214676018683, 5842.123681447647, 6011.789587364421, 6043.12374705674, 6096.603720758137, 6143.56995010345, 5787.94212057874, 5819.854503637443, 5821.912671310019, 5825.737841797045, 5830.47525722687, 5678.290213723285, 5909.379515151019, 5925.377835327228, 5933.110033494838, 5933.228680271537, 5668.574856885833, 5738.540916726568, 5738.942610573841, 5770.221020162225, 5780.971095144498, 5715.942840571707, 5733.0, 5733.483986441241, 5745.3105627324985, 5756.30924289088, 5479.890402191854, 5561.3882472927135, 5577.414371490935, 5578.944210557843, 5586.273784408001, 5763.193152958673, 5859.062549991981, 5875.265591801025, 5876.1773351729935, 5878.147668588116, 5622.550195984393, 5678.886422271449, 5680.630759000652, 5685.516731077904, 5686.488216060575], "value": 5397.8199016079825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.0991118721574, 622.1911515030461, 629.483823264923, 630.7886857902603, 645.9547831651785, 33108.66891331086, 43847.342289865635, 44518.10963780726, 44680.10639787211, 44689.55310446895, 46920.48096392767, 47207.52792472074, 47332.52667473324, 47344.0, 47458.81352966169, 8045.477043992122, 8774.078721734222, 8983.95508022459, 8988.235999940012, 10405.739856503573, 10247.385156890574, 10664.30682005671, 10674.519646615881, 10677.039066484014, 10678.305910115856, 10688.0, 10738.838917416246, 10754.139668826514, 10754.408507532082, 10755.569777208902, 8126.715564955257, 8331.50010999342, 8351.33189344857, 10371.11845493134, 10671.83992240117, 10253.128484078863, 10709.571617135305, 10713.83929241062, 10721.195910306758, 10730.570777168903, 42196.78901605503, 42837.35743963843, 42899.57100428987, 42925.0, 42935.14129717388, 3483.170163635198, 3800.63893930079, 3988.3219852625125, 4136.627703506669, 4199.370094485821, 32645.6735432645, 33502.32995340104, 33604.83197584021, 33628.49557256643, 33681.326373472395, 4100.7334523256195, 4355.716878402894, 4363.410939523155, 4382.6055654991205, 4511.842085526991, 338545.0, 338582.0, 338794.0, 339292.0, 340901.0, 60188.69905650444, 60732.392676073556, 60991.695041525396, 61248.69375653182, 61345.0, 64339.0, 64450.35549644537, 64598.67700661561, 64739.67630161913, 64751.35248647547, 16206.189690515426, 16454.095024773753, 16457.91771041137, 16460.506184814476, 16470.6705865882, 12280.201786883825, 12360.196587221802, 12363.814542781865, 12364.690882727824, 12373.0, 16693.248803803857, 18112.909435452737, 18163.36428225006, 18166.5458363542, 18255.90872045631, 6904.896426553606, 6925.134358205224, 7071.116110486189, 7129.215786263507, 7130.286971302932, 823.3865770001267, 867.4578388507183, 998.3460833154296, 1004.7588578741049, 1045.5033858916954, 33022.5046624296, 33451.49822752661, 33526.66473335236, 33555.0, 34094.48858267128, 1055.4089709762557, 1131.9151063670092, 1141.2011591885714, 1147.718808891827, 1154.809456439695, 16288.42990495327, 16894.408695695838, 16947.237374318185, 16959.576010599587, 17088.23102960345, 586636.0, 587396.0, 589360.0, 592002.0, 593601.0, 59064.70467647634, 59858.0, 59997.0, 60341.39658603358, 60457.0, 1192.8151136573845, 1358.660334916271, 1370.8971827112807, 1403.8806701430492, 1420.6732451535997, 31463.269520175694, 34080.829595851865, 34146.31707365889, 34308.48537271993, 34674.65325346714, 50794.74602626963, 50864.745676271385, 50885.236721449946, 51139.74430127825, 51437.22844157415, 322598.0, 323335.0, 323570.0, 323781.0, 325712.0, 24620.6306905393, 27719.445611087263, 28427.147185584465, 28556.85721571462, 29685.5547166797, 48435.51564484451, 48552.27171592358, 49464.0, 50559.74720126376, 50712.49287507078, 40774.59225407708, 42084.789576051924, 42350.788246058575, 42422.0, 43041.78479107584, 41002.58997410107, 41282.587174127875, 41667.7916610415, 41969.580304197785, 42264.366034508894, 41108.177836443705, 41995.7900210497, 42387.5761242396, 42417.78791106148, 42488.0, 34803.0, 36914.63085369219, 37749.245015100096, 38025.619743802206, 38036.42945355877, 28099.157025289274, 28223.858880705466, 28373.858130709214, 28736.281592960342, 28866.711332886403], "value": 20534.124512732433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.2835617324818, 386.46860566720767, 389.9727019108662, 400.16166131953554, 415.97296175748573, 18927.0, 19500.0, 19600.31398901039, 19612.509687257825, 20815.583688326224, 18891.0, 19394.806051939475, 19452.22191112357, 19592.510187245327, 19953.800461995375, 5559.499645031946, 5630.521405680502, 5689.9146512802345, 5721.427857214266, 5732.885342293152, 5438.83683489494, 5542.612017158801, 5548.611597188198, 5580.0, 5595.104783234683, 5316.12283973144, 5555.694436805974, 5608.887822243552, 5615.7472913718775, 5660.433956604348, 5505.476979686923, 5555.111182210867, 5594.0769772987815, 5613.466720661551, 5623.297087863976, 4921.876953076166, 5181.896362072775, 5217.139172036609, 5250.789968401259, 5251.4485978972425, 13710.862891371058, 13855.722885542233, 13862.58412247624, 19330.323438679578, 22069.33791986243, 2223.788740069691, 2282.6918366020705, 2302.1597117052324, 2414.613661814119, 2416.649585810065, 9902.108810207115, 10256.384616922935, 10290.176785857113, 10425.270231083827, 12765.170263932814, 1823.5441139715072, 1902.5624106455593, 1945.843514686079, 1974.5359840437486, 1987.175322241268, 60508.394916051155, 75160.62419687922, 76566.23433765702, 76777.0, 85160.57419712924, 10631.574737010433, 10681.786364272672, 11000.834987475195, 11003.22977391575, 11631.95312421886, 14864.256787160599, 14985.475508357154, 14985.850141498664, 15046.247687615794, 15064.849351506564, 8003.559804210708, 8035.879461808077, 8064.153263907323, 8186.222308880647, 8215.548144852091, 7683.923160768432, 7734.110577283572, 7746.845063098706, 7835.333996610352, 7868.842623147505, 4612.561806628365, 4722.362481065081, 4735.076660051257, 4770.666053376231, 4800.183968725255, 1841.2232195930992, 1940.4372731907872, 1972.8717633353785, 1980.8514361422663, 1985.9404217873487, 877.4165180155253, 932.883389576303, 958.2669258017622, 1031.9886511219047, 1039.2673165418362, 19320.613587728447, 19425.22299108048, 19505.0, 19557.31549395793, 19814.70277945832, 998.7952469743685, 1013.7465633591602, 1018.1854516386861, 1018.7962407518378, 1039.656913218636, 10609.734756631146, 10750.677479675465, 11047.779044419067, 11302.830457543143, 11430.371329576787, 334633.0, 339433.0, 496040.0, 498604.0, 503833.0, 62812.0, 67961.66019169873, 95859.04140958501, 97340.51329743447, 99416.0, 1038.5170895533613, 1057.513543769859, 1063.8989296016866, 1064.7976884392097, 1081.778235461744, 17497.650046999242, 18363.449096527125, 18383.54041148982, 18396.0, 18453.63092738111, 41081.38377924274, 41221.0, 41223.1755364885, 41299.38050929178, 41698.374524382765, 58324.416755831895, 58480.4151958492, 59974.0, 60132.699336503036, 60654.0, 7374.262573742582, 7710.267524585155, 7748.535087894745, 8179.713710020121, 8196.467229630054, 9344.766380840261, 11733.706657333634, 13373.933130334286, 13415.731685366432, 14037.859621404064, 6351.809445716636, 9215.354925155174, 11849.565169611367, 11988.520459181535, 12028.15802893789, 11560.595379161688, 11841.526338946345, 11992.160548761503, 12358.258504489759, 12559.811602825783, 9244.0, 11699.473523691284, 11840.111991600492, 11897.345645989208, 12175.0, 8704.825903482022, 8817.867731984154, 8865.512396818236, 8905.0, 9182.862257066283, 11264.0, 11845.11161662896, 11898.881011189776, 11976.76046479083, 12085.879141208827], "value": 9007.960899968832, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.4522568359805, 1513.21312917283, 1533.9693206135878, 1716.8626509879211, 1858.2566973210724, 8297.211764882342, 8715.128487151282, 8715.172058654418, 8973.730788076351, 8986.056464071276, 8678.956605216965, 8894.644214231423, 8898.288136949044, 8902.599383027764, 8911.153440423166, 1982.623301572704, 2269.251147121446, 2330.9883450582765, 2357.0571771291447, 2361.551305252005, 2317.4553979814814, 2335.5212181502834, 2343.320437073247, 2344.0272287000957, 2344.050659482912, 2316.6061769499224, 2377.3818807110188, 2378.369732021016, 2380.321608341623, 2384.463495713468, 2006.4482267376516, 2292.0946226240626, 2353.082297903819, 2355.9057637694473, 2395.532871090121, 2298.184144628666, 2301.4131396493954, 2305.988470057656, 2306.757790432014, 2348.4011577047913, 8817.470951742851, 8931.062238464932, 8935.463872167691, 8938.821223575493, 8942.821143577157, 5274.0, 5388.649737767033, 5401.567874570025, 5407.486288802557, 5411.972940135313, 3210.2776875203126, 3281.2289112058647, 3333.683300086488, 3334.583177102862, 3351.4805205193234, 1030.9793804123876, 1050.8056009638242, 1058.973525661857, 1099.4887377369562, 1105.0496572947259, 12360.258384496869, 12445.875541244563, 12463.0, 12478.064145189057, 12485.188462749982, 4597.218472859622, 4724.71651700899, 4747.098051370229, 4845.3216549683075, 4849.393825771778, 10518.0, 10520.579176832842, 10524.473776311306, 10534.683959481228, 10539.473026348653, 4856.660033797671, 5362.65142765719, 5362.946370536322, 5363.329583802025, 5364.275822763877, 4771.188897887368, 4886.755662216875, 4890.559849613552, 4970.751462426864, 4970.801167953241, 4024.939625905614, 4049.271131196413, 4118.794494305225, 4263.616274535245, 4271.722338048017, 1218.3055658274875, 1251.28676654308, 1252.9812052819216, 1275.8724127587168, 1298.1756584568866, 934.2059249637754, 1015.4161357219481, 1016.364772017489, 1024.3341827811983, 1038.2680210451613, 6091.5735898487565, 6309.842253943596, 6322.9051564226575, 6325.9051114233325, 6339.746410143634, 423.9448871646666, 426.23916309388215, 428.20567846644025, 428.3296640757205, 1065.6536625596711, 3981.243563722883, 4227.577242275809, 4227.725197862129, 4303.268444364466, 4316.892077698083, 11008.779824403468, 11309.434528273554, 11319.830202546967, 11333.829992550118, 11339.943300283447, 11043.503042363112, 11089.27919685218, 11104.666859994213, 11129.666110016713, 11151.38667373286, 7939.245771651684, 8171.264586187272, 8294.460860044077, 8296.83406331882, 8310.21052999964, 6244.5325348543965, 6369.172007638977, 6377.0753240778895, 6403.359664033559, 6461.256955450183, 9937.453440060866, 10117.544710488193, 10295.3822770634, 10312.432816195182, 10322.225833062701, 10387.740306492398, 10478.109360704426, 10514.0, 10519.0, 10522.263441559018, 7270.454715896223, 7436.144843342869, 7519.097708274823, 7998.160193179865, 8146.389020823581, 8660.870086948575, 8843.204111629984, 8851.026387097543, 8857.335699822668, 8872.955635221782, 7643.4267429941865, 7930.881036784337, 7985.760427187193, 7988.760337189894, 8137.471064380797, 7756.108047574376, 7806.882896756667, 7866.056073271244, 7907.9604601976625, 7930.088039875488, 7065.222825489295, 7073.929260707327, 7148.535345202546, 7155.248698886542, 7160.212376638669, 5518.420565840529, 5552.222688823487, 5564.749586268546, 5619.915701264566, 5622.922842001251, 5296.496832800878, 5403.945960540502, 5448.291722076263, 5557.888842223052, 5562.054450743302], "value": 4652.616346840544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.879965613067, 325.6564324637508, 334.5466892360851, 335.37954783650235, 336.70706485357744, 5323.787048518059, 5379.6503227290195, 5385.434529374418, 5426.294581704378, 5506.531944784698, 5358.258565966057, 5371.382291036532, 5391.245225668409, 5410.621256512046, 5427.317531565218, 4222.408862759216, 4224.366345048252, 4233.645233525273, 4236.585146466516, 4245.851395201169, 4104.42538044674, 4230.238557059728, 4236.771336312481, 4241.703080784347, 4243.278642630745, 4169.6455801256925, 4185.748855068706, 4196.832126714943, 4200.97899510502, 4230.725002874803, 4213.389058586518, 4251.022264879064, 4252.893677658068, 4264.616184543391, 4266.552012038738, 3699.593044765101, 3778.1499162688174, 3799.525059367579, 3802.3535998880257, 3803.220339830328, 5194.961007798455, 5202.358349155568, 5202.777347323376, 5229.294045303874, 5253.395859476171, 4797.2564252540915, 4827.227643577011, 4843.200871856139, 4845.3216549683075, 4941.703497790144, 5453.618246722731, 5632.436756324335, 5643.209950606918, 5643.322801263875, 5701.828945131652, 4126.587341265879, 4132.834686612532, 4135.462389889325, 4138.6482149017365, 4143.316352801784, 5634.943650563483, 5676.631018983753, 5961.0, 5972.850678733023, 6008.128821320927, 4147.212029714345, 4156.376543518496, 4156.625903668624, 4159.542450330461, 4204.348326009474, 4237.6821738369745, 4251.128518653669, 4251.787410629456, 4254.255505286563, 4262.318029115327, 4637.814487420465, 4645.674802763841, 4801.51984801517, 4823.155947709137, 4875.853724388274, 5621.9360448555635, 5639.915401268984, 5671.476193094116, 5672.546196304285, 5672.914906276409, 1451.165579791624, 1462.612407711957, 1469.9485518006818, 1472.7275454040823, 1474.402866838932, 938.3572253006712, 947.2989987409268, 951.362587066667, 954.513198268874, 964.8311545479653, 4816.181249187646, 4836.806527738921, 4855.927161092586, 4876.244551961291, 4916.901661966741, 4976.527229913152, 5097.852983078852, 5148.021875843578, 5189.028169295643, 5209.613751061765, 4901.730404827697, 4946.653734238641, 4955.876103097451, 5091.66904151229, 5450.22867568042, 3059.990203232928, 3065.601471808651, 3068.969310306913, 3085.645150807641, 3100.534919762054, 5954.583179177416, 5959.553033522417, 5960.463558279689, 6007.909881351783, 6021.217241758543, 5597.720113994284, 5844.707764611752, 5863.413658634103, 5864.182103547829, 5890.4993075589055, 5959.612625179349, 5978.521718262528, 6005.189299444606, 6012.879742405127, 6096.207493025967, 5743.396943321059, 5874.383189765013, 5880.529557635465, 5929.140274660236, 5961.91057134152, 5548.445155484419, 5757.424257574209, 5808.128780682931, 5814.709264536841, 5815.86590614826, 5745.8563535911935, 5859.794907178229, 5893.499052580407, 5897.705114744332, 5991.0, 3973.2252210818615, 4005.35914253718, 4016.096378314856, 4021.336479480853, 4040.777757223381, 5681.2330335404195, 5790.305163380422, 5798.507126894261, 5834.599696072827, 5902.911456328073, 5604.635698679573, 5606.822567260758, 5614.747336369792, 5633.661980281032, 5651.378348381757, 5552.250446189712, 5572.192032155396, 5618.775248990158, 5624.521915637217, 5661.037623604079, 5370.543503802064, 5568.415316391721, 5589.133684278943, 5599.552035837041, 5610.0, 5676.68778217202, 5677.51741102011, 5733.369329373682, 5753.252077229933, 5768.653880767168, 5321.521063104185, 5555.944230673194, 5555.944440555542, 5566.385748133158, 5586.581006424453], "value": 4281.625453270676, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3366503811608, 771.8449968789322, 829.4194064155089, 843.7974886027355, 847.3009766942271, 12699.238045717251, 12939.676508087303, 12950.935245323784, 12968.0, 12970.0, 12693.174943628681, 13229.933850330759, 13233.073684842066, 13657.180569165832, 13998.720025599481, 673.4376795375867, 819.5943008210944, 820.335528222142, 825.5459497276504, 825.6738588257634, 683.4122654517112, 688.8828899087167, 689.2556039477353, 801.3789313282224, 824.1593574553951, 856.644492535597, 857.5283594023293, 857.5626430520448, 858.0389963241179, 858.2147335188296, 850.0139837788136, 851.9488830670149, 852.3096292003497, 853.0488505316589, 854.9487030778142, 520.3261776000052, 615.2063837649426, 620.6338260426324, 626.1765778001912, 626.9717862696144, 14675.412983480755, 14786.112833230041, 14826.0, 14914.850851491454, 14945.850541494554, 12928.54750083752, 13323.86676133236, 13451.192928424229, 13503.189808611514, 13509.256990865499, 12050.683229813665, 12127.151099423045, 12336.81494777579, 12350.567730129493, 13087.738245235138, 4351.108022855307, 4388.846390376353, 4402.845900393503, 4529.614982726473, 4607.861764147081, 58269.70865145647, 59130.40869591292, 59424.405755942316, 59703.40296597022, 60198.0, 10665.573377064831, 10781.568737250422, 10910.563577456971, 11039.227254092297, 11141.498632561554, 18588.0, 19561.217551298072, 19609.117589708498, 19634.803651963583, 19658.213671453268, 8318.916810831814, 8374.916250837536, 8433.072362040171, 8679.6528138875, 8727.214550690469, 4550.726956382561, 4577.267637178102, 4681.227597446383, 4729.763511824395, 4774.140654682191, 3392.9830350848088, 3431.1422144463886, 3442.0534353053113, 3442.896713098611, 3452.223249768782, 628.9622622642656, 639.2903876696863, 654.7904670505487, 657.1949362031569, 668.0313545359248, 571.4885177765959, 635.8632893927828, 706.1349846438072, 717.178830239373, 722.7181399254295, 9612.782424166771, 10233.181345492492, 10303.536340864679, 10336.948315258376, 10398.68803935883, 627.2942939193407, 674.5547938360659, 692.1590267824618, 716.8279612892868, 748.3900620993873, 4570.88572785683, 4694.366260554782, 4727.220008698595, 4738.491703925955, 4800.399950006249, 69307.3069269311, 69985.65007175034, 71437.64281178561, 72052.0, 72243.0, 53481.465185348425, 64661.06016819503, 65593.34406655873, 66098.33901661017, 68320.65839670869, 56177.43822561804, 56401.153982690295, 57219.711211552734, 58358.0, 58442.70778646079, 9523.333366664267, 9540.093691099335, 9544.284178686488, 9683.612655493702, 9781.902180978099, 36441.81779091088, 37852.62147378491, 38404.0, 38430.231395372495, 38888.222235555695, 51035.74482127566, 51338.122878326496, 51528.48471515387, 52055.47944520506, 52391.73804130955, 12254.693632659255, 12440.875591243972, 12656.620301390973, 13001.284929328978, 13174.670633234246, 13632.0, 13919.791203132163, 14130.15219086858, 14201.076929999517, 14320.641983950485, 12867.227966321676, 13217.669558261121, 13347.532836350681, 13444.993456637269, 13795.862041379458, 13156.276404797827, 13210.339483025618, 13328.200307981551, 13445.865541344461, 13505.662358441117, 13286.468541258242, 13311.933440332736, 13370.665733356744, 13405.530806421728, 13561.321933903462, 10772.515236814206, 11137.276077054965, 11163.162762792661, 11199.776004480027, 11323.830142547704, 10300.278980471296, 10567.260291779501, 10647.666081575433, 10654.57381704723, 10897.182711296842], "value": 6979.871741797489, "unit": "score"}], "name": "dromaeo_css", "value": 7195.923206084476, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 112.0, 109.0, 111.0, 109.0, 108.0, 109.0, 108.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 125.0, 172.0, 127.0, 136.0, 157.0, 125.0, 156.0, 131.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 109.0, 74.0, 76.0, 74.0, 75.0, 104.0, 73.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 128.0, 85.0, 83.0, 84.0, 114.0, 85.0, 84.0, 121.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.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": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 178.0, 145.0, 146.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 54.0, 55.0, 53.0, 73.0, 52.0, 52.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 62.0, 64.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 79.0, 80.0, 79.0, 82.0, 80.0, 80.0, 80.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 134.0, 118.0, 120.0, 125.0, 125.0, 120.0, 162.0, 128.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 158.0, 165.0, 162.0, 159.0, 159.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 65.0, 63.0, 62.0, 61.0, 62.0, 62.0, 63.0, 65.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1494.7, "alertThreshold": 2.0}]} 11:43:12 INFO - Return code: 0 11:43:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:12 ERROR - # TBPL SUCCESS # 11:43:12 INFO - Running post-action listener: _resource_record_post_action 11:43:12 INFO - ##### 11:43:12 INFO - ##### Finished run-tests step (success) 11:43:12 INFO - ##### 11:43:12 INFO - Running post-run listener: _resource_record_post_run 11:43:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539795456; Read time: 16; Write time: 362112 11:43:12 INFO - TinderboxPrint: CPU usage
13.2% 11:43:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:43:12 INFO - TinderboxPrint: I/O write bytes / time
539,795,456 / 362,112 11:43:12 INFO - TinderboxPrint: CPU idle
8,261.5 (86.8%) 11:43:12 INFO - TinderboxPrint: CPU user
1,209.4 (12.7%) 11:43:12 INFO - TinderboxPrint: Swap in / out
0 / 0 11:43:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247250944; Read time: 0; Write time: 205832 11:43:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292544512; Read time: 16; Write time: 156280 11:43:13 INFO - Running post-run listener: _upload_blobber_files 11:43:13 INFO - Blob upload gear active. 11:43:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:13 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 11:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:43:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:14 INFO - (blobuploader) - INFO - Done attempting. 11:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:14 INFO - (blobuploader) - INFO - Done attempting. 11:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:20 INFO - (blobuploader) - INFO - Done attempting. 11:43:20 INFO - (blobuploader) - INFO - Iteration through files over. 11:43:20 INFO - Return code: 0 11:43:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:43:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:43:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c24431b36a7341a381fc9a5df4f1ea126fc78f4f09fa35d580ec599e721a425a1438ea5879dd8bde629a98ac5a2138b5fa1a28cf1a1a0e66dd4b8721c451fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd780d34c5abb044f06f2c89ea1826efdd827b7f18e1a50d88bbb48c00016e223670090c244990df80e70c47bec6716209eae89d6790c04913a06282c71f3bf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b8ddd0c1425157362cbbe7e545fb68756da40f17192c6a741b914a99ed445b32f70960805bdffa936e6c83da3d594aef175ce7e6eaffb9f895133a02be6d07c"} 11:43:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:43:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:43:20 INFO - Contents: 11:43:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c24431b36a7341a381fc9a5df4f1ea126fc78f4f09fa35d580ec599e721a425a1438ea5879dd8bde629a98ac5a2138b5fa1a28cf1a1a0e66dd4b8721c451fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd780d34c5abb044f06f2c89ea1826efdd827b7f18e1a50d88bbb48c00016e223670090c244990df80e70c47bec6716209eae89d6790c04913a06282c71f3bf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b8ddd0c1425157362cbbe7e545fb68756da40f17192c6a741b914a99ed445b32f70960805bdffa936e6c83da3d594aef175ce7e6eaffb9f895133a02be6d07c"} 11:43:20 INFO - Running post-run listener: copy_logs_to_upload_dir 11:43:20 INFO - Copying logs to upload dir... 11:43:20 INFO - mkdir: /builds/slave/test/build/upload/logs 11:43:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.424746 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-25 11:43:20.676606) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 11:43:20.679899) ========= 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=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c24431b36a7341a381fc9a5df4f1ea126fc78f4f09fa35d580ec599e721a425a1438ea5879dd8bde629a98ac5a2138b5fa1a28cf1a1a0e66dd4b8721c451fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd780d34c5abb044f06f2c89ea1826efdd827b7f18e1a50d88bbb48c00016e223670090c244990df80e70c47bec6716209eae89d6790c04913a06282c71f3bf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b8ddd0c1425157362cbbe7e545fb68756da40f17192c6a741b914a99ed445b32f70960805bdffa936e6c83da3d594aef175ce7e6eaffb9f895133a02be6d07c"} build_url:https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/Evkeq05TTlyY3RZbGV7t-Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/31c24431b36a7341a381fc9a5df4f1ea126fc78f4f09fa35d580ec599e721a425a1438ea5879dd8bde629a98ac5a2138b5fa1a28cf1a1a0e66dd4b8721c451fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd780d34c5abb044f06f2c89ea1826efdd827b7f18e1a50d88bbb48c00016e223670090c244990df80e70c47bec6716209eae89d6790c04913a06282c71f3bf9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b8ddd0c1425157362cbbe7e545fb68756da40f17192c6a741b914a99ed445b32f70960805bdffa936e6c83da3d594aef175ce7e6eaffb9f895133a02be6d07c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 11:43:20.709262) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:43:20.710010) ========= 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=41bf3e9aed84707956354da8000001c5-1464198696.88708-1525280788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 11:43:20.794544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 11:43:20.795230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 11:43:20.795933) ========= ========= Total master_lag: 0.18 =========