builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1463559198.14 results: success (0) buildid: 20160517223201 builduid: e605c79088354fdaa55256757bf8ffc3 revision: cb356a5f82cdc4f1e44165c96906b04742ed6311 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.143099) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.143561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.144049) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.178482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.178773) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-18 01:13:18-- 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% 25.1M=0s 2016-05-18 01:13:18 (25.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.318840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.319168) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017623 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.383184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.383552) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cb356a5f82cdc4f1e44165c96906b04742ed6311 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev cb356a5f82cdc4f1e44165c96906b04742ed6311 --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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-18 01:13:18,770 truncating revision to first 12 chars 2016-05-18 01:13:18,770 Setting DEBUG logging. 2016-05-18 01:13:18,770 attempt 1/10 2016-05-18 01:13:18,771 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/cb356a5f82cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 01:13:19,088 unpacking tar archive at: mozilla-inbound-cb356a5f82cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.976832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.977573) ========= script_repo_revision: cb356a5f82cdc4f1e44165c96906b04742ed6311 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.978086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.978395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 01:13:18.988732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-18 01:13:18.989362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:13:19 INFO - MultiFileLogger online at 20160518 01:13:19 in /builds/slave/test 01:13:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:13:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:13:19 INFO - {'append_to_log': False, 01:13:19 INFO - 'base_work_dir': '/builds/slave/test', 01:13:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:13:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:13:19 INFO - 'branch': 'Mozilla-Inbound', 01:13:19 INFO - 'buildbot_json_path': 'buildprops.json', 01:13:19 INFO - 'config_files': ('talos/linux_config.py',), 01:13:19 INFO - 'default_actions': ('clobber', 01:13:19 INFO - 'read-buildbot-config', 01:13:19 INFO - 'download-and-extract', 01:13:19 INFO - 'populate-webroot', 01:13:19 INFO - 'create-virtualenv', 01:13:19 INFO - 'install', 01:13:19 INFO - 'run-tests'), 01:13:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:13:19 INFO - 'download_minidump_stackwalk': True, 01:13:19 INFO - 'download_symbols': 'ondemand', 01:13:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:13:19 INFO - 'tooltool.py': '/tools/tooltool.py', 01:13:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:13:19 INFO - '/tools/misc-python/virtualenv.py')}, 01:13:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:13:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:13:19 INFO - 'installer_path': 'installer.exe', 01:13:19 INFO - 'log_level': 'info', 01:13:19 INFO - 'log_name': 'talos', 01:13:19 INFO - 'log_to_console': True, 01:13:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:13:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:13:19 INFO - 'opt_config_files': (), 01:13:19 INFO - 'pip_index': False, 01:13:19 INFO - 'sps_profile': False, 01:13:19 INFO - 'sps_profile_interval': 0, 01:13:19 INFO - 'suite': 'dromaeojs', 01:13:19 INFO - 'system_bits': '32', 01:13:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:13:19 INFO - 'title': 'talos-linux64-ix-061', 01:13:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:13:19 INFO - 'use_talos_json': True, 01:13:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:13:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:13:19 INFO - 'work_dir': 'build'} 01:13:19 INFO - ##### 01:13:19 INFO - ##### Running clobber step. 01:13:19 INFO - ##### 01:13:19 INFO - Running pre-action listener: _resource_record_pre_action 01:13:19 INFO - Running main action method: clobber 01:13:19 INFO - rmtree: /builds/slave/test/build 01:13:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:13:19 INFO - Running post-action listener: _resource_record_post_action 01:13:19 INFO - ##### 01:13:19 INFO - ##### Finished clobber step (success) 01:13:19 INFO - ##### 01:13:19 INFO - ##### 01:13:19 INFO - ##### Running read-buildbot-config step. 01:13:19 INFO - ##### 01:13:19 INFO - Running pre-action listener: _resource_record_pre_action 01:13:19 INFO - Running main action method: read_buildbot_config 01:13:19 INFO - Using buildbot properties: 01:13:19 INFO - { 01:13:19 INFO - "project": "", 01:13:19 INFO - "product": "firefox", 01:13:19 INFO - "script_repo_revision": "production", 01:13:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:13:19 INFO - "repository": "", 01:13:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:13:19 INFO - "buildid": "20160517223201", 01:13:19 INFO - "pgo_build": "True", 01:13:19 INFO - "basedir": "/builds/slave/test", 01:13:19 INFO - "buildnumber": 927, 01:13:19 INFO - "slavename": "talos-linux64-ix-061", 01:13:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:13:19 INFO - "platform": "ubuntu64_hw", 01:13:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:13:19 INFO - "branch": "mozilla-inbound", 01:13:19 INFO - "repo_path": "integration/mozilla-inbound", 01:13:19 INFO - "revision": "cb356a5f82cdc4f1e44165c96906b04742ed6311", 01:13:19 INFO - "stage_platform": "linux64-pgo", 01:13:19 INFO - "builduid": "e605c79088354fdaa55256757bf8ffc3", 01:13:19 INFO - "slavebuilddir": "test" 01:13:19 INFO - } 01:13:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:13:19 INFO - Running post-action listener: _resource_record_post_action 01:13:19 INFO - ##### 01:13:19 INFO - ##### Finished read-buildbot-config step (success) 01:13:19 INFO - ##### 01:13:19 INFO - ##### 01:13:19 INFO - ##### Running download-and-extract step. 01:13:19 INFO - ##### 01:13:19 INFO - Running pre-action listener: _resource_record_pre_action 01:13:19 INFO - Running main action method: download_and_extract 01:13:19 INFO - mkdir: /builds/slave/test/build/tests 01:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:19 INFO - https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:21 INFO - Downloaded 1361 bytes. 01:13:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:13:21 INFO - Using the following test package requirements: 01:13:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:13:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:13:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'jsshell-linux-x86_64.zip'], 01:13:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:13:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:13:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:13:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:13:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:13:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:13:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:13:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:21 INFO - https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:22 INFO - Downloaded 24347545 bytes. 01:13:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:13:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:13:23 INFO - Return code: 0 01:13:23 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 01:13:23 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')]} 01:13:23 INFO - https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:30 INFO - Downloaded 24347545 bytes. 01:13:30 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'] 01:13:30 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 01:13:31 INFO - Return code: 0 01:13:31 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')]} 01:13:31 INFO - https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:32 INFO - Downloaded 10840194 bytes. 01:13:32 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'] 01:13:32 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 01:13:33 INFO - Return code: 0 01:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:33 INFO - https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I-SEj3maTjqcBtwSei5wSw/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 01:13:38 INFO - Downloaded 58335699 bytes. 01:13:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:13:38 INFO - mkdir: /builds/slave/test/properties 01:13:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:13:38 INFO - Writing to file /builds/slave/test/properties/build_url 01:13:38 INFO - Contents: 01:13:38 INFO - build_url:https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:13:39 INFO - Running post-action listener: _resource_record_post_action 01:13:39 INFO - Running post-action listener: set_extra_try_arguments 01:13:39 INFO - ##### 01:13:39 INFO - ##### Finished download-and-extract step (success) 01:13:39 INFO - ##### 01:13:39 INFO - ##### 01:13:39 INFO - ##### Running populate-webroot step. 01:13:39 INFO - ##### 01:13:39 INFO - Running pre-action listener: _resource_record_pre_action 01:13:39 INFO - Running main action method: populate_webroot 01:13:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:13:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:13:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:13:39 INFO - '--tppagecycles', 01:13:39 INFO - '7'], 01:13:39 INFO - 'tests': ['tsvgm']}}, 01:13:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:13:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:13:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:13:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:13:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:13:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['damp', 'tps']}, 01:13:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'tests': ['damp', 'tps']}, 01:13:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['dromaeo_dom']}, 01:13:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:13:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'other-e10s': {'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['a11yr', 01:13:39 INFO - 'ts_paint', 01:13:39 INFO - 'tpaint', 01:13:39 INFO - 'sessionrestore', 01:13:39 INFO - 'sessionrestore_no_auto_restore', 01:13:39 INFO - 'tabpaint']}, 01:13:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['tsvgx', 01:13:39 INFO - 'tsvgr_opacity', 01:13:39 INFO - 'tart', 01:13:39 INFO - 'tscrollx', 01:13:39 INFO - 'cart']}, 01:13:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:13:39 INFO - 'tsvgr_opacity', 01:13:39 INFO - 'tart', 01:13:39 INFO - 'tscrollx', 01:13:39 INFO - 'cart']}, 01:13:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'talos_options': ['--disable-e10s'], 01:13:39 INFO - 'tests': ['tp5o']}, 01:13:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'tests': ['tp5o']}, 01:13:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'talos_options': ['--disable-e10s', 01:13:39 INFO - '--xperf_path', 01:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:39 INFO - 'tests': ['tp5n']}, 01:13:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:13:39 INFO - 'talos_options': ['--xperf_path', 01:13:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:13:39 INFO - 'tests': ['tp5n']}}, 01:13:39 INFO - 'talos.zip': {'path': '', 01:13:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:13:39 INFO - Running post-action listener: _resource_record_post_action 01:13:39 INFO - ##### 01:13:39 INFO - ##### Finished populate-webroot step (success) 01:13:39 INFO - ##### 01:13:39 INFO - ##### 01:13:39 INFO - ##### Running create-virtualenv step. 01:13:39 INFO - ##### 01:13:39 INFO - Running pre-action listener: _resource_record_pre_action 01:13:39 INFO - Running main action method: create_virtualenv 01:13:39 INFO - Creating virtualenv /builds/slave/test/build/venv 01:13:39 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 01:13:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:13:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:13:39 INFO - Using real prefix '/usr' 01:13:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:13:39 INFO - Installing distribute.............................................................................................................................................................................................done. 01:13:41 INFO - Installing pip.................done. 01:13:41 INFO - Return code: 0 01:13:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:13:41 INFO - Using env: {'DISPLAY': ':0', 01:13:41 INFO - 'HOME': '/home/cltbld', 01:13:41 INFO - 'LANG': 'en_US.UTF-8', 01:13:41 INFO - 'LANGUAGE': 'en_US:en', 01:13:41 INFO - 'LOGNAME': 'cltbld', 01:13:41 INFO - 'MAIL': '/var/mail/cltbld', 01:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:41 INFO - 'MOZ_NO_REMOTE': '1', 01:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:41 INFO - 'NO_EM_RESTART': '1', 01:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:41 INFO - 'PWD': '/builds/slave/test', 01:13:41 INFO - 'SHELL': '/bin/bash', 01:13:41 INFO - 'SHLVL': '1', 01:13:41 INFO - 'TERM': 'linux', 01:13:41 INFO - 'TMOUT': '86400', 01:13:41 INFO - 'USER': 'cltbld', 01:13:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:41 INFO - '_': '/tools/buildbot/bin/python'} 01:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:41 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 01:13:41 INFO - Cleaning up... 01:13:41 INFO - Return code: 0 01:13:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:13:41 INFO - Using env: {'DISPLAY': ':0', 01:13:41 INFO - 'HOME': '/home/cltbld', 01:13:41 INFO - 'LANG': 'en_US.UTF-8', 01:13:41 INFO - 'LANGUAGE': 'en_US:en', 01:13:41 INFO - 'LOGNAME': 'cltbld', 01:13:41 INFO - 'MAIL': '/var/mail/cltbld', 01:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:41 INFO - 'MOZ_NO_REMOTE': '1', 01:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:41 INFO - 'NO_EM_RESTART': '1', 01:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:41 INFO - 'PWD': '/builds/slave/test', 01:13:41 INFO - 'SHELL': '/bin/bash', 01:13:41 INFO - 'SHLVL': '1', 01:13:41 INFO - 'TERM': 'linux', 01:13:41 INFO - 'TMOUT': '86400', 01:13:41 INFO - 'USER': 'cltbld', 01:13:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:41 INFO - '_': '/tools/buildbot/bin/python'} 01:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:42 INFO - Downloading/unpacking psutil>=3.1.1 01:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:44 INFO - Installing collected packages: psutil 01:13:44 INFO - Running setup.py install for psutil 01:13:44 INFO - building 'psutil._psutil_linux' extension 01:13:44 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 01:13:44 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 01:13:44 INFO - building 'psutil._psutil_posix' extension 01:13:44 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 01:13:44 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 01:13:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:44 INFO - Successfully installed psutil 01:13:44 INFO - Cleaning up... 01:13:44 INFO - Return code: 0 01:13:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:13:44 INFO - Using env: {'DISPLAY': ':0', 01:13:44 INFO - 'HOME': '/home/cltbld', 01:13:44 INFO - 'LANG': 'en_US.UTF-8', 01:13:44 INFO - 'LANGUAGE': 'en_US:en', 01:13:44 INFO - 'LOGNAME': 'cltbld', 01:13:44 INFO - 'MAIL': '/var/mail/cltbld', 01:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:44 INFO - 'MOZ_NO_REMOTE': '1', 01:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:44 INFO - 'NO_EM_RESTART': '1', 01:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:44 INFO - 'PWD': '/builds/slave/test', 01:13:44 INFO - 'SHELL': '/bin/bash', 01:13:44 INFO - 'SHLVL': '1', 01:13:44 INFO - 'TERM': 'linux', 01:13:44 INFO - 'TMOUT': '86400', 01:13:44 INFO - 'USER': 'cltbld', 01:13:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:44 INFO - '_': '/tools/buildbot/bin/python'} 01:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:13:46 INFO - Installing collected packages: mozsystemmonitor 01:13:46 INFO - Running setup.py install for mozsystemmonitor 01:13:46 INFO - Successfully installed mozsystemmonitor 01:13:46 INFO - Cleaning up... 01:13:47 INFO - Return code: 0 01:13:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:13:47 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')]} 01:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:47 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')]} 01:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:47 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 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:47 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 01:13:47 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 01:13:47 INFO - Using env: {'DISPLAY': ':0', 01:13:47 INFO - 'HOME': '/home/cltbld', 01:13:47 INFO - 'LANG': 'en_US.UTF-8', 01:13:47 INFO - 'LANGUAGE': 'en_US:en', 01:13:47 INFO - 'LOGNAME': 'cltbld', 01:13:47 INFO - 'MAIL': '/var/mail/cltbld', 01:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:47 INFO - 'MOZ_NO_REMOTE': '1', 01:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:47 INFO - 'NO_EM_RESTART': '1', 01:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:47 INFO - 'PWD': '/builds/slave/test', 01:13:47 INFO - 'SHELL': '/bin/bash', 01:13:47 INFO - 'SHLVL': '1', 01:13:47 INFO - 'TERM': 'linux', 01:13:47 INFO - 'TMOUT': '86400', 01:13:47 INFO - 'USER': 'cltbld', 01:13:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:47 INFO - '_': '/tools/buildbot/bin/python'} 01:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:47 INFO - Downloading/unpacking blobuploader==1.2.4 01:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:49 INFO - Downloading blobuploader-1.2.4.tar.gz 01:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:13:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:13:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:49 INFO - Downloading docopt-0.6.1.tar.gz 01:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:13:49 INFO - Installing collected packages: blobuploader, requests, docopt 01:13:49 INFO - Running setup.py install for blobuploader 01:13:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:13:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:13:49 INFO - Running setup.py install for requests 01:13:50 INFO - Running setup.py install for docopt 01:13:50 INFO - Successfully installed blobuploader requests docopt 01:13:50 INFO - Cleaning up... 01:13:50 INFO - Return code: 0 01:13:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13:50 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')]} 01:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:50 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')]} 01:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:50 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 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:50 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 01:13:50 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 01:13:50 INFO - Using env: {'DISPLAY': ':0', 01:13:50 INFO - 'HOME': '/home/cltbld', 01:13:50 INFO - 'LANG': 'en_US.UTF-8', 01:13:50 INFO - 'LANGUAGE': 'en_US:en', 01:13:50 INFO - 'LOGNAME': 'cltbld', 01:13:50 INFO - 'MAIL': '/var/mail/cltbld', 01:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:50 INFO - 'MOZ_NO_REMOTE': '1', 01:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:50 INFO - 'NO_EM_RESTART': '1', 01:13:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:50 INFO - 'PWD': '/builds/slave/test', 01:13:50 INFO - 'SHELL': '/bin/bash', 01:13:50 INFO - 'SHLVL': '1', 01:13:50 INFO - 'TERM': 'linux', 01:13:50 INFO - 'TMOUT': '86400', 01:13:50 INFO - 'USER': 'cltbld', 01:13:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:50 INFO - '_': '/tools/buildbot/bin/python'} 01:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:13:50 INFO - Running setup.py (path:/tmp/pip-JeHh0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:13:50 INFO - Running setup.py (path:/tmp/pip-Jo9L0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:13:50 INFO - Running setup.py (path:/tmp/pip-EflDC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:13:50 INFO - Running setup.py (path:/tmp/pip-opKRU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:13:50 INFO - Running setup.py (path:/tmp/pip-Gz531D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:13:51 INFO - Running setup.py (path:/tmp/pip-ZMuXaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:13:51 INFO - Running setup.py (path:/tmp/pip-EIqWV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:13:51 INFO - Running setup.py (path:/tmp/pip-dOsRMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:13:51 INFO - Running setup.py (path:/tmp/pip-qOV2n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:13:51 INFO - Running setup.py (path:/tmp/pip-x5u1Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:13:51 INFO - Running setup.py (path:/tmp/pip-N2hga1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:13:51 INFO - Running setup.py (path:/tmp/pip-8Hi40N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:13:51 INFO - Running setup.py (path:/tmp/pip-nIxL6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:13:51 INFO - Running setup.py (path:/tmp/pip-UTUWX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:51 INFO - Running setup.py (path:/tmp/pip-z_xQpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:13:51 INFO - Running setup.py (path:/tmp/pip-6Z2R9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:13:51 INFO - Running setup.py (path:/tmp/pip-YYHhGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:13:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:13:51 INFO - Running setup.py install for manifestparser 01:13:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for mozcrash 01:13:52 INFO - Running setup.py install for mozdebug 01:13:52 INFO - Running setup.py install for mozdevice 01:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for mozfile 01:13:52 INFO - Running setup.py install for mozhttpd 01:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for mozinfo 01:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for mozInstall 01:13:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for mozleak 01:13:52 INFO - Running setup.py install for mozlog 01:13:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:13:52 INFO - Running setup.py install for moznetwork 01:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Running setup.py install for mozprocess 01:13:53 INFO - Running setup.py install for mozprofile 01:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Running setup.py install for mozrunner 01:13:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Running setup.py install for mozscreenshot 01:13:53 INFO - Running setup.py install for moztest 01:13:53 INFO - Running setup.py install for mozversion 01:13:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:13:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:13:53 INFO - Cleaning up... 01:13:53 INFO - Return code: 0 01:13:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:53 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 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:53 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 01:13:53 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 01:13:53 INFO - Using env: {'DISPLAY': ':0', 01:13:53 INFO - 'HOME': '/home/cltbld', 01:13:53 INFO - 'LANG': 'en_US.UTF-8', 01:13:53 INFO - 'LANGUAGE': 'en_US:en', 01:13:53 INFO - 'LOGNAME': 'cltbld', 01:13:53 INFO - 'MAIL': '/var/mail/cltbld', 01:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:53 INFO - 'MOZ_NO_REMOTE': '1', 01:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:53 INFO - 'NO_EM_RESTART': '1', 01:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:53 INFO - 'PWD': '/builds/slave/test', 01:13:53 INFO - 'SHELL': '/bin/bash', 01:13:53 INFO - 'SHLVL': '1', 01:13:53 INFO - 'TERM': 'linux', 01:13:53 INFO - 'TMOUT': '86400', 01:13:53 INFO - 'USER': 'cltbld', 01:13:53 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:53 INFO - '_': '/tools/buildbot/bin/python'} 01:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:13:53 INFO - Running setup.py (path:/tmp/pip-pqEtnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:13:53 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)) 01:13:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:13:53 INFO - Running setup.py (path:/tmp/pip-7hHWa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:13:54 INFO - Running setup.py (path:/tmp/pip-PXqwpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:13:54 INFO - Running setup.py (path:/tmp/pip-lhdQ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:13:54 INFO - Running setup.py (path:/tmp/pip-BOIAZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:13:54 INFO - Running setup.py (path:/tmp/pip-B2WwHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:13:54 INFO - Running setup.py (path:/tmp/pip-cvkBzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:13:54 INFO - Running setup.py (path:/tmp/pip-RH51lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:13:54 INFO - Running setup.py (path:/tmp/pip-6Fa1BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:13:54 INFO - Running setup.py (path:/tmp/pip-0vAL2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:13:54 INFO - Running setup.py (path:/tmp/pip-W7ZCtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:13:54 INFO - Running setup.py (path:/tmp/pip-AY7vP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:13:54 INFO - Running setup.py (path:/tmp/pip-odXEvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:13:54 INFO - Running setup.py (path:/tmp/pip-k5EhwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:54 INFO - Running setup.py (path:/tmp/pip-WHT79a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:54 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)) 01:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:13:54 INFO - Running setup.py (path:/tmp/pip-9mTOlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:13:55 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)) 01:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:13:55 INFO - Running setup.py (path:/tmp/pip-wUrEsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:13:55 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)) 01:13:55 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)) 01:13:55 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)) 01:13:55 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)) 01:13:55 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)) 01:13:55 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)) 01:13:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:56 INFO - Downloading blessings-1.6.tar.gz 01:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:13:57 INFO - Installing collected packages: blessings 01:13:57 INFO - Running setup.py install for blessings 01:13:57 INFO - Successfully installed blessings 01:13:57 INFO - Cleaning up... 01:13:57 INFO - Return code: 0 01:13:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:13:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:13:57 INFO - Reading from file tmpfile_stdout 01:13:57 INFO - Current package versions: 01:13:57 INFO - argparse == 1.2.1 01:13:57 INFO - blessings == 1.6 01:13:57 INFO - blobuploader == 1.2.4 01:13:57 INFO - docopt == 0.6.1 01:13:57 INFO - manifestparser == 1.1 01:13:57 INFO - mozInstall == 1.12 01:13:57 INFO - mozcrash == 0.17 01:13:57 INFO - mozdebug == 0.1 01:13:57 INFO - mozdevice == 0.48 01:13:57 INFO - mozfile == 1.2 01:13:57 INFO - mozhttpd == 0.7 01:13:57 INFO - mozinfo == 0.9 01:13:57 INFO - mozleak == 0.1 01:13:57 INFO - mozlog == 3.2 01:13:57 INFO - moznetwork == 0.27 01:13:57 INFO - mozprocess == 0.22 01:13:57 INFO - mozprofile == 0.28 01:13:57 INFO - mozrunner == 6.11 01:13:57 INFO - mozscreenshot == 0.1 01:13:57 INFO - mozsystemmonitor == 0.3 01:13:57 INFO - moztest == 0.7 01:13:57 INFO - mozversion == 1.4 01:13:57 INFO - psutil == 3.1.1 01:13:57 INFO - requests == 1.2.3 01:13:57 INFO - wsgiref == 0.1.2 01:13:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:57 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 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13:57 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 01:13:57 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 01:13:57 INFO - Using env: {'DISPLAY': ':0', 01:13:57 INFO - 'HOME': '/home/cltbld', 01:13:57 INFO - 'LANG': 'en_US.UTF-8', 01:13:57 INFO - 'LANGUAGE': 'en_US:en', 01:13:57 INFO - 'LOGNAME': 'cltbld', 01:13:57 INFO - 'MAIL': '/var/mail/cltbld', 01:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:57 INFO - 'MOZ_NO_REMOTE': '1', 01:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:57 INFO - 'NO_EM_RESTART': '1', 01:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:57 INFO - 'PWD': '/builds/slave/test', 01:13:57 INFO - 'SHELL': '/bin/bash', 01:13:57 INFO - 'SHLVL': '1', 01:13:57 INFO - 'TERM': 'linux', 01:13:57 INFO - 'TMOUT': '86400', 01:13:57 INFO - 'USER': 'cltbld', 01:13:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:57 INFO - '_': '/tools/buildbot/bin/python'} 01:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 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)) 01:13:57 INFO - Cleaning up... 01:13:57 INFO - Return code: 0 01:13:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:13: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', 'jsonschema'] in /builds/slave/test/build 01:13: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 jsonschema 01:13:57 INFO - Using env: {'DISPLAY': ':0', 01:13:57 INFO - 'HOME': '/home/cltbld', 01:13:57 INFO - 'LANG': 'en_US.UTF-8', 01:13:57 INFO - 'LANGUAGE': 'en_US:en', 01:13:57 INFO - 'LOGNAME': 'cltbld', 01:13:57 INFO - 'MAIL': '/var/mail/cltbld', 01:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:57 INFO - 'MOZ_NO_REMOTE': '1', 01:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:57 INFO - 'NO_EM_RESTART': '1', 01:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:57 INFO - 'PWD': '/builds/slave/test', 01:13:57 INFO - 'SHELL': '/bin/bash', 01:13:57 INFO - 'SHLVL': '1', 01:13:57 INFO - 'TERM': 'linux', 01:13:57 INFO - 'TMOUT': '86400', 01:13:57 INFO - 'USER': 'cltbld', 01:13:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:57 INFO - '_': '/tools/buildbot/bin/python'} 01:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:57 INFO - Downloading/unpacking jsonschema 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:13:59 INFO - Downloading/unpacking functools32 (from jsonschema) 01:13:59 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 01:13:59 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 01:13:59 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 01:13:59 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 01:13:59 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 01:13:59 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 01:13:59 INFO - Downloading functools32-3.2.3-2.tar.gz 01:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:14:00 INFO - warning: no files found matching '*.txt' 01:14:00 INFO - no previously-included directories found matching 'build' 01:14:00 INFO - no previously-included directories found matching 'dist' 01:14:00 INFO - no previously-included directories found matching '.git*' 01:14:00 INFO - Installing collected packages: jsonschema, functools32 01:14:00 INFO - Running setup.py install for functools32 01:14:00 INFO - warning: no files found matching '*.txt' 01:14:00 INFO - no previously-included directories found matching 'build' 01:14:00 INFO - no previously-included directories found matching 'dist' 01:14:00 INFO - no previously-included directories found matching '.git*' 01:14:00 INFO - Successfully installed jsonschema functools32 01:14:00 INFO - Cleaning up... 01:14:00 INFO - Return code: 0 01:14:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:14: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')]} 01:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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')]} 01:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:14: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6431654f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, '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': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', '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 01:14: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', 'flake8'] in /builds/slave/test/build 01:14: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 flake8 01:14:00 INFO - Using env: {'DISPLAY': ':0', 01:14:00 INFO - 'HOME': '/home/cltbld', 01:14:00 INFO - 'LANG': 'en_US.UTF-8', 01:14:00 INFO - 'LANGUAGE': 'en_US:en', 01:14:00 INFO - 'LOGNAME': 'cltbld', 01:14:00 INFO - 'MAIL': '/var/mail/cltbld', 01:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:00 INFO - 'MOZ_NO_REMOTE': '1', 01:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:00 INFO - 'NO_EM_RESTART': '1', 01:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:00 INFO - 'PWD': '/builds/slave/test', 01:14:00 INFO - 'SHELL': '/bin/bash', 01:14:00 INFO - 'SHLVL': '1', 01:14:00 INFO - 'TERM': 'linux', 01:14:00 INFO - 'TMOUT': '86400', 01:14:00 INFO - 'USER': 'cltbld', 01:14:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:00 INFO - '_': '/tools/buildbot/bin/python'} 01:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:14:00 INFO - Downloading/unpacking flake8 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14: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 01:14:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:14:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:14:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 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 01:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:14:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:03 INFO - no previously-included directories found matching 'docs/_build' 01:14:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:14:03 INFO - Running setup.py install for pep8 01:14:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:14:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:14:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:14:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:14:03 INFO - no previously-included directories found matching 'docs/_build' 01:14:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:14:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:14:03 INFO - Cleaning up... 01:14:03 INFO - Return code: 0 01:14:03 INFO - Running post-action listener: _resource_record_post_action 01:14:03 INFO - Running post-action listener: _start_resource_monitoring 01:14:03 INFO - Starting resource monitoring. 01:14:03 INFO - ##### 01:14:03 INFO - ##### Finished create-virtualenv step (success) 01:14:03 INFO - ##### 01:14:03 INFO - ##### 01:14:03 INFO - ##### Running install step. 01:14:03 INFO - ##### 01:14:03 INFO - Running pre-action listener: _resource_record_pre_action 01:14:03 INFO - Running main action method: install 01:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:14:03 INFO - Reading from file tmpfile_stdout 01:14:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:14:03 INFO - Reading from file tmpfile_stdout 01:14:03 INFO - Output received: 01:14:03 INFO - Usage: mozinstall [options] installer 01:14:03 INFO - Options: 01:14:03 INFO - -h, --help show this help message and exit 01:14:03 INFO - -d DEST, --destination=DEST 01:14:03 INFO - Directory to install application into. [default: 01:14:03 INFO - "/builds/slave/test"] 01:14:03 INFO - --app=APP Application being installed. [default: firefox] 01:14:03 INFO - mkdir: /builds/slave/test/build/application 01:14:03 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'] 01:14:03 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 01:14:20 INFO - Reading from file tmpfile_stdout 01:14:20 INFO - Output received: 01:14:20 INFO - /builds/slave/test/build/application/firefox/firefox 01:14:20 INFO - Running post-action listener: _resource_record_post_action 01:14:20 INFO - ##### 01:14:20 INFO - ##### Finished install step (success) 01:14:20 INFO - ##### 01:14:20 INFO - ##### 01:14:20 INFO - ##### Running run-tests step. 01:14:20 INFO - ##### 01:14:20 INFO - Running pre-action listener: _resource_record_pre_action 01:14:20 INFO - Running main action method: run_tests 01:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:14:20 INFO - Python 2.7.3 01:14:20 INFO - Return code: 0 01:14:20 INFO - grabbing minidump binary from tooltool 01:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:14:20 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 0x18439c0>, '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 0x18448c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1844d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:14:20 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 01:14:20 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 01:14:20 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 01:14:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:20 INFO - Return code: 0 01:14:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:14:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:14:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:14:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:14:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:14:21 INFO - Return code: 0 01:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 01:14:21 INFO - Using env: {'DISPLAY': ':0', 01:14:21 INFO - 'HOME': '/home/cltbld', 01:14:21 INFO - 'LANG': 'en_US.UTF-8', 01:14:21 INFO - 'LANGUAGE': 'en_US:en', 01:14:21 INFO - 'LOGNAME': 'cltbld', 01:14:21 INFO - 'MAIL': '/var/mail/cltbld', 01:14:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:21 INFO - 'MOZ_NO_REMOTE': '1', 01:14:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:14:21 INFO - 'NO_EM_RESTART': '1', 01:14:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:21 INFO - 'PWD': '/builds/slave/test', 01:14:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:21 INFO - 'SHELL': '/bin/bash', 01:14:21 INFO - 'SHLVL': '1', 01:14:21 INFO - 'TERM': 'linux', 01:14:21 INFO - 'TMOUT': '86400', 01:14:21 INFO - 'USER': 'cltbld', 01:14:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377', 01:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:21 INFO - '_': '/tools/buildbot/bin/python'} 01:14:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 01:14:21 INFO - mozversion application_buildid: 20160517223201 01:14:21 INFO - mozversion application_changeset: cb356a5f82cdc4f1e44165c96906b04742ed6311 01:14:21 INFO - mozversion application_display_name: Nightly 01:14:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:14:21 INFO - mozversion application_name: Firefox 01:14:21 INFO - mozversion application_remotingname: firefox 01:14:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:14:21 INFO - mozversion application_vendor: Mozilla 01:14:21 INFO - mozversion application_version: 49.0a1 01:14:21 INFO - mozversion platform_buildid: 20160517223201 01:14:21 INFO - mozversion platform_changeset: cb356a5f82cdc4f1e44165c96906b04742ed6311 01:14:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:14:21 INFO - mozversion platform_version: 49.0a1 01:14:21 INFO - using testdate: 1463559261 01:14:21 INFO - actual date: 1463559261 01:14:21 INFO - starting webserver on 'localhost:33375' 01:14:21 INFO - SUITE-START | Running 2 tests 01:14:21 INFO - TEST-START | dromaeo_css 01:14:21 INFO - operating with platform_type : linux_ 01:14:21 INFO - Initialising browser for dromaeo_css test... 01:14:21 INFO - TEST-INFO | started process 6075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYESai/profile http://localhost:33375/getInfo.html) 01:14:25 INFO - PROCESS | 6075 | __metrics Screen width/height:1600/1200 01:14:25 INFO - PROCESS | 6075 | colorDepth:24 01:14:25 INFO - PROCESS | 6075 | Browser inner width/height: 1024/697 01:14:25 INFO - PROCESS | 6075 | __metrics 01:14:26 ERROR - PROCESS | 6075 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:14:27 INFO - TEST-INFO | 6075: exit 0 01:14:27 INFO - Browser initialized. 01:14:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:14:27 INFO - TEST-INFO | started process 6158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdYESai/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:39 INFO - PROCESS | 6158 | RSS: Main: 152817664 01:14:39 INFO - PROCESS | 6158 | 01:15:30 INFO - PROCESS | 6158 | 1463559330306 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] 01:17:38 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33375/tests/dromaeo/cssquery-ext.html) 01:17:39 INFO - PROCESS | 6158 | RSS: Main: 239300608 01:17:39 INFO - PROCESS | 6158 | 01:20:41 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-ext.html (next: http://localhost:33375/tests/dromaeo/cssquery-jquery.html) 01:20:42 INFO - PROCESS | 6158 | RSS: Main: 238686208 01:20:42 INFO - PROCESS | 6158 | 01:23:44 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33375/tests/dromaeo/cssquery-mootools.html) 01:23:44 INFO - PROCESS | 6158 | RSS: Main: 232775680 01:23:44 INFO - PROCESS | 6158 | 01:26:46 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33375/tests/dromaeo/cssquery-prototype.html) 01:26:47 INFO - PROCESS | 6158 | RSS: Main: 232890368 01:26:47 INFO - PROCESS | 6158 | 01:29:49 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33375/tests/dromaeo/cssquery-yui.html) 01:29:50 INFO - PROCESS | 6158 | RSS: Main: 203509760 01:29:50 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:33375/tests/dromaeo/cssquery-yui.html (next: http://localhost:33375/tests/dromaeo/cssquery-dojo.html) 01:32:53 INFO - PROCESS | 6158 | RSS: Main: 272519168 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | __start_tp_report 01:32:53 INFO - PROCESS | 6158 | _x_x_mozilla_page_load 01:32:53 INFO - PROCESS | 6158 | _x_x_mozilla_page_load_details 01:32:53 INFO - PROCESS | 6158 | |i|pagename|runs| 01:32:53 INFO - PROCESS | 6158 | |0;dojo.html;3131.953020704689;3138.4507711150527;3155.5266709993507;3172.3655268946186;3189.2983543620394;5354.411014788375;5366.838994830152;5425.430329815372;5454.481824226702;5497.257870187518;5336.039512887679;5343.545798607123;5374.3013408256875;5390.8921821563545;5399.379071406789;4829.396325459309;4908.116539022974;4923.138450771118;4936.210206366982;5037.143685573461;4936.80252789888;4987.875303117415;5001.149804533238;5024.371953505812;5060.822871199509;4812.7352995585225;4847.539483749073;4852.684575502599;4857.684250523705;4919.040787046527;4864.854054378375;4927.630427717935;4934.55588996992;4939.827106051271;4970.900581988376;4895.4125504939275;4917.262410638397;4935.062338155739;4958.132326842788;4984.700917944935;5218.112920803473;5256.684598924076;5336.733163341817;5339.252504649352;5392.703401312926;5809.128630705386;5810.767569297223;5819.981503236959;5836;5858.736356863951;5662.688552129631;5825.825225243249;5836.737346819404;5862.794802181946;5892.587518873681;5345;5417.6207665463435;5436.266104075979;5506.146547285177;5508.944910550923;6013.128096425994;6015.578909476295;6022.909656355158;6024.277086749618;6029.186059881859;5579.246801681721;5608.074667679869;5742.454466825645;5744.597878148573;5757.65454072757;5654.660720356792;5700.37295897451;5712.400197979236;5714.714264286769;5755.539556835443;5602.047651899187;5642.605017648807;5643.633163844337;5649.6327738696855;5656.632318899258;5602.915956260659;5669.40471250521;5671.914921276184;5695.857603559944;5710.029295019856;4432.645388368923;4434.623057040188;4460.933086003713;4466.307722303049;4472.396226509444;3928.5482169550296;3937.310970580137;3951.565327813938;3954.209158168378;3973.8807835764974;5415.214793854869;5432.891342173134;5440.265564148868;5491.093969495068;5494.752736126884;5750.539956803445;5798.217240672539;5807.738651760681;5820.476157145878;5820.767169313265;5529.115341545334;5532.640378375393;5534.584906131976;5535.059039963216;5538.806141785099;4894.657373983858;4899.730514821647;4943.950560494349;4985;5019.648624596316;5996.130561068708;6002.849928751729;6019.337872833985;6019.367966363557;6050.54620903434;5717.285339332583;5722.084466485426;5725.1126075456705;5733.483986441241;5734.827955161351;5918.2898052234;5921.437463440966;5949.958757217556;5955.225820643289;6025;5637.379888212376;5645.435456454322;5659.688717120598;5689.288838895138;5692.174634678031;5733.397993210653;5791.276090488689;5803.709814509173;5814.069748840166;5824.126381042877;5378.489043540857;5613.438656134517;5622.381538030895;5630.634008789416;5730.656160630208;5674.177244299636;5675.0636145035605;5679.148127780866;5701.543876489788;5701.657900525982;5557.499825015768;5561.165825126263;5564.165375193753;5577.0797818359515;5586.916196256978;5558.861028474321;5626.493615574618;5674.829755107354;5687.488126068508;5774.971125144348;5591.692456914746;5598.440155984532;5599.300087489064;5601.691906945157;5646.35066967304 01:32:53 INFO - PROCESS | 6158 | |1;ext.html;601.4376557918347;637.4103953842697;639.6034458635646;644.9193850768655;656.0782101147882;43432.34851477227;44774.77612611937;44826.551734482644;44843.5515644843;48597.757011214984;47532;47989.52010479894;47999;48009.51990480094;48042.51957480424;8911.598978045971;9088.909110908873;9097.363184577049;9097.63609455621;9101.817963640757;9004.144606262395;9021.594028268712;9097.727068187965;9103.590338434786;9108;9060.864087038666;9194.35639505235;9199.356045076847;9202.079792020812;9207.861882071775;9075.95462022689;9100.36297459178;9121;9125.589348479334;9132.771680707969;8880.911190888137;8960.910390896073;8991.055939126429;8993.775155621097;8995.955020224923;42683.57316426827;43462;43546.56453435457;43564.78217608923;43612.78193609043;3365.8317084145697;3501.7898926064518;3688.409854423306;3795.335816232176;3826.7129965252716;32851.34297314064;33317.66682333194;33349.52322423327;33556.3288734224;33866.661333386844;4324.372965919924;4345.73925564464;4409.272470042439;4416.668749843742;4459.0858873930765;364324;366214;367825;368177;368850;55422;61153.69423152945;62262;62353.37646623476;65398.346016539224;66917.66541167263;66947;67397.32602674009;67458.66270668615;67542;18008.549786255448;18216.180271887533;18218.180181891847;18219.45341639753;18235.54411139732;12437.440315185839;12871.485140594272;13224.801627975588;14002;14104;18012.549686257687;18072.63854722898;18351.17419716116;18359.81640183581;18444.538886527946;6148.077788331786;6159.476444502178;6171.166892469549;6276.529260305495;6316.968415157987;983.439439519467;1032.808930347888;1036.6060896859144;1070.7751372211924;1172.1033409441784;33448.1637959053;33860.15349616279;33944.830275848464;34016.319673606886;34186.48720269198;1102.0467295789244;1155.1509640414288;1173.3839734139644;1189.149757923089;1228.969275768113;17851;17901.910490447466;17932.193051312723;17996.910015449837;18092.366767163086;476797;479759.82161605626;480771;481049;482272;58980;59466.405335946954;59507.10739338913;59512.404875950684;59671;1327.2169420042221;1419.5954153066327;1440.6470414748453;1457.3369117051716;1459.7737350710656;33351.33297334088;34874.82562587272;34994.300113997066;35155.64844351524;35319.646803531636;52117.73941130422;52750.2087468696;52827.47172528225;52827.73586132045;52835.20747188718;377308;380182;380306;380493;383905;43350.78324608357;44382.77808610936;44791.55208448004;45079.32381014353;45153.774231128635;48574.514254857;50096.49903500918;50784;51220.231696523835;54147;42033.57966420297;42509.78745106255;43285;43294;43671.56328436675;42374.36438453364;42878.142437151706;43036.78481607697;43335;43429.13141737211;42916.78541607272;43385;44623.55376446194;44771;44847;37521;38196.236075278895;38238.42642360422;38460.584473888855;38479.80760096294;29425;29623.37409241498;29657.70342296636;30091.548626770178;30215.395692085596 01:32:53 INFO - PROCESS | 6158 | |2;jquery.html;410.9054917369005;415.2981461330352;415.66123609258455;416.96872734544917;431.2668463611861;18502.537436564075;19936.655279224713;20141.496462588424;20589.176432942702;20674.48313792152;18622.627547449043;18756.531086722804;19391.4182574523;19411;19419;4991.725455099968;5320.122179840322;5320.893582128355;5373.596980226479;5386.407495175527;3977.781222032787;5279.63042587019;5366.9463305367035;5599.41206173352;5853.092770620539;5931.525477961774;5947.791827286046;5949.167116603679;5958.13607026983;5968.67172305523;5735.770569177228;5829.329627092875;5849.7660093596205;5860.355360910296;5867.882642347172;3801.0877389426614;3963.0488682716227;3967.5834037425943;5670.291213598301;5678.801241956553;21356.786432135792;22290.665640015413;22798.430039249153;23919.402014949592;23998.640020399533;2487.987560062188;2551.8341307815117;2622.5279449699046;2792.686435381309;3003.174127115039;10328.535215915303;10581.047705706447;10801.713891912912;12344.5062197512;14780.852191478056;1891.2529550827483;1909.76127984002;1920.6484684225975;2026.1490174126902;2064.4838790302424;71971.64014179948;76077;77757.22242777556;88158.55920720419;90193;11097.889021109686;11176.832347514632;11341.206115571997;11520.251183673203;11683.773203813476;15894.841051589336;15990.840091599168;16024.679506409806;16041;16068.116253606164;8341.20758527939;8548.700795472128;8628.568571571397;8677.869831952527;8706.477611343213;8389;8452.239298463044;8467.195616416431;8600.956995215109;8602.268807151337;4817.301491283744;4926.359573255454;4935.580475659537;4952.257161425815;5015.348004759431;1835.8046727760407;1956.1979588368702;2027.9797202027792;2091.435312465626;2131.648278034107;916.5279880861361;1010.7624708193568;1064.356064580933;1072.383379556758;1079.0935614084208;19578.51053723668;19942.401727948185;19987.800121998593;20168.899155504423;20221.988900554912;1012.1902478017556;1017.4251547875426;1026.9127124194526;1029.613894789454;1031.2729525684374;10812.189085818594;11353.489092990836;11370.147238957112;11473.4263286837;11487.483063262172;430425;434727;436558;457203;479312;90820.54589727141;93401;93458.53270733602;94032.52983735038;95053;1034.4155552113032;1036.2694300518267;1076.434871692352;1097.6542389147394;1100.5652767156928;17566.38517651876;17719.20263588116;17793.377231796825;17999.2800287987;18291.085445727927;30063.398732024798;40391.79663318574;40864.591354087264;41380;41980.79009604932;57776.71111644583;57792.422075780385;58519.4148058531;59116.40883591109;59619.70190149022;9009.189172974464;9022.097790220925;9035.638574456949;9116.680916167903;9148.313876459159;10065.949670251603;13389.397477113747;13735.175889446666;13929.23389213603;13997.650058748613;5406.972965135149;8928.330375222014;10773.86874378179;11913.16607837443;12602.810957835456;11698;11756.647300580997;11988.160828741904;12012.75974480523;12144.696382590153;12194.451249693608;12419.751604967669;12469.688257793629;12518.874811251771;12569.1201615886;8807.295416366547;8965.148310910454;9013.594388252675;9017.549122543978;9104.226140778108;12082.972947299579;12168.87831121713;12179.695507612381;12215.633530994084;12262.26426414418 01:32:53 INFO - PROCESS | 6158 | |3;mootools.html;1380.8550102239271;1546.9690606187876;1571.6620926500805;1746.100758109573;1878.783939846917;8641.438306510081;9104.226140778033;9121.996580376162;9341.81316373672;9356.906430935689;9009.459432434058;9206.401583897043;9211.217046551052;9217.585208665609;9228.723138305844;2061.371281759063;2314.2363020203375;2341.8594884306913;2343.414146463384;2410.529946660402;2296.357020034393;2303.8272129590264;2305.7578954209816;2306.723193216808;2306.884655767213;2295.7589453107435;2332.1953925895623;2335.1943579465055;2335.4745182333922;2336.2874323331375;1986;2283.2579411691186;2344.9882750586307;2348.283773449097;2364.054378248697;2337.3922780077132;2342.7232158473503;2348.5772560939026;2349.5300939812105;2367.8816059197143;9164.8625270621;9260.722178334661;9316.114969077928;9327.813443731087;9340.953295233548;5172.120739474299;5328.520433160996;5344.331958505187;5350.866228344323;5356.330458692663;3317.3531161423534;3345.933081338384;3407.4037043517287;3445.3109378124477;3457.550518432613;1079.6167360586958;1084.4089970965842;1106.9335839849634;1148.3970915269551;1164.150170375622;12791;12806.103572749911;12835.486580536768;12838.679033024157;12846.35768211595;4685.625149987993;4705.929411058837;4807.134715751198;4815.22956326986;4818.975905120452;10726.731831704114;10736.463176841127;10740.946295268473;10756.677299681021;10762.515686794113;4762.333273341735;5434.3207099112615;5434.864128396743;5435.809746658848;5444.40111587725;4696.8590942271785;4762.571368576845;4775.617950563947;4861.1006963711825;4864.756762161877;4032.677385809187;4073.735207211522;4126.339785634284;4181.289180839204;4185.142045880587;1285.1967520299813;1291.541502766523;1297.48100759695;1297.9091463597647;1311.1280998136133;1054.0882136951482;1055.3773273768513;1063.4788953412772;1064.4943651765504;1067.8665166854144;6236.844078897973;6279.0895320178315;6491.706531944386;6492.123563318892;6518.608883467007;476.19760703215195;479.5085037836246;483.76295615148325;488.8728930478101;489.3662706794709;4406.471223453206;4467.955320446819;4561.475430325555;4585.060062687141;4672.906541869143;11020.724481888017;11404.600838970597;11418;11428;11451.59919402817;11050.392228427514;11374.090072794157;11374.601888933848;11384.658460246206;11397.658070257905;7729.768106956801;8047.396445266511;8086.959565202254;8115.229053239933;8173.836523269501;6192.102145189013;6252.249730032243;6277.2781130170615;6277.780277690259;6341.714622841891;9736.610535578497;9755.56099975517;9769.413835169913;9801.558929848317;9843.803123937625;10298.279120461795;10602.89397106019;10683.51924163399;10684.198685098803;10743.838842417214;7772.261635144652;7999.160088190656;8015.238552337519;8396.076431592397;8567;8093.635786389745;8895;8910.198082172636;9142.497162656118;9143.542822858963;7893.684252629831;8051.637676304697;8158.3065439438315;8165;8336.499810011419;7955.323797477279;8038.075621303625;8089.635966381409;8183.631736571988;8185.30424913889;7095.858082838417;7131.25121862197;7341.008963790034;7536;7700.5764682940735;5483.698396588226;5491.862703432446;5685.886282274414;5702.885942281214;5769.394213607511;5483.232347471437;5713.628614140068;5726.79956201531;5814.738336774771;5842.123681447647 01:32:53 INFO - PROCESS | 6158 | |4;prototype.html;334.7554646097914;337.0696876620528;337.79225776147644;338.13606236066846;347.7600455685576;5359.67841929484;5377.7580008899595;5391.81128660497;5395.919061214085;5446.836594902149;5070.264811602316;5084.347587034219;5222.686638801665;5246.501582349671;5295.152775555912;4139.710220284566;4177.624013838754;4181.142865712537;4184.225918205127;4189.015581338383;4183.560726123759;4184.958150418503;4191.895202619944;4206.326987681971;4213.325867861143;4006.5993400659845;4089.20260549193;4115.629593336599;4159.667226621863;4169.124483858378;4102.179564087194;4148.605882441163;4166.770827604496;4169.812358443877;4170.39529268256;3708.87018954338;3721.3115573618966;3726.6832319252894;3730.123420996064;3746.7002639788752;5048.217526283432;5064.366954130734;5086.847394578169;5113.744312784346;5200.635955483118;4717.834875779366;4741.668083234175;4768.7615619218905;4805.495422980572;4821.758912054418;5494.587905907033;5507.284053073115;5507.5593952484105;5532.5020748132865;5542.224088627595;3915.197384536163;4060.4112403701592;4066.1054567994993;4072.3484242521054;4117.814698338552;5731.44950497029;5732.197492351074;5754.251947246831;5775.8556036099435;5815.79644712433;4192.538820729717;4194.748315101104;4201.222773786859;4204.957950420518;4210.6841986851105;3884.8446062157195;4029.6373326400767;4062.2281766464275;4219.493660760667;4242.53332133465;4565.817367305271;4630.814767409266;4635.791389387486;4637.281221410687;4643.791029403685;5504.862378440491;5537.556995440355;5547.334319881559;5600.663960162403;5606.271184745957;1356.5387768158873;1366.3100134432048;1403.9649008774863;1408.401429392504;1414.70291238841;949.4066208619613;962.7352478068448;963.6097380560884;965.1747755668943;973.5473005052685;5352.277442545284;5434.293541839615;5444.754986025639;5475.6440831345835;5488.368837583649;5496.587755918322;5672.659640421505;5697.6296540724725;5705.4579814917515;5708.771649133988;5365.382980957162;5385.246065550826;5399.70301633414;5408.728334099687;5432.782688692408;2904.1868276882506;2989.925251868721;3007.593974813416;3050.557669138007;3052.6568309943555;5850.5904586678525;5889.970550147307;5901.3508514063415;5929.6145750526075;5954.523638108941;5717.885642287131;5733.226014488074;5758.452946970031;5770;5776;5694.572907031989;5905.498032667186;5964.9105263420215;5966.820995370233;6042.184305118841;5684.232628595252;5731.598788084794;5769.18270744714;5795.116587109291;5855.443732845373;5506.366767821752;5663.5469162467725;5692.459216374438;5693.914591281051;5753.798617048383;5932.347441781314;5973;5984.401559843981;5995;6018.488428483628;4032.1129351542613;4038.0914294284726;4046.2918989176187;4075.2053349596545;4086.816093275869;5487.670739755627;5688.089905615082;5712.457316554921;5720.542356611544;5738.397468265772;5584;5592.496675299242;5595.692236926845;5607.411221821813;5621.8594535136945;5325.334333208349;5369.248305237348;5635.549156067423;5637.701944362594;5644.238027866186;5470.781168753205;5496;5497.697626630574;5545.584081194007;5552.639078459887;5318.574514038945;5569.081101618188;5621.241132447068;5657.26455560791;5687.459691329317;5482.945170548243;5486.890262194814;5503.147012213113;5518.972405137949;5519 01:32:53 INFO - PROCESS | 6158 | |5;yui.html;851.7657644147861;856.54603060378;872.4677946452658;879.6921077622833;907.9546022698863;14694.338754756034;15503.14732689703;15574.299156537954;15635.84364156358;15684;14636.121832690045;14686.118832870008;14686.706265874676;14695.926520367384;14709.705805883876;693.7051753004965;809.0776514773163;840.0381563110235;842.2672275120623;846.4709556527171;824.11819353292;824.9711260105897;829.2578142562403;831.5717405536154;832.6003518311214;725.5465334166146;878.6441491196044;878.9340799440035;879.5734068976541;879.8768172455862;736.193867714854;742.6398196874511;846.6571038729294;869.604330029835;869.7303835810919;626.6208943589154;627.2034516164491;627.5701144715885;628.6259675493075;629.1537881549309;13845.100068495516;13892.791608125886;13961.371738271802;14029.929850350785;14078.2960851957;12939.5471158509;13601;13923.721525569432;14085.366158522891;14143.858561414358;11960.102992275528;12020.098492613002;12084.939575302154;12291.385430728427;12489.313087780169;4399.362092496602;4448.555144485558;4462.9107417851465;4486.528914463967;4520.886977825548;59644.701776491274;60488.69755651238;60582;60959.39040609626;62448.06327905085;11251;11355.829662555068;11392.25950313227;11529.596464123715;11581;21313.68029479559;21395.572088558143;21519.56960860774;22209.888950555145;22408.991595378247;8774.780630484289;8969;9054.909450905538;9177.541122943827;9188.219001384958;4869.245266983623;4872.78072486739;4967.726775027336;5050.671706339076;5164.431912489623;3583;3677.742558020913;3702.6852717518773;3705.7220708446976;3707.8146092695256;591.7425919724933;655.6787174284566;667.39934059346;674.5918719174927;690.1304356510833;550.9779608815683;638.8498702804837;689.8309914071085;721.6463932672953;736.8047467421138;10077.69766906994;10445.84331235032;10532;10552.15582753378;10581.947090264499;609.7225762278152;705.6154395854169;745.7017193122795;757.8484303139284;785.0814546980047;4682.882927926761;4694.755974553836;4993.825216117419;5002.52476014778;5048.798048078036;71964;73133;74723.62638186883;74835;74875;67114.66442667755;69289;70147.64926175438;70388.64805675938;70498;61880;62090.37909620936;62093.689531552955;62270.688646556475;62544.06183907245;9513.571889265138;9603.855942160733;9607.327487075838;9741.172000380047;9816.26378021637;39791.60208397879;40128.59871401366;41144.588554114074;41263;41428.378574322014;50959.49040509547;56316.71841640765;56855.147172793266;57170.14244786415;57407.7129614366;12603.369831508571;12796.296203708513;12916.547920822726;12924.1305851842;13269.734605307647;13443.260620665566;13684.794728079285;13775.104618199784;14107.929460353043;14301.57095287143;13087;13570.185788852701;13672.589822305346;13911.930440347733;14012.509562165274;12276;12862.614121576367;12887.742245155232;12895.355232238539;13393.397297121848;12829.166104203197;13125.409356579168;13159.934200328937;13163.934180329037;13163.934180329037;10781.676549703521;10853.837192442277;10940.56237750481;10985.725356866142;11384.715382115513;11191.944040279746;11211.327320360804;11466.426678666201;11498.885011150116;11519.942400287944 01:32:53 INFO - PROCESS | 6158 | __end_tp_report 01:32:53 INFO - PROCESS | 6158 | __start_cc_report 01:32:53 INFO - PROCESS | 6158 | _x_x_mozilla_cycle_collect,1019 01:32:53 INFO - PROCESS | 6158 | __end_cc_report 01:32:53 INFO - PROCESS | 6158 | __startTimestamp1463560373414__endTimestamp 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | ------- Summary: start ------- 01:32:53 INFO - PROCESS | 6158 | Number of tests: 6 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#0] dojo.html Cycles:165 Average:5367.75 Median:5586.92 stddev:602.26 (10.8%) stddev-sans-first:578.00 01:32:53 INFO - PROCESS | 6158 | Values: 3132.0 3138.5 3155.5 3172.4 3189.3 5354.4 5366.8 5425.4 5454.5 5497.3 5336.0 5343.5 5374.3 5390.9 5399.4 4829.4 4908.1 4923.1 4936.2 5037.1 4936.8 4987.9 5001.1 5024.4 5060.8 4812.7 4847.5 4852.7 4857.7 4919.0 4864.9 4927.6 4934.6 4939.8 4970.9 4895.4 4917.3 4935.1 4958.1 4984.7 5218.1 5256.7 5336.7 5339.3 5392.7 5809.1 5810.8 5820.0 5836.0 5858.7 5662.7 5825.8 5836.7 5862.8 5892.6 5345.0 5417.6 5436.3 5506.1 5508.9 6013.1 6015.6 6022.9 6024.3 6029.2 5579.2 5608.1 5742.5 5744.6 5757.7 5654.7 5700.4 5712.4 5714.7 5755.5 5602.0 5642.6 5643.6 5649.6 5656.6 5602.9 5669.4 5671.9 5695.9 5710.0 4432.6 4434.6 4460.9 4466.3 4472.4 3928.5 3937.3 3951.6 3954.2 3973.9 5415.2 5432.9 5440.3 5491.1 5494.8 5750.5 5798.2 5807.7 5820.5 5820.8 5529.1 5532.6 5534.6 5535.1 5538.8 4894.7 4899.7 4944.0 4985.0 5019.6 5996.1 6002.8 6019.3 6019.4 6050.5 5717.3 5722.1 5725.1 5733.5 5734.8 5918.3 5921.4 5950.0 5955.2 6025.0 5637.4 5645.4 5659.7 5689.3 5692.2 5733.4 5791.3 5803.7 5814.1 5824.1 5378.5 5613.4 5622.4 5630.6 5730.7 5674.2 5675.1 5679.1 5701.5 5701.7 5557.5 5561.2 5564.2 5577.1 5586.9 5558.9 5626.5 5674.8 5687.5 5775.0 5591.7 5598.4 5599.3 5601.7 5646.4 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#1] ext.html Cycles:180 Average:59225.18 Median:43504.28 stddev:108605.81 (249.6%) stddev-sans-first:108821.28 01:32:53 INFO - PROCESS | 6158 | Values: 601.4 637.4 639.6 644.9 656.1 43432.3 44774.8 44826.6 44843.6 48597.8 47532.0 47989.5 47999.0 48009.5 48042.5 8911.6 9088.9 9097.4 9097.6 9101.8 9004.1 9021.6 9097.7 9103.6 9108.0 9060.9 9194.4 9199.4 9202.1 9207.9 9076.0 9100.4 9121.0 9125.6 9132.8 8880.9 8960.9 8991.1 8993.8 8996.0 42683.6 43462.0 43546.6 43564.8 43612.8 3365.8 3501.8 3688.4 3795.3 3826.7 32851.3 33317.7 33349.5 33556.3 33866.7 4324.4 4345.7 4409.3 4416.7 4459.1 364324.0 366214.0 367825.0 368177.0 368850.0 55422.0 61153.7 62262.0 62353.4 65398.3 66917.7 66947.0 67397.3 67458.7 67542.0 18008.5 18216.2 18218.2 18219.5 18235.5 12437.4 12871.5 13224.8 14002.0 14104.0 18012.5 18072.6 18351.2 18359.8 18444.5 6148.1 6159.5 6171.2 6276.5 6317.0 983.4 1032.8 1036.6 1070.8 1172.1 33448.2 33860.2 33944.8 34016.3 34186.5 1102.0 1155.2 1173.4 1189.1 1229.0 17851.0 17901.9 17932.2 17996.9 18092.4 476797.0 479759.8 480771.0 481049.0 482272.0 58980.0 59466.4 59507.1 59512.4 59671.0 1327.2 1419.6 1440.6 1457.3 1459.8 33351.3 34874.8 34994.3 35155.6 35319.6 52117.7 52750.2 52827.5 52827.7 52835.2 377308.0 380182.0 380306.0 380493.0 383905.0 43350.8 44382.8 44791.6 45079.3 45153.8 48574.5 50096.5 50784.0 51220.2 54147.0 42033.6 42509.8 43285.0 43294.0 43671.6 42374.4 42878.1 43036.8 43335.0 43429.1 42916.8 43385.0 44623.6 44771.0 44847.0 37521.0 38196.2 38238.4 38460.6 38479.8 29425.0 29623.4 29657.7 30091.5 30215.4 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#2] jquery.html Cycles:180 Average:27950.49 Median:23959.02 stddev:74133.40 (309.4%) stddev-sans-first:74312.53 01:32:53 INFO - PROCESS | 6158 | Values: 410.9 415.3 415.7 417.0 431.3 18502.5 19936.7 20141.5 20589.2 20674.5 18622.6 18756.5 19391.4 19411.0 19419.0 4991.7 5320.1 5320.9 5373.6 5386.4 3977.8 5279.6 5366.9 5599.4 5853.1 5931.5 5947.8 5949.2 5958.1 5968.7 5735.8 5829.3 5849.8 5860.4 5867.9 3801.1 3963.0 3967.6 5670.3 5678.8 21356.8 22290.7 22798.4 23919.4 23998.6 2488.0 2551.8 2622.5 2792.7 3003.2 10328.5 10581.0 10801.7 12344.5 14780.9 1891.3 1909.8 1920.6 2026.1 2064.5 71971.6 76077.0 77757.2 88158.6 90193.0 11097.9 11176.8 11341.2 11520.3 11683.8 15894.8 15990.8 16024.7 16041.0 16068.1 8341.2 8548.7 8628.6 8677.9 8706.5 8389.0 8452.2 8467.2 8601.0 8602.3 4817.3 4926.4 4935.6 4952.3 5015.3 1835.8 1956.2 2028.0 2091.4 2131.6 916.5 1010.8 1064.4 1072.4 1079.1 19578.5 19942.4 19987.8 20168.9 20222.0 1012.2 1017.4 1026.9 1029.6 1031.3 10812.2 11353.5 11370.1 11473.4 11487.5 430425.0 434727.0 436558.0 457203.0 479312.0 90820.5 93401.0 93458.5 94032.5 95053.0 1034.4 1036.3 1076.4 1097.7 1100.6 17566.4 17719.2 17793.4 17999.3 18291.1 30063.4 40391.8 40864.6 41380.0 41980.8 57776.7 57792.4 58519.4 59116.4 59619.7 9009.2 9022.1 9035.6 9116.7 9148.3 10065.9 13389.4 13735.2 13929.2 13997.7 5407.0 8928.3 10773.9 11913.2 12602.8 11698.0 11756.6 11988.2 12012.8 12144.7 12194.5 12419.8 12469.7 12518.9 12569.1 8807.3 8965.1 9013.6 9017.5 9104.2 12083.0 12168.9 12179.7 12215.6 12262.3 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#3] mootools.html Cycles:180 Average:6003.75 Median:4769.09 stddev:3445.88 (72.3%) stddev-sans-first:3438.03 01:32:53 INFO - PROCESS | 6158 | Values: 1380.9 1547.0 1571.7 1746.1 1878.8 8641.4 9104.2 9122.0 9341.8 9356.9 9009.5 9206.4 9211.2 9217.6 9228.7 2061.4 2314.2 2341.9 2343.4 2410.5 2296.4 2303.8 2305.8 2306.7 2306.9 2295.8 2332.2 2335.2 2335.5 2336.3 1986.0 2283.3 2345.0 2348.3 2364.1 2337.4 2342.7 2348.6 2349.5 2367.9 9164.9 9260.7 9316.1 9327.8 9341.0 5172.1 5328.5 5344.3 5350.9 5356.3 3317.4 3345.9 3407.4 3445.3 3457.6 1079.6 1084.4 1106.9 1148.4 1164.2 12791.0 12806.1 12835.5 12838.7 12846.4 4685.6 4705.9 4807.1 4815.2 4819.0 10726.7 10736.5 10740.9 10756.7 10762.5 4762.3 5434.3 5434.9 5435.8 5444.4 4696.9 4762.6 4775.6 4861.1 4864.8 4032.7 4073.7 4126.3 4181.3 4185.1 1285.2 1291.5 1297.5 1297.9 1311.1 1054.1 1055.4 1063.5 1064.5 1067.9 6236.8 6279.1 6491.7 6492.1 6518.6 476.2 479.5 483.8 488.9 489.4 4406.5 4468.0 4561.5 4585.1 4672.9 11020.7 11404.6 11418.0 11428.0 11451.6 11050.4 11374.1 11374.6 11384.7 11397.7 7729.8 8047.4 8087.0 8115.2 8173.8 6192.1 6252.2 6277.3 6277.8 6341.7 9736.6 9755.6 9769.4 9801.6 9843.8 10298.3 10602.9 10683.5 10684.2 10743.8 7772.3 7999.2 8015.2 8396.1 8567.0 8093.6 8895.0 8910.2 9142.5 9143.5 7893.7 8051.6 8158.3 8165.0 8336.5 7955.3 8038.1 8089.6 8183.6 8185.3 7095.9 7131.3 7341.0 7536.0 7700.6 5483.7 5491.9 5685.9 5702.9 5769.4 5483.2 5713.6 5726.8 5814.7 5842.1 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#4] prototype.html Cycles:180 Average:4700.15 Median:5404.22 stddev:1379.73 (25.5%) stddev-sans-first:1344.13 01:32:53 INFO - PROCESS | 6158 | Values: 334.8 337.1 337.8 338.1 347.8 5359.7 5377.8 5391.8 5395.9 5446.8 5070.3 5084.3 5222.7 5246.5 5295.2 4139.7 4177.6 4181.1 4184.2 4189.0 4183.6 4185.0 4191.9 4206.3 4213.3 4006.6 4089.2 4115.6 4159.7 4169.1 4102.2 4148.6 4166.8 4169.8 4170.4 3708.9 3721.3 3726.7 3730.1 3746.7 5048.2 5064.4 5086.8 5113.7 5200.6 4717.8 4741.7 4768.8 4805.5 4821.8 5494.6 5507.3 5507.6 5532.5 5542.2 3915.2 4060.4 4066.1 4072.3 4117.8 5731.4 5732.2 5754.3 5775.9 5815.8 4192.5 4194.7 4201.2 4205.0 4210.7 3884.8 4029.6 4062.2 4219.5 4242.5 4565.8 4630.8 4635.8 4637.3 4643.8 5504.9 5537.6 5547.3 5600.7 5606.3 1356.5 1366.3 1404.0 1408.4 1414.7 949.4 962.7 963.6 965.2 973.5 5352.3 5434.3 5444.8 5475.6 5488.4 5496.6 5672.7 5697.6 5705.5 5708.8 5365.4 5385.2 5399.7 5408.7 5432.8 2904.2 2989.9 3007.6 3050.6 3052.7 5850.6 5890.0 5901.4 5929.6 5954.5 5717.9 5733.2 5758.5 5770.0 5776.0 5694.6 5905.5 5964.9 5966.8 6042.2 5684.2 5731.6 5769.2 5795.1 5855.4 5506.4 5663.5 5692.5 5693.9 5753.8 5932.3 5973.0 5984.4 5995.0 6018.5 4032.1 4038.1 4046.3 4075.2 4086.8 5487.7 5688.1 5712.5 5720.5 5738.4 5584.0 5592.5 5595.7 5607.4 5621.9 5325.3 5369.2 5635.5 5637.7 5644.2 5470.8 5496.0 5497.7 5545.6 5552.6 5318.6 5569.1 5621.2 5657.3 5687.5 5482.9 5486.9 5503.1 5519.0 5519.0 01:32:53 INFO - PROCESS | 6158 | 01:32:53 INFO - PROCESS | 6158 | [#5] yui.html Cycles:180 Average:16910.03 Median:4688.82 stddev:20763.14 (442.8%) stddev-sans-first:20786.37 01:32:53 INFO - PROCESS | 6158 | Values: 851.8 856.5 872.5 879.7 908.0 14694.3 15503.1 15574.3 15635.8 15684.0 14636.1 14686.1 14686.7 14695.9 14709.7 693.7 809.1 840.0 842.3 846.5 824.1 825.0 829.3 831.6 832.6 725.5 878.6 878.9 879.6 879.9 736.2 742.6 846.7 869.6 869.7 626.6 627.2 627.6 628.6 629.2 13845.1 13892.8 13961.4 14029.9 14078.3 12939.5 13601.0 13923.7 14085.4 14143.9 11960.1 12020.1 12084.9 12291.4 12489.3 4399.4 4448.6 4462.9 4486.5 4520.9 59644.7 60488.7 60582.0 60959.4 62448.1 11251.0 11355.8 11392.3 11529.6 11581.0 21313.7 21395.6 21519.6 22209.9 22409.0 8774.8 8969.0 9054.9 9177.5 9188.2 4869.2 4872.8 4967.7 5050.7 5164.4 3583.0 3677.7 3702.7 3705.7 3707.8 591.7 655.7 667.4 674.6 690.1 551.0 638.8 689.8 721.6 736.8 10077.7 10445.8 10532.0 10552.2 10581.9 609.7 705.6 745.7 757.8 785.1 4682.9 4694.8 4993.8 5002.5 5048.8 71964.0 73133.0 74723.6 74835.0 74875.0 67114.7 69289.0 70147.6 70388.6 70498.0 61880.0 62090.4 62093.7 62270.7 62544.1 9513.6 9603.9 9607.3 9741.2 9816.3 39791.6 40128.6 41144.6 41263.0 41428.4 50959.5 56316.7 56855.1 57170.1 57407.7 12603.4 12796.3 12916.5 12924.1 13269.7 13443.3 13684.8 13775.1 14107.9 14301.6 13087.0 13570.2 13672.6 13911.9 14012.5 12276.0 12862.6 12887.7 12895.4 13393.4 12829.2 13125.4 13159.9 13163.9 13163.9 10781.7 10853.8 10940.6 10985.7 11384.7 11191.9 11211.3 11466.4 11498.9 11519.9 01:32:53 INFO - PROCESS | 6158 | -------- Summary: end -------- 01:32:53 INFO - PROCESS | 6158 | 01:32:54 INFO - TEST-INFO | 6158: exit 0 01:32:54 INFO - TEST-OK | dromaeo_css | took 1112813ms 01:32:54 INFO - TEST-START | kraken 01:32:54 INFO - operating with platform_type : linux_ 01:32:54 INFO - Initialising browser for kraken test... 01:32:54 INFO - TEST-INFO | started process 6342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmVmCFZ/profile http://localhost:33375/getInfo.html) 01:32:58 INFO - PROCESS | 6342 | __metrics Screen width/height:1600/1200 01:32:58 INFO - PROCESS | 6342 | colorDepth:24 01:32:58 INFO - PROCESS | 6342 | Browser inner width/height: 1024/697 01:32:58 INFO - PROCESS | 6342 | __metrics 01:32:59 ERROR - PROCESS | 6342 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:33:00 INFO - TEST-INFO | 6342: exit 0 01:33:00 INFO - Browser initialized. 01:33:00 INFO - Running cycle 1/1 for kraken test... 01:33:00 INFO - TEST-INFO | started process 6424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmVmCFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:33:12 INFO - PROCESS | 6424 | RSS: Main: 152887296 01:33:12 INFO - PROCESS | 6424 | 01:33:14 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33375/tests/kraken/driver.html?testName=audio-beat-detection) 01:33:15 INFO - PROCESS | 6424 | RSS: Main: 208592896 01:33:15 INFO - PROCESS | 6424 | 01:33:18 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33375/tests/kraken/driver.html?testName=audio-dft) 01:33:19 INFO - PROCESS | 6424 | RSS: Main: 197607424 01:33:19 INFO - PROCESS | 6424 | 01:33:22 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33375/tests/kraken/driver.html?testName=audio-fft) 01:33:22 INFO - PROCESS | 6424 | RSS: Main: 265568256 01:33:22 INFO - PROCESS | 6424 | 01:33:25 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33375/tests/kraken/driver.html?testName=audio-oscillator) 01:33:25 INFO - PROCESS | 6424 | RSS: Main: 175636480 01:33:25 INFO - PROCESS | 6424 | 01:33:27 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:33:28 INFO - PROCESS | 6424 | RSS: Main: 179036160 01:33:28 INFO - PROCESS | 6424 | 01:33:31 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33375/tests/kraken/driver.html?testName=imaging-darkroom) 01:33:32 INFO - PROCESS | 6424 | RSS: Main: 214953984 01:33:32 INFO - PROCESS | 6424 | 01:33:35 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33375/tests/kraken/driver.html?testName=imaging-desaturate) 01:33:36 INFO - PROCESS | 6424 | RSS: Main: 213118976 01:33:36 INFO - PROCESS | 6424 | 01:33:39 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33375/tests/kraken/driver.html?testName=json-parse-financial) 01:33:40 INFO - PROCESS | 6424 | RSS: Main: 213995520 01:33:40 INFO - PROCESS | 6424 | 01:33:41 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:33:42 INFO - PROCESS | 6424 | RSS: Main: 203751424 01:33:42 INFO - PROCESS | 6424 | 01:33:44 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:33:44 INFO - PROCESS | 6424 | RSS: Main: 206540800 01:33:44 INFO - PROCESS | 6424 | 01:33:46 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:33:47 INFO - PROCESS | 6424 | RSS: Main: 217759744 01:33:47 INFO - PROCESS | 6424 | 01:33:50 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:33:50 INFO - PROCESS | 6424 | RSS: Main: 222904320 01:33:50 INFO - PROCESS | 6424 | 01:33:53 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:33:54 INFO - PROCESS | 6424 | RSS: Main: 219865088 01:33:54 INFO - PROCESS | 6424 | 01:33:55 INFO - PROCESS | 6424 | Cycle 1(1): loaded http://localhost:33375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33375/tests/kraken/driver.html?testName=ai-astar) 01:33:56 INFO - PROCESS | 6424 | RSS: Main: 266162176 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | __start_tp_report 01:33:56 INFO - PROCESS | 6424 | _x_x_mozilla_page_load 01:33:56 INFO - PROCESS | 6424 | _x_x_mozilla_page_load_details 01:33:56 INFO - PROCESS | 6424 | |i|pagename|runs| 01:33:56 INFO - PROCESS | 6424 | |0;ai-astar;111;105;114;112;111;110;110;112;110;109 01:33:56 INFO - PROCESS | 6424 | |1;audio-beat-detection;153;124;152;220;125;159;148;124;183;131 01:33:56 INFO - PROCESS | 6424 | |2;audio-dft;161;162;159;160;159;161;162;161;163;160 01:33:56 INFO - PROCESS | 6424 | |3;audio-fft;74;75;74;160;75;74;75;76;129;75 01:33:56 INFO - PROCESS | 6424 | |4;audio-oscillator;92;92;144;91;92;93;122;92;91;124 01:33:56 INFO - PROCESS | 6424 | |5;imaging-gaussian-blur;116;116;116;116;116;116;116;117;117;116 01:33:56 INFO - PROCESS | 6424 | |6;imaging-darkroom;145;146;145;145;145;146;145;146;145;146 01:33:56 INFO - PROCESS | 6424 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;95 01:33:56 INFO - PROCESS | 6424 | |8;json-parse-financial;54;58;55;53;54;54;54;123;52;52 01:33:56 INFO - PROCESS | 6424 | |9;json-stringify-tinderbox;59;59;59;59;60;58;59;59;59;60 01:33:56 INFO - PROCESS | 6424 | |10;stanford-crypto-aes;78;82;81;78;78;79;79;80;82;83 01:33:56 INFO - PROCESS | 6424 | |11;stanford-crypto-ccm;133;121;127;128;118;120;122;118;195;123 01:33:56 INFO - PROCESS | 6424 | |12;stanford-crypto-pbkdf2;162;160;160;164;161;162;166;165;165;157 01:33:56 INFO - PROCESS | 6424 | |13;stanford-crypto-sha256-iterative;63;70;63;63;62;61;62;61;63;64 01:33:56 INFO - PROCESS | 6424 | __end_tp_report 01:33:56 INFO - PROCESS | 6424 | __start_cc_report 01:33:56 INFO - PROCESS | 6424 | _x_x_mozilla_cycle_collect,1857 01:33:56 INFO - PROCESS | 6424 | __end_cc_report 01:33:56 INFO - PROCESS | 6424 | __startTimestamp1463560436091__endTimestamp 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | ------- Summary: start ------- 01:33:56 INFO - PROCESS | 6424 | Number of tests: 14 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.37 (2.1%) stddev-sans-first:2.50 01:33:56 INFO - PROCESS | 6424 | Values: 111.0 105.0 114.0 112.0 111.0 110.0 110.0 112.0 110.0 109.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:152.50 stddev:30.53 (20.0%) stddev-sans-first:32.38 01:33:56 INFO - PROCESS | 6424 | Values: 153.0 124.0 152.0 220.0 125.0 159.0 148.0 124.0 183.0 131.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 01:33:56 INFO - PROCESS | 6424 | Values: 161.0 162.0 159.0 160.0 159.0 161.0 162.0 161.0 163.0 160.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#3] audio-fft Cycles:10 Average:88.70 Median:75.00 stddev:30.31 (40.4%) stddev-sans-first:31.68 01:33:56 INFO - PROCESS | 6424 | Values: 74.0 75.0 74.0 160.0 75.0 74.0 75.0 76.0 129.0 75.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:92.00 stddev:19.30 (21.0%) stddev-sans-first:20.04 01:33:56 INFO - PROCESS | 6424 | Values: 92.0 92.0 144.0 91.0 92.0 93.0 122.0 92.0 91.0 124.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#5] imaging-gaussian-blur Cycles:10 Average:116.20 Median:116.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:33:56 INFO - PROCESS | 6424 | Values: 116.0 116.0 116.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:33:56 INFO - PROCESS | 6424 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 146.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:33:56 INFO - PROCESS | 6424 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:54.00 stddev:21.89 (40.5%) stddev-sans-first:23.07 01:33:56 INFO - PROCESS | 6424 | Values: 54.0 58.0 55.0 53.0 54.0 54.0 54.0 123.0 52.0 52.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 01:33:56 INFO - PROCESS | 6424 | Values: 59.0 59.0 59.0 59.0 60.0 58.0 59.0 59.0 59.0 60.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:80.50 stddev:1.89 (2.3%) stddev-sans-first:1.86 01:33:56 INFO - PROCESS | 6424 | Values: 78.0 82.0 81.0 78.0 78.0 79.0 79.0 80.0 82.0 83.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:125.00 stddev:23.16 (18.5%) stddev-sans-first:24.54 01:33:56 INFO - PROCESS | 6424 | Values: 133.0 121.0 127.0 128.0 118.0 120.0 122.0 118.0 195.0 123.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:2.82 (1.7%) stddev-sans-first:2.99 01:33:56 INFO - PROCESS | 6424 | Values: 162.0 160.0 160.0 164.0 161.0 162.0 166.0 165.0 165.0 157.0 01:33:56 INFO - PROCESS | 6424 | 01:33:56 INFO - PROCESS | 6424 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.57 (4.1%) stddev-sans-first:2.73 01:33:56 INFO - PROCESS | 6424 | Values: 63.0 70.0 63.0 63.0 62.0 61.0 62.0 61.0 63.0 64.0 01:33:56 INFO - PROCESS | 6424 | -------- Summary: end -------- 01:33:56 INFO - PROCESS | 6424 | 01:33:57 INFO - TEST-INFO | 6424: exit 0 01:33:57 INFO - TEST-OK | kraken | took 62938ms 01:33:57 INFO - SUITE-END | took 1175s 01:33:57 INFO - Completed test suite (00:19:35) 01:33:57 INFO - javascript benchmark 01:33:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.953020704689, 3138.4507711150527, 3155.5266709993507, 3172.3655268946186, 3189.2983543620394, 5354.411014788375, 5366.838994830152, 5425.430329815372, 5454.481824226702, 5497.257870187518, 5336.039512887679, 5343.545798607123, 5374.3013408256875, 5390.8921821563545, 5399.379071406789, 4829.396325459309, 4908.116539022974, 4923.138450771118, 4936.210206366982, 5037.143685573461, 4936.80252789888, 4987.875303117415, 5001.149804533238, 5024.371953505812, 5060.822871199509, 4812.7352995585225, 4847.539483749073, 4852.684575502599, 4857.684250523705, 4919.040787046527, 4864.854054378375, 4927.630427717935, 4934.55588996992, 4939.827106051271, 4970.900581988376, 4895.4125504939275, 4917.262410638397, 4935.062338155739, 4958.132326842788, 4984.700917944935, 5218.112920803473, 5256.684598924076, 5336.733163341817, 5339.252504649352, 5392.703401312926, 5809.128630705386, 5810.767569297223, 5819.981503236959, 5836.0, 5858.736356863951, 5662.688552129631, 5825.825225243249, 5836.737346819404, 5862.794802181946, 5892.587518873681, 5345.0, 5417.6207665463435, 5436.266104075979, 5506.146547285177, 5508.944910550923, 6013.128096425994, 6015.578909476295, 6022.909656355158, 6024.277086749618, 6029.186059881859, 5579.246801681721, 5608.074667679869, 5742.454466825645, 5744.597878148573, 5757.65454072757, 5654.660720356792, 5700.37295897451, 5712.400197979236, 5714.714264286769, 5755.539556835443, 5602.047651899187, 5642.605017648807, 5643.633163844337, 5649.6327738696855, 5656.632318899258, 5602.915956260659, 5669.40471250521, 5671.914921276184, 5695.857603559944, 5710.029295019856, 4432.645388368923, 4434.623057040188, 4460.933086003713, 4466.307722303049, 4472.396226509444, 3928.5482169550296, 3937.310970580137, 3951.565327813938, 3954.209158168378, 3973.8807835764974, 5415.214793854869, 5432.891342173134, 5440.265564148868, 5491.093969495068, 5494.752736126884, 5750.539956803445, 5798.217240672539, 5807.738651760681, 5820.476157145878, 5820.767169313265, 5529.115341545334, 5532.640378375393, 5534.584906131976, 5535.059039963216, 5538.806141785099, 4894.657373983858, 4899.730514821647, 4943.950560494349, 4985.0, 5019.648624596316, 5996.130561068708, 6002.849928751729, 6019.337872833985, 6019.367966363557, 6050.54620903434, 5717.285339332583, 5722.084466485426, 5725.1126075456705, 5733.483986441241, 5734.827955161351, 5918.2898052234, 5921.437463440966, 5949.958757217556, 5955.225820643289, 6025.0, 5637.379888212376, 5645.435456454322, 5659.688717120598, 5689.288838895138, 5692.174634678031, 5733.397993210653, 5791.276090488689, 5803.709814509173, 5814.069748840166, 5824.126381042877, 5378.489043540857, 5613.438656134517, 5622.381538030895, 5630.634008789416, 5730.656160630208, 5674.177244299636, 5675.0636145035605, 5679.148127780866, 5701.543876489788, 5701.657900525982, 5557.499825015768, 5561.165825126263, 5564.165375193753, 5577.0797818359515, 5586.916196256978, 5558.861028474321, 5626.493615574618, 5674.829755107354, 5687.488126068508, 5774.971125144348, 5591.692456914746, 5598.440155984532, 5599.300087489064, 5601.691906945157, 5646.35066967304], "value": 5327.666663909755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4376557918347, 637.4103953842697, 639.6034458635646, 644.9193850768655, 656.0782101147882, 43432.34851477227, 44774.77612611937, 44826.551734482644, 44843.5515644843, 48597.757011214984, 47532.0, 47989.52010479894, 47999.0, 48009.51990480094, 48042.51957480424, 8911.598978045971, 9088.909110908873, 9097.363184577049, 9097.63609455621, 9101.817963640757, 9004.144606262395, 9021.594028268712, 9097.727068187965, 9103.590338434786, 9108.0, 9060.864087038666, 9194.35639505235, 9199.356045076847, 9202.079792020812, 9207.861882071775, 9075.95462022689, 9100.36297459178, 9121.0, 9125.589348479334, 9132.771680707969, 8880.911190888137, 8960.910390896073, 8991.055939126429, 8993.775155621097, 8995.955020224923, 42683.57316426827, 43462.0, 43546.56453435457, 43564.78217608923, 43612.78193609043, 3365.8317084145697, 3501.7898926064518, 3688.409854423306, 3795.335816232176, 3826.7129965252716, 32851.34297314064, 33317.66682333194, 33349.52322423327, 33556.3288734224, 33866.661333386844, 4324.372965919924, 4345.73925564464, 4409.272470042439, 4416.668749843742, 4459.0858873930765, 364324.0, 366214.0, 367825.0, 368177.0, 368850.0, 55422.0, 61153.69423152945, 62262.0, 62353.37646623476, 65398.346016539224, 66917.66541167263, 66947.0, 67397.32602674009, 67458.66270668615, 67542.0, 18008.549786255448, 18216.180271887533, 18218.180181891847, 18219.45341639753, 18235.54411139732, 12437.440315185839, 12871.485140594272, 13224.801627975588, 14002.0, 14104.0, 18012.549686257687, 18072.63854722898, 18351.17419716116, 18359.81640183581, 18444.538886527946, 6148.077788331786, 6159.476444502178, 6171.166892469549, 6276.529260305495, 6316.968415157987, 983.439439519467, 1032.808930347888, 1036.6060896859144, 1070.7751372211924, 1172.1033409441784, 33448.1637959053, 33860.15349616279, 33944.830275848464, 34016.319673606886, 34186.48720269198, 1102.0467295789244, 1155.1509640414288, 1173.3839734139644, 1189.149757923089, 1228.969275768113, 17851.0, 17901.910490447466, 17932.193051312723, 17996.910015449837, 18092.366767163086, 476797.0, 479759.82161605626, 480771.0, 481049.0, 482272.0, 58980.0, 59466.405335946954, 59507.10739338913, 59512.404875950684, 59671.0, 1327.2169420042221, 1419.5954153066327, 1440.6470414748453, 1457.3369117051716, 1459.7737350710656, 33351.33297334088, 34874.82562587272, 34994.300113997066, 35155.64844351524, 35319.646803531636, 52117.73941130422, 52750.2087468696, 52827.47172528225, 52827.73586132045, 52835.20747188718, 377308.0, 380182.0, 380306.0, 380493.0, 383905.0, 43350.78324608357, 44382.77808610936, 44791.55208448004, 45079.32381014353, 45153.774231128635, 48574.514254857, 50096.49903500918, 50784.0, 51220.231696523835, 54147.0, 42033.57966420297, 42509.78745106255, 43285.0, 43294.0, 43671.56328436675, 42374.36438453364, 42878.142437151706, 43036.78481607697, 43335.0, 43429.13141737211, 42916.78541607272, 43385.0, 44623.55376446194, 44771.0, 44847.0, 37521.0, 38196.236075278895, 38238.42642360422, 38460.584473888855, 38479.80760096294, 29425.0, 29623.37409241498, 29657.70342296636, 30091.548626770178, 30215.395692085596], "value": 20953.402055930434, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.9054917369005, 415.2981461330352, 415.66123609258455, 416.96872734544917, 431.2668463611861, 18502.537436564075, 19936.655279224713, 20141.496462588424, 20589.176432942702, 20674.48313792152, 18622.627547449043, 18756.531086722804, 19391.4182574523, 19411.0, 19419.0, 4991.725455099968, 5320.122179840322, 5320.893582128355, 5373.596980226479, 5386.407495175527, 3977.781222032787, 5279.63042587019, 5366.9463305367035, 5599.41206173352, 5853.092770620539, 5931.525477961774, 5947.791827286046, 5949.167116603679, 5958.13607026983, 5968.67172305523, 5735.770569177228, 5829.329627092875, 5849.7660093596205, 5860.355360910296, 5867.882642347172, 3801.0877389426614, 3963.0488682716227, 3967.5834037425943, 5670.291213598301, 5678.801241956553, 21356.786432135792, 22290.665640015413, 22798.430039249153, 23919.402014949592, 23998.640020399533, 2487.987560062188, 2551.8341307815117, 2622.5279449699046, 2792.686435381309, 3003.174127115039, 10328.535215915303, 10581.047705706447, 10801.713891912912, 12344.5062197512, 14780.852191478056, 1891.2529550827483, 1909.76127984002, 1920.6484684225975, 2026.1490174126902, 2064.4838790302424, 71971.64014179948, 76077.0, 77757.22242777556, 88158.55920720419, 90193.0, 11097.889021109686, 11176.832347514632, 11341.206115571997, 11520.251183673203, 11683.773203813476, 15894.841051589336, 15990.840091599168, 16024.679506409806, 16041.0, 16068.116253606164, 8341.20758527939, 8548.700795472128, 8628.568571571397, 8677.869831952527, 8706.477611343213, 8389.0, 8452.239298463044, 8467.195616416431, 8600.956995215109, 8602.268807151337, 4817.301491283744, 4926.359573255454, 4935.580475659537, 4952.257161425815, 5015.348004759431, 1835.8046727760407, 1956.1979588368702, 2027.9797202027792, 2091.435312465626, 2131.648278034107, 916.5279880861361, 1010.7624708193568, 1064.356064580933, 1072.383379556758, 1079.0935614084208, 19578.51053723668, 19942.401727948185, 19987.800121998593, 20168.899155504423, 20221.988900554912, 1012.1902478017556, 1017.4251547875426, 1026.9127124194526, 1029.613894789454, 1031.2729525684374, 10812.189085818594, 11353.489092990836, 11370.147238957112, 11473.4263286837, 11487.483063262172, 430425.0, 434727.0, 436558.0, 457203.0, 479312.0, 90820.54589727141, 93401.0, 93458.53270733602, 94032.52983735038, 95053.0, 1034.4155552113032, 1036.2694300518267, 1076.434871692352, 1097.6542389147394, 1100.5652767156928, 17566.38517651876, 17719.20263588116, 17793.377231796825, 17999.2800287987, 18291.085445727927, 30063.398732024798, 40391.79663318574, 40864.591354087264, 41380.0, 41980.79009604932, 57776.71111644583, 57792.422075780385, 58519.4148058531, 59116.40883591109, 59619.70190149022, 9009.189172974464, 9022.097790220925, 9035.638574456949, 9116.680916167903, 9148.313876459159, 10065.949670251603, 13389.397477113747, 13735.175889446666, 13929.23389213603, 13997.650058748613, 5406.972965135149, 8928.330375222014, 10773.86874378179, 11913.16607837443, 12602.810957835456, 11698.0, 11756.647300580997, 11988.160828741904, 12012.75974480523, 12144.696382590153, 12194.451249693608, 12419.751604967669, 12469.688257793629, 12518.874811251771, 12569.1201615886, 8807.295416366547, 8965.148310910454, 9013.594388252675, 9017.549122543978, 9104.226140778108, 12082.972947299579, 12168.87831121713, 12179.695507612381, 12215.633530994084, 12262.26426414418], "value": 9346.683784866525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.8550102239271, 1546.9690606187876, 1571.6620926500805, 1746.100758109573, 1878.783939846917, 8641.438306510081, 9104.226140778033, 9121.996580376162, 9341.81316373672, 9356.906430935689, 9009.459432434058, 9206.401583897043, 9211.217046551052, 9217.585208665609, 9228.723138305844, 2061.371281759063, 2314.2363020203375, 2341.8594884306913, 2343.414146463384, 2410.529946660402, 2296.357020034393, 2303.8272129590264, 2305.7578954209816, 2306.723193216808, 2306.884655767213, 2295.7589453107435, 2332.1953925895623, 2335.1943579465055, 2335.4745182333922, 2336.2874323331375, 1986.0, 2283.2579411691186, 2344.9882750586307, 2348.283773449097, 2364.054378248697, 2337.3922780077132, 2342.7232158473503, 2348.5772560939026, 2349.5300939812105, 2367.8816059197143, 9164.8625270621, 9260.722178334661, 9316.114969077928, 9327.813443731087, 9340.953295233548, 5172.120739474299, 5328.520433160996, 5344.331958505187, 5350.866228344323, 5356.330458692663, 3317.3531161423534, 3345.933081338384, 3407.4037043517287, 3445.3109378124477, 3457.550518432613, 1079.6167360586958, 1084.4089970965842, 1106.9335839849634, 1148.3970915269551, 1164.150170375622, 12791.0, 12806.103572749911, 12835.486580536768, 12838.679033024157, 12846.35768211595, 4685.625149987993, 4705.929411058837, 4807.134715751198, 4815.22956326986, 4818.975905120452, 10726.731831704114, 10736.463176841127, 10740.946295268473, 10756.677299681021, 10762.515686794113, 4762.333273341735, 5434.3207099112615, 5434.864128396743, 5435.809746658848, 5444.40111587725, 4696.8590942271785, 4762.571368576845, 4775.617950563947, 4861.1006963711825, 4864.756762161877, 4032.677385809187, 4073.735207211522, 4126.339785634284, 4181.289180839204, 4185.142045880587, 1285.1967520299813, 1291.541502766523, 1297.48100759695, 1297.9091463597647, 1311.1280998136133, 1054.0882136951482, 1055.3773273768513, 1063.4788953412772, 1064.4943651765504, 1067.8665166854144, 6236.844078897973, 6279.0895320178315, 6491.706531944386, 6492.123563318892, 6518.608883467007, 476.19760703215195, 479.5085037836246, 483.76295615148325, 488.8728930478101, 489.3662706794709, 4406.471223453206, 4467.955320446819, 4561.475430325555, 4585.060062687141, 4672.906541869143, 11020.724481888017, 11404.600838970597, 11418.0, 11428.0, 11451.59919402817, 11050.392228427514, 11374.090072794157, 11374.601888933848, 11384.658460246206, 11397.658070257905, 7729.768106956801, 8047.396445266511, 8086.959565202254, 8115.229053239933, 8173.836523269501, 6192.102145189013, 6252.249730032243, 6277.2781130170615, 6277.780277690259, 6341.714622841891, 9736.610535578497, 9755.56099975517, 9769.413835169913, 9801.558929848317, 9843.803123937625, 10298.279120461795, 10602.89397106019, 10683.51924163399, 10684.198685098803, 10743.838842417214, 7772.261635144652, 7999.160088190656, 8015.238552337519, 8396.076431592397, 8567.0, 8093.635786389745, 8895.0, 8910.198082172636, 9142.497162656118, 9143.542822858963, 7893.684252629831, 8051.637676304697, 8158.3065439438315, 8165.0, 8336.499810011419, 7955.323797477279, 8038.075621303625, 8089.635966381409, 8183.631736571988, 8185.30424913889, 7095.858082838417, 7131.25121862197, 7341.008963790034, 7536.0, 7700.5764682940735, 5483.698396588226, 5491.862703432446, 5685.886282274414, 5702.885942281214, 5769.394213607511, 5483.232347471437, 5713.628614140068, 5726.79956201531, 5814.738336774771, 5842.123681447647], "value": 4707.762157983476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7554646097914, 337.0696876620528, 337.79225776147644, 338.13606236066846, 347.7600455685576, 5359.67841929484, 5377.7580008899595, 5391.81128660497, 5395.919061214085, 5446.836594902149, 5070.264811602316, 5084.347587034219, 5222.686638801665, 5246.501582349671, 5295.152775555912, 4139.710220284566, 4177.624013838754, 4181.142865712537, 4184.225918205127, 4189.015581338383, 4183.560726123759, 4184.958150418503, 4191.895202619944, 4206.326987681971, 4213.325867861143, 4006.5993400659845, 4089.20260549193, 4115.629593336599, 4159.667226621863, 4169.124483858378, 4102.179564087194, 4148.605882441163, 4166.770827604496, 4169.812358443877, 4170.39529268256, 3708.87018954338, 3721.3115573618966, 3726.6832319252894, 3730.123420996064, 3746.7002639788752, 5048.217526283432, 5064.366954130734, 5086.847394578169, 5113.744312784346, 5200.635955483118, 4717.834875779366, 4741.668083234175, 4768.7615619218905, 4805.495422980572, 4821.758912054418, 5494.587905907033, 5507.284053073115, 5507.5593952484105, 5532.5020748132865, 5542.224088627595, 3915.197384536163, 4060.4112403701592, 4066.1054567994993, 4072.3484242521054, 4117.814698338552, 5731.44950497029, 5732.197492351074, 5754.251947246831, 5775.8556036099435, 5815.79644712433, 4192.538820729717, 4194.748315101104, 4201.222773786859, 4204.957950420518, 4210.6841986851105, 3884.8446062157195, 4029.6373326400767, 4062.2281766464275, 4219.493660760667, 4242.53332133465, 4565.817367305271, 4630.814767409266, 4635.791389387486, 4637.281221410687, 4643.791029403685, 5504.862378440491, 5537.556995440355, 5547.334319881559, 5600.663960162403, 5606.271184745957, 1356.5387768158873, 1366.3100134432048, 1403.9649008774863, 1408.401429392504, 1414.70291238841, 949.4066208619613, 962.7352478068448, 963.6097380560884, 965.1747755668943, 973.5473005052685, 5352.277442545284, 5434.293541839615, 5444.754986025639, 5475.6440831345835, 5488.368837583649, 5496.587755918322, 5672.659640421505, 5697.6296540724725, 5705.4579814917515, 5708.771649133988, 5365.382980957162, 5385.246065550826, 5399.70301633414, 5408.728334099687, 5432.782688692408, 2904.1868276882506, 2989.925251868721, 3007.593974813416, 3050.557669138007, 3052.6568309943555, 5850.5904586678525, 5889.970550147307, 5901.3508514063415, 5929.6145750526075, 5954.523638108941, 5717.885642287131, 5733.226014488074, 5758.452946970031, 5770.0, 5776.0, 5694.572907031989, 5905.498032667186, 5964.9105263420215, 5966.820995370233, 6042.184305118841, 5684.232628595252, 5731.598788084794, 5769.18270744714, 5795.116587109291, 5855.443732845373, 5506.366767821752, 5663.5469162467725, 5692.459216374438, 5693.914591281051, 5753.798617048383, 5932.347441781314, 5973.0, 5984.401559843981, 5995.0, 6018.488428483628, 4032.1129351542613, 4038.0914294284726, 4046.2918989176187, 4075.2053349596545, 4086.816093275869, 5487.670739755627, 5688.089905615082, 5712.457316554921, 5720.542356611544, 5738.397468265772, 5584.0, 5592.496675299242, 5595.692236926845, 5607.411221821813, 5621.8594535136945, 5325.334333208349, 5369.248305237348, 5635.549156067423, 5637.701944362594, 5644.238027866186, 5470.781168753205, 5496.0, 5497.697626630574, 5545.584081194007, 5552.639078459887, 5318.574514038945, 5569.081101618188, 5621.241132447068, 5657.26455560791, 5687.459691329317, 5482.945170548243, 5486.890262194814, 5503.147012213113, 5518.972405137949, 5519.0], "value": 4261.109371274032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.7657644147861, 856.54603060378, 872.4677946452658, 879.6921077622833, 907.9546022698863, 14694.338754756034, 15503.14732689703, 15574.299156537954, 15635.84364156358, 15684.0, 14636.121832690045, 14686.118832870008, 14686.706265874676, 14695.926520367384, 14709.705805883876, 693.7051753004965, 809.0776514773163, 840.0381563110235, 842.2672275120623, 846.4709556527171, 824.11819353292, 824.9711260105897, 829.2578142562403, 831.5717405536154, 832.6003518311214, 725.5465334166146, 878.6441491196044, 878.9340799440035, 879.5734068976541, 879.8768172455862, 736.193867714854, 742.6398196874511, 846.6571038729294, 869.604330029835, 869.7303835810919, 626.6208943589154, 627.2034516164491, 627.5701144715885, 628.6259675493075, 629.1537881549309, 13845.100068495516, 13892.791608125886, 13961.371738271802, 14029.929850350785, 14078.2960851957, 12939.5471158509, 13601.0, 13923.721525569432, 14085.366158522891, 14143.858561414358, 11960.102992275528, 12020.098492613002, 12084.939575302154, 12291.385430728427, 12489.313087780169, 4399.362092496602, 4448.555144485558, 4462.9107417851465, 4486.528914463967, 4520.886977825548, 59644.701776491274, 60488.69755651238, 60582.0, 60959.39040609626, 62448.06327905085, 11251.0, 11355.829662555068, 11392.25950313227, 11529.596464123715, 11581.0, 21313.68029479559, 21395.572088558143, 21519.56960860774, 22209.888950555145, 22408.991595378247, 8774.780630484289, 8969.0, 9054.909450905538, 9177.541122943827, 9188.219001384958, 4869.245266983623, 4872.78072486739, 4967.726775027336, 5050.671706339076, 5164.431912489623, 3583.0, 3677.742558020913, 3702.6852717518773, 3705.7220708446976, 3707.8146092695256, 591.7425919724933, 655.6787174284566, 667.39934059346, 674.5918719174927, 690.1304356510833, 550.9779608815683, 638.8498702804837, 689.8309914071085, 721.6463932672953, 736.8047467421138, 10077.69766906994, 10445.84331235032, 10532.0, 10552.15582753378, 10581.947090264499, 609.7225762278152, 705.6154395854169, 745.7017193122795, 757.8484303139284, 785.0814546980047, 4682.882927926761, 4694.755974553836, 4993.825216117419, 5002.52476014778, 5048.798048078036, 71964.0, 73133.0, 74723.62638186883, 74835.0, 74875.0, 67114.66442667755, 69289.0, 70147.64926175438, 70388.64805675938, 70498.0, 61880.0, 62090.37909620936, 62093.689531552955, 62270.688646556475, 62544.06183907245, 9513.571889265138, 9603.855942160733, 9607.327487075838, 9741.172000380047, 9816.26378021637, 39791.60208397879, 40128.59871401366, 41144.588554114074, 41263.0, 41428.378574322014, 50959.49040509547, 56316.71841640765, 56855.147172793266, 57170.14244786415, 57407.7129614366, 12603.369831508571, 12796.296203708513, 12916.547920822726, 12924.1305851842, 13269.734605307647, 13443.260620665566, 13684.794728079285, 13775.104618199784, 14107.929460353043, 14301.57095287143, 13087.0, 13570.185788852701, 13672.589822305346, 13911.930440347733, 14012.509562165274, 12276.0, 12862.614121576367, 12887.742245155232, 12895.355232238539, 13393.397297121848, 12829.166104203197, 13125.409356579168, 13159.934200328937, 13163.934180329037, 13163.934180329037, 10781.676549703521, 10853.837192442277, 10940.56237750481, 10985.725356866142, 11384.715382115513, 11191.944040279746, 11211.327320360804, 11466.426678666201, 11498.885011150116, 11519.942400287944], "value": 7235.483775306817, "unit": "score"}], "name": "dromaeo_css", "value": 7301.016265635259, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 114.0, 112.0, 111.0, 110.0, 110.0, 112.0, 110.0, 109.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 152.0, 220.0, 125.0, 159.0, 148.0, 124.0, 183.0, 131.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 160.0, 159.0, 161.0, 162.0, 161.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 160.0, 75.0, 74.0, 75.0, 76.0, 129.0, 75.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 144.0, 91.0, 92.0, 93.0, 122.0, 92.0, 91.0, 124.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 53.0, 54.0, 54.0, 54.0, 123.0, 52.0, 52.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 81.0, 78.0, 78.0, 79.0, 79.0, 80.0, 82.0, 83.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 121.0, 127.0, 128.0, 118.0, 120.0, 122.0, 118.0, 195.0, 123.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 164.0, 161.0, 162.0, 166.0, 165.0, 165.0, 157.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 63.0, 63.0, 62.0, 61.0, 62.0, 61.0, 63.0, 64.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1527.4, "alertThreshold": 2.0}]} 01:33:57 INFO - Return code: 0 01:33:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:33:57 ERROR - # TBPL SUCCESS # 01:33:57 INFO - Running post-action listener: _resource_record_post_action 01:33:57 INFO - ##### 01:33:57 INFO - ##### Finished run-tests step (success) 01:33:57 INFO - ##### 01:33:57 INFO - Running post-run listener: _resource_record_post_run 01:33:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535949312; Read time: 12; Write time: 473692 01:33:57 INFO - TinderboxPrint: CPU usage
13.1% 01:33:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:33:57 INFO - TinderboxPrint: I/O write bytes / time
535,949,312 / 473,692 01:33:57 INFO - TinderboxPrint: CPU idle
8,281.6 (86.9%) 01:33:57 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 01:33:57 INFO - TinderboxPrint: Swap in / out
0 / 0 01:33:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 140881920; Read time: 0; Write time: 160084 01:33:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289308672; Read time: 12; Write time: 246524 01:33:58 INFO - Running post-run listener: _upload_blobber_files 01:33:58 INFO - Blob upload gear active. 01:33:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:33:58 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 01:33:58 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:33:58 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:33:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:59 INFO - (blobuploader) - INFO - Done attempting. 01:33:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:33:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:03 INFO - (blobuploader) - INFO - Done attempting. 01:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:34:03 INFO - (blobuploader) - INFO - Done attempting. 01:34:03 INFO - (blobuploader) - INFO - Iteration through files over. 01:34:03 INFO - Return code: 0 01:34:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:34:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:34:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c923a22181e513da5c65ca330e84072b1b39d2693507fa6067ca6c460320c48921ed2e13e51adcba7af0075ce4aa789411bf6b0a0cd621730ca21458e9d5f9b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92f94e23642ae599cf49c3fb0b0bcbd267b3268512e290d88f08475ca3f5706c6b59aab434d2e805e3df67892303995adaf674186b71afa36b8b34829ca3e0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49f9bbe0b82b8278a047f740e9c68eea23bb5dee1a4cc4c05ac6ba0e75020ff026b5f31632e2ae0b87b022aa73c4279a651ff9f5fd07ffb4185c4ef73138da1d"} 01:34:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:34:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:34:03 INFO - Contents: 01:34:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c923a22181e513da5c65ca330e84072b1b39d2693507fa6067ca6c460320c48921ed2e13e51adcba7af0075ce4aa789411bf6b0a0cd621730ca21458e9d5f9b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92f94e23642ae599cf49c3fb0b0bcbd267b3268512e290d88f08475ca3f5706c6b59aab434d2e805e3df67892303995adaf674186b71afa36b8b34829ca3e0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49f9bbe0b82b8278a047f740e9c68eea23bb5dee1a4cc4c05ac6ba0e75020ff026b5f31632e2ae0b87b022aa73c4279a651ff9f5fd07ffb4185c4ef73138da1d"} 01:34:03 INFO - Running post-run listener: copy_logs_to_upload_dir 01:34:03 INFO - Copying logs to upload dir... 01:34:03 INFO - mkdir: /builds/slave/test/build/upload/logs 01:34:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.530535 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-18 01:34:03.530870) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 01:34:03.535113) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c923a22181e513da5c65ca330e84072b1b39d2693507fa6067ca6c460320c48921ed2e13e51adcba7af0075ce4aa789411bf6b0a0cd621730ca21458e9d5f9b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92f94e23642ae599cf49c3fb0b0bcbd267b3268512e290d88f08475ca3f5706c6b59aab434d2e805e3df67892303995adaf674186b71afa36b8b34829ca3e0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49f9bbe0b82b8278a047f740e9c68eea23bb5dee1a4cc4c05ac6ba0e75020ff026b5f31632e2ae0b87b022aa73c4279a651ff9f5fd07ffb4185c4ef73138da1d"} build_url:https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/I-SEj3maTjqcBtwSei5wSw/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/Mozilla-Inbound/sha512/c923a22181e513da5c65ca330e84072b1b39d2693507fa6067ca6c460320c48921ed2e13e51adcba7af0075ce4aa789411bf6b0a0cd621730ca21458e9d5f9b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/92f94e23642ae599cf49c3fb0b0bcbd267b3268512e290d88f08475ca3f5706c6b59aab434d2e805e3df67892303995adaf674186b71afa36b8b34829ca3e0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49f9bbe0b82b8278a047f740e9c68eea23bb5dee1a4cc4c05ac6ba0e75020ff026b5f31632e2ae0b87b022aa73c4279a651ff9f5fd07ffb4185c4ef73138da1d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 01:34:03.567947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:34:03.568717) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1463558453.230653-1323431377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 01:34:03.803821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 01:34:03.804357) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 01:34:03.804855) ========= ========= Total master_lag: 0.35 =========