builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1464347448.86 results: success (0) buildid: 20160527013054 builduid: 6172d09855b441acb7883a933ffc6707 revision: 59ce575d21f13a723f0c7610b13fd597f36736d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:48.857477) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:48.858049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:48.858384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:48.882159) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:48.882473) ========= 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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 04:10:49-- 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% 224M=0s 2016-05-27 04:10:49 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115478 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.012332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.012713) ========= 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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015513 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.062656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.063071) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 59ce575d21f13a723f0c7610b13fd597f36736d2 --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 59ce575d21f13a723f0c7610b13fd597f36736d2 --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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 04:10:49,772 truncating revision to first 12 chars 2016-05-27 04:10:49,772 Setting DEBUG logging. 2016-05-27 04:10:49,772 attempt 1/10 2016-05-27 04:10:49,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/59ce575d21f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 04:10:50,126 unpacking tar archive at: mozilla-inbound-59ce575d21f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.708892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.789531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.790334) ========= script_repo_revision: 59ce575d21f13a723f0c7610b13fd597f36736d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.791367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.791976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 04:10:49.803147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-27 04:10:49.803920) ========= /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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:50 INFO - MultiFileLogger online at 20160527 04:10:50 in /builds/slave/test 04:10:50 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 04:10:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:50 INFO - {'append_to_log': False, 04:10:50 INFO - 'base_work_dir': '/builds/slave/test', 04:10:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:10:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:50 INFO - 'branch': 'Mozilla-Inbound', 04:10:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:50 INFO - 'config_files': ('talos/linux_config.py',), 04:10:50 INFO - 'default_actions': ('clobber', 04:10:50 INFO - 'read-buildbot-config', 04:10:50 INFO - 'download-and-extract', 04:10:50 INFO - 'populate-webroot', 04:10:50 INFO - 'create-virtualenv', 04:10:50 INFO - 'install', 04:10:50 INFO - 'run-tests'), 04:10:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:50 INFO - 'download_minidump_stackwalk': True, 04:10:50 INFO - 'download_symbols': 'ondemand', 04:10:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:50 INFO - 'installer_path': 'installer.exe', 04:10:50 INFO - 'log_level': 'info', 04:10:50 INFO - 'log_name': 'talos', 04:10:50 INFO - 'log_to_console': True, 04:10:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:50 INFO - 'opt_config_files': (), 04:10:50 INFO - 'pip_index': False, 04:10:50 INFO - 'sps_profile': False, 04:10:50 INFO - 'sps_profile_interval': 0, 04:10:50 INFO - 'suite': 'dromaeojs', 04:10:50 INFO - 'system_bits': '32', 04:10:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:50 INFO - 'title': 'talos-linux64-ix-048', 04:10:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:50 INFO - 'use_talos_json': True, 04:10:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:50 INFO - 'work_dir': 'build'} 04:10:50 INFO - ##### 04:10:50 INFO - ##### Running clobber step. 04:10:50 INFO - ##### 04:10:50 INFO - Running pre-action listener: _resource_record_pre_action 04:10:50 INFO - Running main action method: clobber 04:10:50 INFO - rmtree: /builds/slave/test/build 04:10:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:51 INFO - Running post-action listener: _resource_record_post_action 04:10:51 INFO - ##### 04:10:51 INFO - ##### Finished clobber step (success) 04:10:51 INFO - ##### 04:10:51 INFO - ##### 04:10:51 INFO - ##### Running read-buildbot-config step. 04:10:51 INFO - ##### 04:10:51 INFO - Running pre-action listener: _resource_record_pre_action 04:10:51 INFO - Running main action method: read_buildbot_config 04:10:51 INFO - Using buildbot properties: 04:10:51 INFO - { 04:10:51 INFO - "project": "", 04:10:51 INFO - "product": "firefox", 04:10:51 INFO - "script_repo_revision": "production", 04:10:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:10:51 INFO - "repository": "", 04:10:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:10:51 INFO - "buildid": "20160527013054", 04:10:51 INFO - "pgo_build": "True", 04:10:51 INFO - "basedir": "/builds/slave/test", 04:10:51 INFO - "buildnumber": 1861, 04:10:51 INFO - "slavename": "talos-linux64-ix-048", 04:10:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:10:51 INFO - "platform": "ubuntu64_hw", 04:10:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:10:51 INFO - "branch": "mozilla-inbound", 04:10:51 INFO - "repo_path": "integration/mozilla-inbound", 04:10:51 INFO - "revision": "59ce575d21f13a723f0c7610b13fd597f36736d2", 04:10:51 INFO - "stage_platform": "linux64-pgo", 04:10:51 INFO - "builduid": "6172d09855b441acb7883a933ffc6707", 04:10:51 INFO - "slavebuilddir": "test" 04:10:51 INFO - } 04:10:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:10:51 INFO - Running post-action listener: _resource_record_post_action 04:10:51 INFO - ##### 04:10:51 INFO - ##### Finished read-buildbot-config step (success) 04:10:51 INFO - ##### 04:10:51 INFO - ##### 04:10:51 INFO - ##### Running download-and-extract step. 04:10:51 INFO - ##### 04:10:51 INFO - Running pre-action listener: _resource_record_pre_action 04:10:51 INFO - Running main action method: download_and_extract 04:10:51 INFO - mkdir: /builds/slave/test/build/tests 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:51 INFO - Downloaded 1361 bytes. 04:10:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:10:51 INFO - Using the following test package requirements: 04:10:51 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:51 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:51 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:51 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'jsshell-linux-x86_64.zip'], 04:10:51 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:51 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:51 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:51 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:51 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:51 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:51 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:51 INFO - https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:53 INFO - Downloaded 24410537 bytes. 04:10:53 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'] 04:10:53 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 04:10:54 INFO - Return code: 0 04:10:54 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 04:10:54 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')]} 04:10:54 INFO - https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:56 INFO - Downloaded 24410537 bytes. 04:10:56 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'] 04:10:56 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 04:10:58 INFO - Return code: 0 04:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:58 INFO - https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:59 INFO - Downloaded 10834034 bytes. 04:10:59 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'] 04:10:59 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 04:10:59 INFO - Return code: 0 04:10:59 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')]} 04:10:59 INFO - https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRGWKEONQj-HF1MDxTkbWA/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 04:11:00 INFO - Downloaded 58688484 bytes. 04:11:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:00 INFO - mkdir: /builds/slave/test/properties 04:11:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:11:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:11:00 INFO - Contents: 04:11:00 INFO - build_url:https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:11:01 INFO - Running post-action listener: _resource_record_post_action 04:11:01 INFO - Running post-action listener: set_extra_try_arguments 04:11:01 INFO - ##### 04:11:01 INFO - ##### Finished download-and-extract step (success) 04:11:01 INFO - ##### 04:11:01 INFO - ##### 04:11:01 INFO - ##### Running populate-webroot step. 04:11:01 INFO - ##### 04:11:01 INFO - Running pre-action listener: _resource_record_pre_action 04:11:01 INFO - Running main action method: populate_webroot 04:11:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:11:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:11:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:11:01 INFO - '--tppagecycles', 04:11:01 INFO - '7'], 04:11:01 INFO - 'tests': ['tsvgm']}}, 04:11:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:11:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:11:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:11:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:11:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:11:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['damp', 'tps']}, 04:11:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'tests': ['damp', 'tps']}, 04:11:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['dromaeo_dom']}, 04:11:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:11:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['a11yr', 04:11:01 INFO - 'ts_paint', 04:11:01 INFO - 'tpaint', 04:11:01 INFO - 'sessionrestore', 04:11:01 INFO - 'sessionrestore_no_auto_restore', 04:11:01 INFO - 'tabpaint']}, 04:11:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['tsvgx', 04:11:01 INFO - 'tsvgr_opacity', 04:11:01 INFO - 'tart', 04:11:01 INFO - 'tscrollx', 04:11:01 INFO - 'cart']}, 04:11:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:11:01 INFO - 'tsvgr_opacity', 04:11:01 INFO - 'tart', 04:11:01 INFO - 'tscrollx', 04:11:01 INFO - 'cart']}, 04:11:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'talos_options': ['--disable-e10s'], 04:11:01 INFO - 'tests': ['tp5o']}, 04:11:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'tests': ['tp5o']}, 04:11:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'talos_options': ['--disable-e10s', 04:11:01 INFO - '--xperf_path', 04:11:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:01 INFO - 'tests': ['tp5n']}, 04:11:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:11:01 INFO - 'talos_options': ['--xperf_path', 04:11:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:11:01 INFO - 'tests': ['tp5n']}}, 04:11:01 INFO - 'talos.zip': {'path': '', 04:11:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:11:01 INFO - Running post-action listener: _resource_record_post_action 04:11:01 INFO - ##### 04:11:01 INFO - ##### Finished populate-webroot step (success) 04:11:01 INFO - ##### 04:11:01 INFO - ##### 04:11:01 INFO - ##### Running create-virtualenv step. 04:11:01 INFO - ##### 04:11:01 INFO - Running pre-action listener: _resource_record_pre_action 04:11:01 INFO - Running main action method: create_virtualenv 04:11:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:11:01 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 04:11:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:11:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:11:01 INFO - Using real prefix '/usr' 04:11:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:11:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:11:04 INFO - Installing pip.................done. 04:11:04 INFO - Return code: 0 04:11:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:11:04 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')]} 04:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:04 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')]} 04:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:04 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:04 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 04:11:04 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 04:11:04 INFO - Using env: {'DISPLAY': ':0', 04:11:04 INFO - 'HOME': '/home/cltbld', 04:11:04 INFO - 'LANG': 'en_US.UTF-8', 04:11:04 INFO - 'LANGUAGE': 'en_US:en', 04:11:04 INFO - 'LOGNAME': 'cltbld', 04:11:04 INFO - 'MAIL': '/var/mail/cltbld', 04:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:04 INFO - 'MOZ_NO_REMOTE': '1', 04:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:04 INFO - 'NO_EM_RESTART': '1', 04:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:04 INFO - 'PWD': '/builds/slave/test', 04:11:04 INFO - 'SHELL': '/bin/bash', 04:11:04 INFO - 'SHLVL': '1', 04:11:04 INFO - 'TERM': 'linux', 04:11:04 INFO - 'TMOUT': '86400', 04:11:04 INFO - 'USER': 'cltbld', 04:11:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:04 INFO - '_': '/tools/buildbot/bin/python'} 04:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:04 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 04:11:04 INFO - Cleaning up... 04:11:04 INFO - Return code: 0 04:11:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:11:04 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')]} 04:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:04 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')]} 04:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:04 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:04 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 04:11:04 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 04:11:04 INFO - Using env: {'DISPLAY': ':0', 04:11:04 INFO - 'HOME': '/home/cltbld', 04:11:04 INFO - 'LANG': 'en_US.UTF-8', 04:11:04 INFO - 'LANGUAGE': 'en_US:en', 04:11:04 INFO - 'LOGNAME': 'cltbld', 04:11:04 INFO - 'MAIL': '/var/mail/cltbld', 04:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:04 INFO - 'MOZ_NO_REMOTE': '1', 04:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:04 INFO - 'NO_EM_RESTART': '1', 04:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:04 INFO - 'PWD': '/builds/slave/test', 04:11:04 INFO - 'SHELL': '/bin/bash', 04:11:04 INFO - 'SHLVL': '1', 04:11:04 INFO - 'TERM': 'linux', 04:11:04 INFO - 'TMOUT': '86400', 04:11:04 INFO - 'USER': 'cltbld', 04:11:04 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:04 INFO - '_': '/tools/buildbot/bin/python'} 04:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:04 INFO - Downloading/unpacking psutil>=3.1.1 04:11:04 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 04:11:04 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 04:11:04 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 04:11:04 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 04:11:04 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 04:11:04 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 04:11:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:11:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:06 INFO - Installing collected packages: psutil 04:11:06 INFO - Running setup.py install for psutil 04:11:06 INFO - building 'psutil._psutil_linux' extension 04:11:06 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 04:11:06 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 04:11:06 INFO - building 'psutil._psutil_posix' extension 04:11:06 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 04:11:06 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 04:11:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:11:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:11:07 INFO - Successfully installed psutil 04:11:07 INFO - Cleaning up... 04:11:07 INFO - Return code: 0 04:11:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:11:07 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')]} 04:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 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')]} 04:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:07 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:07 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 04:11:07 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 04:11:07 INFO - Using env: {'DISPLAY': ':0', 04:11:07 INFO - 'HOME': '/home/cltbld', 04:11:07 INFO - 'LANG': 'en_US.UTF-8', 04:11:07 INFO - 'LANGUAGE': 'en_US:en', 04:11:07 INFO - 'LOGNAME': 'cltbld', 04:11:07 INFO - 'MAIL': '/var/mail/cltbld', 04:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:07 INFO - 'MOZ_NO_REMOTE': '1', 04:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:07 INFO - 'NO_EM_RESTART': '1', 04:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:07 INFO - 'PWD': '/builds/slave/test', 04:11:07 INFO - 'SHELL': '/bin/bash', 04:11:07 INFO - 'SHLVL': '1', 04:11:07 INFO - 'TERM': 'linux', 04:11:07 INFO - 'TMOUT': '86400', 04:11:07 INFO - 'USER': 'cltbld', 04:11:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:07 INFO - '_': '/tools/buildbot/bin/python'} 04:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:07 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 04:11:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:11:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:11:09 INFO - Installing collected packages: mozsystemmonitor 04:11:09 INFO - Running setup.py install for mozsystemmonitor 04:11:09 INFO - Successfully installed mozsystemmonitor 04:11:09 INFO - Cleaning up... 04:11:09 INFO - Return code: 0 04:11:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:09 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:09 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 04:11:09 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 04:11:09 INFO - Using env: {'DISPLAY': ':0', 04:11:09 INFO - 'HOME': '/home/cltbld', 04:11:09 INFO - 'LANG': 'en_US.UTF-8', 04:11:09 INFO - 'LANGUAGE': 'en_US:en', 04:11:09 INFO - 'LOGNAME': 'cltbld', 04:11:09 INFO - 'MAIL': '/var/mail/cltbld', 04:11:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:09 INFO - 'MOZ_NO_REMOTE': '1', 04:11:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:09 INFO - 'NO_EM_RESTART': '1', 04:11:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:09 INFO - 'PWD': '/builds/slave/test', 04:11:09 INFO - 'SHELL': '/bin/bash', 04:11:09 INFO - 'SHLVL': '1', 04:11:09 INFO - 'TERM': 'linux', 04:11:09 INFO - 'TMOUT': '86400', 04:11:09 INFO - 'USER': 'cltbld', 04:11:09 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:09 INFO - '_': '/tools/buildbot/bin/python'} 04:11:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:09 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 04:11:09 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 04:11:09 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 04:11:09 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 04:11:09 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 04:11:09 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 04:11:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:12 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 04:11:12 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 04:11:12 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 04:11:12 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 04:11:12 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 04:11:12 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 04:11:12 INFO - Downloading docopt-0.6.1.tar.gz 04:11:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:12 INFO - Running setup.py install for blobuploader 04:11:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:12 INFO - Running setup.py install for requests 04:11:12 INFO - Running setup.py install for docopt 04:11:12 INFO - Successfully installed blobuploader requests docopt 04:11:12 INFO - Cleaning up... 04:11:12 INFO - Return code: 0 04:11:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:12 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')]} 04:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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')]} 04:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:12 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:12 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 04:11:12 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 04:11:12 INFO - Using env: {'DISPLAY': ':0', 04:11:12 INFO - 'HOME': '/home/cltbld', 04:11:12 INFO - 'LANG': 'en_US.UTF-8', 04:11:12 INFO - 'LANGUAGE': 'en_US:en', 04:11:12 INFO - 'LOGNAME': 'cltbld', 04:11:12 INFO - 'MAIL': '/var/mail/cltbld', 04:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:12 INFO - 'MOZ_NO_REMOTE': '1', 04:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:12 INFO - 'NO_EM_RESTART': '1', 04:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:12 INFO - 'PWD': '/builds/slave/test', 04:11:12 INFO - 'SHELL': '/bin/bash', 04:11:12 INFO - 'SHLVL': '1', 04:11:12 INFO - 'TERM': 'linux', 04:11:12 INFO - 'TMOUT': '86400', 04:11:12 INFO - 'USER': 'cltbld', 04:11:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:12 INFO - '_': '/tools/buildbot/bin/python'} 04:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:13 INFO - Running setup.py (path:/tmp/pip-OGkU9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:13 INFO - Running setup.py (path:/tmp/pip-Wvwo_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:13 INFO - Running setup.py (path:/tmp/pip-tddaDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:13 INFO - Running setup.py (path:/tmp/pip-rv_Gu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:13 INFO - Running setup.py (path:/tmp/pip-z_e0UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:13 INFO - Running setup.py (path:/tmp/pip-tq_kBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:13 INFO - Running setup.py (path:/tmp/pip-RkQBbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:13 INFO - Running setup.py (path:/tmp/pip-NHFQQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:13 INFO - Running setup.py (path:/tmp/pip-yIn9OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:13 INFO - Running setup.py (path:/tmp/pip-aQB5WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:13 INFO - Running setup.py (path:/tmp/pip-usayqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:13 INFO - Running setup.py (path:/tmp/pip-hLKtjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:13 INFO - Running setup.py (path:/tmp/pip-Z9aLmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:14 INFO - Running setup.py (path:/tmp/pip-ZTLFOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:14 INFO - Running setup.py (path:/tmp/pip-FjwZrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:14 INFO - Running setup.py (path:/tmp/pip-goY_Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:14 INFO - Running setup.py (path:/tmp/pip-GHmBKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:14 INFO - Running setup.py install for manifestparser 04:11:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:14 INFO - Running setup.py install for mozcrash 04:11:14 INFO - Running setup.py install for mozdebug 04:11:14 INFO - Running setup.py install for mozdevice 04:11:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:14 INFO - Running setup.py install for mozfile 04:11:14 INFO - Running setup.py install for mozhttpd 04:11:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:14 INFO - Running setup.py install for mozinfo 04:11:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for mozInstall 04:11:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for mozleak 04:11:15 INFO - Running setup.py install for mozlog 04:11:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for moznetwork 04:11:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for mozprocess 04:11:15 INFO - Running setup.py install for mozprofile 04:11:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for mozrunner 04:11:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:15 INFO - Running setup.py install for mozscreenshot 04:11:15 INFO - Running setup.py install for moztest 04:11:16 INFO - Running setup.py install for mozversion 04:11:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:16 INFO - Cleaning up... 04:11:16 INFO - Return code: 0 04:11:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:16 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:16 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 04:11:16 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 04:11:16 INFO - Using env: {'DISPLAY': ':0', 04:11:16 INFO - 'HOME': '/home/cltbld', 04:11:16 INFO - 'LANG': 'en_US.UTF-8', 04:11:16 INFO - 'LANGUAGE': 'en_US:en', 04:11:16 INFO - 'LOGNAME': 'cltbld', 04:11:16 INFO - 'MAIL': '/var/mail/cltbld', 04:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:16 INFO - 'MOZ_NO_REMOTE': '1', 04:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:16 INFO - 'NO_EM_RESTART': '1', 04:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:16 INFO - 'PWD': '/builds/slave/test', 04:11:16 INFO - 'SHELL': '/bin/bash', 04:11:16 INFO - 'SHLVL': '1', 04:11:16 INFO - 'TERM': 'linux', 04:11:16 INFO - 'TMOUT': '86400', 04:11:16 INFO - 'USER': 'cltbld', 04:11:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:16 INFO - '_': '/tools/buildbot/bin/python'} 04:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:16 INFO - Running setup.py (path:/tmp/pip-5VIWDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:16 INFO - Running setup.py (path:/tmp/pip-9Itl8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:16 INFO - Running setup.py (path:/tmp/pip-uEbQmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:16 INFO - Running setup.py (path:/tmp/pip-46ALNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:16 INFO - Running setup.py (path:/tmp/pip-dgsxRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:16 INFO - Running setup.py (path:/tmp/pip-n_MEjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:16 INFO - Running setup.py (path:/tmp/pip-5airzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:16 INFO - Running setup.py (path:/tmp/pip-5WpSyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:16 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)) 04:11:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:16 INFO - Running setup.py (path:/tmp/pip-_5Gc64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:17 INFO - Running setup.py (path:/tmp/pip-UEpeIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:17 INFO - Running setup.py (path:/tmp/pip-OCMB9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:17 INFO - Running setup.py (path:/tmp/pip-EDroNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:17 INFO - Running setup.py (path:/tmp/pip-6ut2i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:17 INFO - Running setup.py (path:/tmp/pip-3K_nEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:17 INFO - Running setup.py (path:/tmp/pip-bp_evy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:17 INFO - Running setup.py (path:/tmp/pip-MHIin8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:17 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)) 04:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:17 INFO - Running setup.py (path:/tmp/pip-C4zhTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:17 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)) 04:11:17 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)) 04:11:17 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)) 04:11:17 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)) 04:11:17 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)) 04:11:17 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)) 04:11:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:17 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 04:11:17 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 04:11:17 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 04:11:17 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 04:11:17 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 04:11:17 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 04:11:19 INFO - Downloading blessings-1.6.tar.gz 04:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:19 INFO - Installing collected packages: blessings 04:11:19 INFO - Running setup.py install for blessings 04:11:19 INFO - Successfully installed blessings 04:11:19 INFO - Cleaning up... 04:11:19 INFO - Return code: 0 04:11:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:19 INFO - Reading from file tmpfile_stdout 04:11:19 INFO - Current package versions: 04:11:19 INFO - argparse == 1.2.1 04:11:19 INFO - blessings == 1.6 04:11:19 INFO - blobuploader == 1.2.4 04:11:19 INFO - docopt == 0.6.1 04:11:19 INFO - manifestparser == 1.1 04:11:19 INFO - mozInstall == 1.12 04:11:19 INFO - mozcrash == 0.17 04:11:19 INFO - mozdebug == 0.1 04:11:19 INFO - mozdevice == 0.48 04:11:19 INFO - mozfile == 1.2 04:11:19 INFO - mozhttpd == 0.7 04:11:19 INFO - mozinfo == 0.9 04:11:19 INFO - mozleak == 0.1 04:11:19 INFO - mozlog == 3.2 04:11:19 INFO - moznetwork == 0.27 04:11:19 INFO - mozprocess == 0.22 04:11:19 INFO - mozprofile == 0.28 04:11:19 INFO - mozrunner == 6.11 04:11:19 INFO - mozscreenshot == 0.1 04:11:19 INFO - mozsystemmonitor == 0.3 04:11:19 INFO - moztest == 0.7 04:11:19 INFO - mozversion == 1.4 04:11:19 INFO - psutil == 3.1.1 04:11:19 INFO - requests == 1.2.3 04:11:19 INFO - wsgiref == 0.1.2 04:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:19 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:19 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 04:11:19 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 04:11:19 INFO - Using env: {'DISPLAY': ':0', 04:11:19 INFO - 'HOME': '/home/cltbld', 04:11:19 INFO - 'LANG': 'en_US.UTF-8', 04:11:19 INFO - 'LANGUAGE': 'en_US:en', 04:11:19 INFO - 'LOGNAME': 'cltbld', 04:11:19 INFO - 'MAIL': '/var/mail/cltbld', 04:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:19 INFO - 'MOZ_NO_REMOTE': '1', 04:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:19 INFO - 'NO_EM_RESTART': '1', 04:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:19 INFO - 'PWD': '/builds/slave/test', 04:11:19 INFO - 'SHELL': '/bin/bash', 04:11:19 INFO - 'SHLVL': '1', 04:11:19 INFO - 'TERM': 'linux', 04:11:19 INFO - 'TMOUT': '86400', 04:11:19 INFO - 'USER': 'cltbld', 04:11:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:19 INFO - '_': '/tools/buildbot/bin/python'} 04:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 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)) 04:11:20 INFO - Cleaning up... 04:11:20 INFO - Return code: 0 04:11:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11: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')]} 04:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11: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')]} 04:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:20 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:20 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 04:11:20 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 04:11:20 INFO - Using env: {'DISPLAY': ':0', 04:11:20 INFO - 'HOME': '/home/cltbld', 04:11:20 INFO - 'LANG': 'en_US.UTF-8', 04:11:20 INFO - 'LANGUAGE': 'en_US:en', 04:11:20 INFO - 'LOGNAME': 'cltbld', 04:11:20 INFO - 'MAIL': '/var/mail/cltbld', 04:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:20 INFO - 'MOZ_NO_REMOTE': '1', 04:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:20 INFO - 'NO_EM_RESTART': '1', 04:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:20 INFO - 'PWD': '/builds/slave/test', 04:11:20 INFO - 'SHELL': '/bin/bash', 04:11:20 INFO - 'SHLVL': '1', 04:11:20 INFO - 'TERM': 'linux', 04:11:20 INFO - 'TMOUT': '86400', 04:11:20 INFO - 'USER': 'cltbld', 04:11:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:20 INFO - '_': '/tools/buildbot/bin/python'} 04:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:20 INFO - Downloading/unpacking jsonschema 04:11:20 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 04:11:20 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 04:11:20 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 04:11:20 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 04:11:20 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 04:11:20 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 04:11:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:11:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:11:22 INFO - warning: no files found matching '*.txt' 04:11:22 INFO - no previously-included directories found matching 'build' 04:11:22 INFO - no previously-included directories found matching 'dist' 04:11:22 INFO - no previously-included directories found matching '.git*' 04:11:22 INFO - Installing collected packages: jsonschema, functools32 04:11:22 INFO - Running setup.py install for functools32 04:11:22 INFO - warning: no files found matching '*.txt' 04:11:22 INFO - no previously-included directories found matching 'build' 04:11:22 INFO - no previously-included directories found matching 'dist' 04:11:22 INFO - no previously-included directories found matching '.git*' 04:11:22 INFO - Successfully installed jsonschema functools32 04:11:22 INFO - Cleaning up... 04:11:22 INFO - Return code: 0 04:11:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:22 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 0x7f7475367f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f84770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, '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': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', '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 04:11:22 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 04:11:22 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 04:11:22 INFO - Using env: {'DISPLAY': ':0', 04:11:22 INFO - 'HOME': '/home/cltbld', 04:11:22 INFO - 'LANG': 'en_US.UTF-8', 04:11:22 INFO - 'LANGUAGE': 'en_US:en', 04:11:22 INFO - 'LOGNAME': 'cltbld', 04:11:22 INFO - 'MAIL': '/var/mail/cltbld', 04:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:22 INFO - 'MOZ_NO_REMOTE': '1', 04:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:22 INFO - 'NO_EM_RESTART': '1', 04:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:22 INFO - 'PWD': '/builds/slave/test', 04:11:22 INFO - 'SHELL': '/bin/bash', 04:11:22 INFO - 'SHLVL': '1', 04:11:22 INFO - 'TERM': 'linux', 04:11:22 INFO - 'TMOUT': '86400', 04:11:22 INFO - 'USER': 'cltbld', 04:11:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:22 INFO - '_': '/tools/buildbot/bin/python'} 04:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:22 INFO - Downloading/unpacking flake8 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:22 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 04:11:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:11:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:11:24 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 04:11:24 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 04:11:24 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 04:11:24 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 04:11:24 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 04:11:24 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 04:11:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:11:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 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 04:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:25 INFO - no previously-included directories found matching 'docs/_build' 04:11:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:11:25 INFO - Running setup.py install for pep8 04:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:11:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:11:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:11:25 INFO - no previously-included directories found matching 'docs/_build' 04:11:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:11:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:11:25 INFO - Cleaning up... 04:11:25 INFO - Return code: 0 04:11:25 INFO - Running post-action listener: _resource_record_post_action 04:11:25 INFO - Running post-action listener: _start_resource_monitoring 04:11:25 INFO - Starting resource monitoring. 04:11:25 INFO - ##### 04:11:25 INFO - ##### Finished create-virtualenv step (success) 04:11:25 INFO - ##### 04:11:25 INFO - ##### 04:11:25 INFO - ##### Running install step. 04:11:25 INFO - ##### 04:11:25 INFO - Running pre-action listener: _resource_record_pre_action 04:11:25 INFO - Running main action method: install 04:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:26 INFO - Reading from file tmpfile_stdout 04:11:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:26 INFO - Reading from file tmpfile_stdout 04:11:26 INFO - Output received: 04:11:26 INFO - Usage: mozinstall [options] installer 04:11:26 INFO - Options: 04:11:26 INFO - -h, --help show this help message and exit 04:11:26 INFO - -d DEST, --destination=DEST 04:11:26 INFO - Directory to install application into. [default: 04:11:26 INFO - "/builds/slave/test"] 04:11:26 INFO - --app=APP Application being installed. [default: firefox] 04:11:26 INFO - mkdir: /builds/slave/test/build/application 04:11:26 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'] 04:11:26 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 04:11:42 INFO - Reading from file tmpfile_stdout 04:11:42 INFO - Output received: 04:11:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:42 INFO - Running post-action listener: _resource_record_post_action 04:11:42 INFO - ##### 04:11:42 INFO - ##### Finished install step (success) 04:11:42 INFO - ##### 04:11:42 INFO - ##### 04:11:42 INFO - ##### Running run-tests step. 04:11:42 INFO - ##### 04:11:42 INFO - Running pre-action listener: _resource_record_pre_action 04:11:42 INFO - Running main action method: run_tests 04:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:42 INFO - Python 2.7.3 04:11:42 INFO - Return code: 0 04:11:42 INFO - grabbing minidump binary from tooltool 04:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:11:42 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 0x20139c0>, '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 0x20148c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2014d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:42 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 04:11:42 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 04:11:42 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 04:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:42 INFO - Return code: 0 04:11:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:11:43 INFO - Return code: 0 04:11:43 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/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 04:11:43 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/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 04:11:43 INFO - Using env: {'DISPLAY': ':0', 04:11:43 INFO - 'HOME': '/home/cltbld', 04:11:43 INFO - 'LANG': 'en_US.UTF-8', 04:11:43 INFO - 'LANGUAGE': 'en_US:en', 04:11:43 INFO - 'LOGNAME': 'cltbld', 04:11:43 INFO - 'MAIL': '/var/mail/cltbld', 04:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:43 INFO - 'MOZ_NO_REMOTE': '1', 04:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:43 INFO - 'NO_EM_RESTART': '1', 04:11:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:43 INFO - 'PWD': '/builds/slave/test', 04:11:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:43 INFO - 'SHELL': '/bin/bash', 04:11:43 INFO - 'SHLVL': '1', 04:11:43 INFO - 'TERM': 'linux', 04:11:43 INFO - 'TMOUT': '86400', 04:11:43 INFO - 'USER': 'cltbld', 04:11:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737', 04:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:43 INFO - '_': '/tools/buildbot/bin/python'} 04:11:43 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/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 04:11:44 INFO - mozversion application_buildid: 20160527013054 04:11:44 INFO - mozversion application_changeset: 59ce575d21f13a723f0c7610b13fd597f36736d2 04:11:44 INFO - mozversion application_display_name: Nightly 04:11:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:44 INFO - mozversion application_name: Firefox 04:11:44 INFO - mozversion application_remotingname: firefox 04:11:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:11:44 INFO - mozversion application_vendor: Mozilla 04:11:44 INFO - mozversion application_version: 49.0a1 04:11:44 INFO - mozversion platform_buildid: 20160527013054 04:11:44 INFO - mozversion platform_changeset: 59ce575d21f13a723f0c7610b13fd597f36736d2 04:11:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:11:44 INFO - mozversion platform_version: 49.0a1 04:11:44 INFO - using testdate: 1464347504 04:11:44 INFO - actual date: 1464347504 04:11:44 INFO - starting webserver on 'localhost:53629' 04:11:44 INFO - SUITE-START | Running 2 tests 04:11:44 INFO - TEST-START | dromaeo_css 04:11:44 INFO - operating with platform_type : linux_ 04:11:44 INFO - Initialising browser for dromaeo_css test... 04:11:44 INFO - TEST-INFO | started process 2236 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdp4k35/profile http://localhost:53629/getInfo.html) 04:11:48 INFO - PROCESS | 2236 | __metrics Screen width/height:1600/1200 04:11:48 INFO - PROCESS | 2236 | colorDepth:24 04:11:48 INFO - PROCESS | 2236 | Browser inner width/height: 1024/697 04:11:48 INFO - PROCESS | 2236 | __metrics 04:11:49 ERROR - PROCESS | 2236 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:11:50 INFO - TEST-INFO | 2236: exit 0 04:11:50 INFO - Browser initialized. 04:11:50 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:50 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdp4k35/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:02 INFO - PROCESS | 2316 | RSS: Main: 155742208 04:12:02 INFO - PROCESS | 2316 | 04:12:53 INFO - PROCESS | 2316 | 1464347573093 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] 04:15:01 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53629/tests/dromaeo/cssquery-ext.html) 04:15:02 INFO - PROCESS | 2316 | RSS: Main: 246829056 04:15:02 INFO - PROCESS | 2316 | 04:18:04 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-ext.html (next: http://localhost:53629/tests/dromaeo/cssquery-jquery.html) 04:18:05 INFO - PROCESS | 2316 | RSS: Main: 246906880 04:18:05 INFO - PROCESS | 2316 | 04:21:07 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53629/tests/dromaeo/cssquery-mootools.html) 04:21:07 INFO - PROCESS | 2316 | RSS: Main: 257323008 04:21:07 INFO - PROCESS | 2316 | 04:24:09 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53629/tests/dromaeo/cssquery-prototype.html) 04:24:10 INFO - PROCESS | 2316 | RSS: Main: 240836608 04:24:10 INFO - PROCESS | 2316 | 04:27:12 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53629/tests/dromaeo/cssquery-yui.html) 04:27:13 INFO - PROCESS | 2316 | RSS: Main: 233611264 04:27:13 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | Cycle 1(1): loaded http://localhost:53629/tests/dromaeo/cssquery-yui.html (next: http://localhost:53629/tests/dromaeo/cssquery-dojo.html) 04:30:16 INFO - PROCESS | 2316 | RSS: Main: 273469440 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | __start_tp_report 04:30:16 INFO - PROCESS | 2316 | _x_x_mozilla_page_load 04:30:16 INFO - PROCESS | 2316 | _x_x_mozilla_page_load_details 04:30:16 INFO - PROCESS | 2316 | |i|pagename|runs| 04:30:16 INFO - PROCESS | 2316 | |0;dojo.html;3121.578586890769;3131.3580715953226;3141.874325026999;3163.161762133034;3176.428242916274;5323.60072994526;5351.49160829721;5407.080796264635;5425.647332923357;5467.425920278373;5403.378611459683;5440.102383106782;5451.3458384993755;5524.475174858392;5564.387917329091;4870.780814863331;4916.090523253191;4939.753012349386;4962.627802914778;5046.217836235371;4955.628327875405;5023.0707319145895;5045.596352291826;5055.368078990126;5061.746912654371;4760.738159401231;4771.880702982401;4870.318155458239;4873.488283730228;4979.153543897528;4844.63665225106;4855.562999330042;4869.683470574401;4896.46138924718;4945.802167913279;4900.338454308659;4907.754612269372;4918.950810491885;4921.532454416824;4928.827491037832;5277.947220527784;5299.814506492293;5364.9731751341;5426.9185962210595;5450.482204190595;5792.304923409176;5809.223775247756;5828.1549175369755;5842.737076831553;5847.532197424196;5656.717164141817;5840.065589505659;5870.589058765888;5884.382139875294;5884.911291411103;5411.512963833235;5471.562275017989;5485.6982865942355;5547.11246200606;5552.833414997556;6035.551061277484;6071.908921366183;6083.148359229712;6085.482733967662;6087.573869829158;5580.665160090408;5604.747786349624;5836.037053886146;5843.29880414353;5847.766089356378;5721.685307308138;5757.13642953552;5758.568107391962;5759.539236861041;5811.709414529257;5682.062459694104;5723.742431590588;5734.627249228787;5736.483716465538;5738.885222295531;5642.266505354278;5742;5744.913826292609;5748.856278593069;5805.912911306334;4423.977880110579;4434.84478043267;4473.105378924228;4476.216662084123;4478.261086920622;3919.7452165609143;3937.3109705801944;3945.9013524662114;3955.7033222507853;3993.121513267077;5403.13549832025;5465.07093794056;5576.470235327637;5581.190727344512;5593.692346920959;5747.109198074305;5787.826365209051;5815.621984570989;5897.0269905465975;5899.380565040695;5540.7783688652;5551.555875529948;5559.694216818033;5561.610687251934;5563.221149039137;4843.2250839865455;5011.223260394571;5035.546800787946;5052.9747351263;5099.311592934981;6093.786717464867;6094.421030002142;6095.969520152371;6101.7559297627595;6131.540134489931;5892.705364731832;5908.3500814911185;5910.290765108214;5912.083627037816;5921.289445266596;5788.479036886701;5997.190379298739;6075.30134034574;6077.726502307319;6085.421884920926;5763.279590051244;5793.739281732248;5807.767689292381;5809.099589563624;5813.94186058134;5903.498202652822;5912.142739302691;5913.793017244548;5916.994111001226;5918.674472904032;5494.5054945055135;5580.86047848807;5602.327720673546;5626.2967129108865;5656.60403771732;5633.4084921082695;5639.238702775237;5654.15187721845;5656.37779844225;5660.207570940154;5456.181572764117;5553.639013464273;5557.277553917965;5560.694161821139;5568.415316391721;5706.058500347563;5783.768649253982;5793.275840519935;5866.560007999332;5868;5651.745671444877;5674.4892959633835;5678.5457163426;5684.8294551163535;5731.828045158652 04:30:16 INFO - PROCESS | 2316 | |1;ext.html;623.5416968528131;633.085191897708;639.335091504835;645.2579533536435;646.9644169570674;43086.78456607716;45192.54807451928;45316.77341613291;49016.50983490164;49092;46073.539264607345;46673.066538669205;46721.53278467214;46721.76639116808;46785.29822052672;8807.735767926957;9007.1443212895;9009.864852027225;9013.639454421815;9015.098490150998;8847.292216622654;8932.866007009867;8939.687110951118;8942.73171804847;8943;8878.334124940622;8934.329925255599;8944.731658050236;8984.685536006242;8987.550622468883;8909.910900890973;8937.419067760575;8952.104789521061;8957.149070838292;8962.551872406419;8857.778555536099;8944.329175311877;8956.596953137125;8959.68641097565;8963.14850089247;42999.78500107479;43225.56774432247;43332.56667433317;43462.13075738499;43485.34771978423;3475.669811367916;3484.198634314122;3539.185987222953;3552.182997910495;3731.9626803731885;32757.6724232757;33161.336773264644;33486.832565837256;33720.66279337224;34057.48913766295;4229.851955181584;4329.7618630975285;4391.055922976543;4443.622292105175;4476.082403107388;346687;346708;351141;351819;352138.99999999744;60039.69980150071;61019;61021.38978610157;61036.38963610396;61062.389376106556;65379.67310163514;65434.672826635564;65469.672651636436;65491.345086549474;65506;16578.17109144538;16755.41356052532;16849.831501684825;16872.746908796376;16874.915625421796;12507.124501285005;12652.746945061048;12658.113932024855;12668.239905605693;12671.17637353569;16434.76489500219;18448;18737.25050997972;18900;19089.331873384366;5158.3552055993005;5793.362730099686;5807.702300297749;5862.091375836752;5886.205362276038;941.2375975459762;1012.9139023182964;1078.9298695584762;1132.1848269246295;1181.4565299962114;33283;33685.32629347399;33735.66264337374;33803.83098084494;33977.66022339794;1131.8698349689726;1132.6318946342471;1145.4043897173424;1150.068444559909;1217.3365515793914;17107.401240956508;17671.73492397615;17751.289948402176;17887.463376098738;18039.909800450914;482751;487209;488370;737199;742186;60909.390906090375;61997.380026200066;62103.68948155321;62110.068348974804;62249.37750622526;1251.0617037222084;1285.5243559882904;1296.5462088268841;1347.968803865044;1348.1237195822794;31380.686193137775;35446.46830297599;36043.459348109274;36217.275654486235;36700;56737.177339926566;57496;57660.42339576551;57728.42271577231;58060.41939580719;499110;501476;501702;502028;502187;22761.31716048521;28251;28255.434891301647;28267.2933176664;28660.14019579416;48965.755171223915;49055;49676.50323496863;49901.50098498969;50447.24329134992;41234.38148427716;41662;42398.788006059774;43015.139697206505;43897.34153987629;41113.1777364457;41879;41962;42047.36928946007;42230.577694222666;42798;42940.570594294906;43633;43892.56107439013;43984.34023489714;34627.48058779171;37262.62737372592;37780.62219377771;38527.42208866813;38697;28000.29999250035;28475;28760.424791503636;28820.711792881804;28915.277118072216 04:30:16 INFO - PROCESS | 2316 | |2;jquery.html;379.747467933824;386.8568629607046;388.4619801574819;403.41101991093;405.98782036538915;17809;19714.507137321572;19977.200911963504;19977.700334494977;19989.400317990447;17574.94550326978;17655.91172044138;17954.10229488527;18668.25326986919;19006.809931900676;5563.388027316992;5617.38208797032;5754.424557544233;5768.740406681688;5798.623089499169;5616.719164041802;5634.915476267839;5650.237217975562;5656;5667.744951477172;5244.370675518924;5526.06056970316;5618.915716264239;5649;5674.574406919498;5339.199120131972;5458.836234912959;5502.394736578973;5537.418571050022;5541.251930989325;5513.50378465936;5543.334799824007;5545.861353466155;5545.861353466155;5547.916781248285;13217;13434.93282533581;13629.386677599532;13778.862211377858;13788.517401890886;2405.5549723301247;2410.20463247128;2423.866687332196;2669.225924481898;2934.8532573371244;9597.856032159523;10056.34633748804;10105.646302379455;10250.899640143927;10261.897381026169;1931.0537836460032;1942.5046613113707;1972.3885595465451;1974.4076776966997;2024.6558085125564;75695.24304756937;81853.59073204655;86259;87594;87675;10533.683989480327;10562.894371056345;10828.187885908588;10905.672829815117;11298.943505282585;15294;15351.61620959485;15384.84615153834;15392.92303538475;15405.768913466307;7439.293267139613;7844.921550784533;7872.134065252818;7965.800854978672;8087.312578430781;7445.585338785613;7506.437017223621;7667.194944530744;7671.884921726179;7680.846383072419;4592.402987611589;4609.446866376056;4624.075184963021;4669.322948172496;4681.485036645966;1859.907004649762;1895.450319407384;1921.9903900480408;1941.3205378117545;1974.338596570165;913.7441516375426;957.7749228931195;966.3766870368573;967.9274054445804;1006.2855372685475;16338.264778085015;18859.339923102627;18897.622047558973;19072.2371105157;19572.3149689763;955.507913424587;978.9363691360039;981.6564202529057;1026.9332493387906;1045.2474218562622;10401;10638.680839574825;10642.68071957827;10661.466926653637;10715.142788576895;364364;366957;509871;511087;515327;93742;100141;103553.48223258986;104930.16390663237;105787;1032.7779527401494;1043.5982146873357;1062.134360496193;1071.8552995345685;1079.3092420850662;15960.122193279482;17150.7994440388;17244;17291.740623890902;17893.910530447265;42141.78929105458;43515.56484435115;43596.34605480857;43604.12791744211;43988.78005609952;54700.45299546954;55079;60217.698911506915;60331;61068;8385.496870187808;8503.574821258788;8692.434991725517;8722.869156962777;8758.12418758119;8152.714654987047;9603.135717785433;10943.945280273547;13215.074944753775;13304.401301941629;5844.557517709337;8636.136386361313;11669.941650291694;11968.640940771791;12008.519659213884;11598.07215422781;11722.472488737856;11848.52605895789;11877.881221187678;12178.208416452902;12023.699407514881;12205.084618653458;12205.511779528719;12291;12310.322932238454;8663.090375510732;8706.651733930572;8708.78228044304;8833.602487888189;8939.955300223717;9171.77070573241;11787.292762434281;11931.880681193077;12109.939450302692;12204.389780511117 04:30:16 INFO - PROCESS | 2316 | |3;mootools.html;1321.0554453565699;1440.4094321328255;1469.1258701072861;1590.3718031377607;1751.6234009687914;8101.10887802342;8401.91598084019;8409.747707568775;8692.652293908237;8693.174148455886;8391.580420978942;8624;8632.697855575056;8633.266172375355;8638;1998.9700154497693;2293.334932869466;2340.3564019894493;2353.223436266028;2361.409647588103;2361.055577768898;2385.985955968715;2387.761223877607;2398.8440751351195;2399.7240317363467;2310.06442390832;2357.917472888449;2358.398608354867;2359.1153317505937;2372.2764556810166;2022.423609271358;2179.3244094330807;2240.88795560223;2242.7757224277607;2260.9095636174534;2213.645816669325;2229.2532001779423;2233.7654546272734;2235.3740952533153;2245.36007237938;8665.826683466295;8719.476831390073;8723.302135829119;8727;8733.519656418894;5089.872753181163;5242.344706911636;5254.106801843695;5256.395514515842;5283.682979021271;3229.8869539566003;3348.9665103349143;3400.353932752769;3414.351273258098;3433.9828300858585;1105.3699391346936;1124.612008856943;1149.5804031528432;1150.6202953025481;1152.7463957929326;11804.05567554585;11836.349000804952;11837.467313970892;11838.934495895412;11846.703832404173;4472.955270447319;4586.4266966629175;4624.791884365211;4655.837045703384;4748.240281554935;9951.900480995097;9964.20286377088;9965.80068398628;9980.650677226262;9995.400275983464;4766.904661906812;5078.289039534468;5081.898362032739;5085.567726743268;5090.0583392072585;4618.1918164321105;4721.5750582447745;4726.054789042205;4787.736674482937;4789.090072886141;3880.2821478026653;3960.554397644839;4018.778967156776;4048.574899635496;4069.5320038195396;1265.9556915507912;1271.7965125579863;1275.05645822091;1299.7465494228534;1317.7957416600443;911.2436677557612;993.3692105513052;1014.4572653630272;1016.1362841584742;1028.311031608824;6114.847128821726;6137.785177518855;6172;6391.424771770563;6470.676466176672;969.4667932637021;979.864433811805;1016.2225897188508;1022.2333250062453;1040.2302296300684;4234.55537168599;4371.322445020964;4432.047109871329;4454.420925279693;4499.235130027903;10507.422091785025;10790.298630588986;10876.564937402574;10880.075193608633;10881.945590271998;10044.648437304659;10505.684829454976;10683.73290667724;10755.677329680122;10791.83812242817;7961.323287520509;8044.959775201203;8115.75652730419;8166.550839703873;8173.79565510867;5991.64050156992;6166.907496387468;6329.936700632935;6366.267879193952;6457.5479716419395;9493.145616894513;9702.126808587262;9741.561629726537;9751.024897510193;10025.548850301608;9957.203423726229;10055.044770746767;10133.189344852246;10158.593656253666;10179.949100254747;6803.625800581016;7500.13748418917;7620.504667196615;7698.307152356315;7941.642626081955;8469.915300847159;8485.193906579112;8507.106753790762;8537;8559.786005349915;7540.132884718328;7582.582957937367;7758.495697779852;7819.257170568787;7821.765347039371;7388.556686598821;7466.813329666802;7477;7555.659995300334;7693.307602315818;7104.502684812013;7135.215126336203;7166.964165179141;7176.390006849476;7179.784606461814;5135.281060651587;5171.715555644325;5307.6284660073425;5342.9198562022375;5391.975524650304;4898.387701537308;4940.357753492023;5045.798168073383;5132.024915266087;5391.379991301051 04:30:16 INFO - PROCESS | 2316 | |4;prototype.html;313.49683757569085;325.4759836662973;329.58472324870655;330.39319767038074;331.09445666103204;4947.8268260610885;5317.46825317468;5317.707526086064;5354.598405119617;5370.758315875785;5294.52349288564;5303.151495760679;5319.601029922762;5340.198970154479;5346.27825243592;4061.7969101544954;4115.074108325625;4115.950432639673;4116.176764647068;4127.236461254663;3869.187470631171;4103.79481025949;4121.670266378697;4126.711130220886;4143.337066069429;3975.264576053425;3993.680505559563;4013.016810881338;4052.3516237402023;4066.430699702044;3996.980769903656;4013.3979903014488;4020.8592699255532;4024.718269721135;4052.49343832021;3536.6463353664685;3541.486484459739;3544.805035723034;3545.1137215696076;3550.467429885512;4858.319835223072;5098.898022039539;5116.258142569344;5129.256257842592;5186.766595503173;4603.194440972817;4606.930896036562;4622.583967442913;4623.32961720552;4654.371659825948;5506.394296627408;5511.173324001432;5514.200440936042;5523.751431185607;5588.273524441796;3760.755550889211;3816.664167541366;3840.3471409860113;3841;3842.634949679776;5407.486288802596;5577.888442231133;5687.061634830248;5698.971505142447;5722.942770572283;3861.691064714816;3935.763854168759;3940.310445671996;3942.8225729842225;3943.526776786804;3776.0937375030344;3844.308024555551;3934.2885844657667;3950.4469374287623;3992.341263691458;4543.7728113594185;4545.727256364628;4563.338315944169;4578.771061446914;4605.608523275492;5555.722213889289;5571.554275657938;5572.414896435897;5590.217369568264;5620.718964051781;1353.817234673326;1373.505538006317;1376.9311534423439;1378.910370825893;1385.0858433433884;859.4070091636751;874.8250349930039;878.3368556739621;883.4142713828693;888.7422647432302;4779.2519301401135;4789.568938795525;4808.735519546459;4830.203016502238;4832.526079545702;4994.300797888299;5027.396712394463;5038.874028149252;5040.36995375578;5088.62607096082;4472.137831787659;4812.975935120302;4828.623842205025;4837.9032419351415;4852.2479015752615;2702.4054707964215;2706.539888218968;2715.67411910572;2724.6185534025253;2749.408877091435;5210.895782084337;5272.20916862466;5274.947250527445;5296.3379577552805;5299.894002119936;5062.443131255559;5129.6916387625715;5161.716105614152;5376.542993845489;5861.853453663693;5858.384869588717;5875.911861321998;5923.348431672513;5927.614705044159;5930.377310382434;5536.695481748381;5742.368339482737;5816.534677225727;5831.125331200354;5849.5612829037145;5349.839504814861;5674.971625141848;5710.74487542097;5728.369879313189;5754.165645981226;5914.112883067574;5931.110333450017;5944.970275148597;5950.583459157818;5958.851028724143;3946.210757848384;4084.14233011071;4093.5087789465456;4104.856330028435;4124.278251306069;5779.815137896637;5783.277090363705;5784.566157538286;5790.826275211751;5797.130430435468;5531.8893622126525;5560.388357280615;5612.298462692163;5633.63381380209;5639.746211420578;5373.382061063028;5543.584231182596;5571.832845014656;5587.77648894056;5593;5411.512963833274;5416.21464887597;5480.177973304037;5480.753366098615;5500.487365974389;5520.806771763129;5587.798623296011;5608.214849921096;5642.717864106696;5726.455986681259;5354.330708661418;5488.368837583569;5488.588355873246;5497.890042199054;5499.092649712753 04:30:16 INFO - PROCESS | 2316 | |5;yui.html;731.8719224135775;762.9776100025966;763.957982310973;808.115113950225;849.872519122132;14364.497242596512;15512.293647698743;15535.76696349553;15644.608884777872;15990.76013859793;14862.182579958098;14887.7022459551;14901.552953411416;15034.248287585604;15056.322465489053;666.1373521289942;775.2751177648888;792.7740593930731;810.3719617296583;810.4448452809814;794.1343935110729;800.75977206838;801.587182600961;808.737160422862;810.2545657994659;837.539353355655;846.5724808971461;848.2704873808519;848.3425345357335;848.9066202717727;697.6720941157673;818.251300060444;839.9748007559783;841.9031811341713;843.9704610338639;615.0958091605333;615.53527087049;616.9598976066542;616.9876602467925;617.2284644194757;14226.217558034305;14293.571192864127;14317.35571899267;14326.57020289393;14408.423663053465;13430.798538021938;13687.726245475134;13750;13923.164610123324;14255.928720356436;11243.325400475998;11771.646850594496;11902.821457678141;12007.699807504881;12317.630471085882;3854.4218367244857;4449.377087207794;4467.82128714851;4485.842995495142;4586.885327866797;59013.40986590165;59281;59287;59296.70351648257;59450.10824837674;10428.27002109845;10665.253432259822;10738.569520049406;10828.296160749525;10908.727281818017;19413.51466213328;19435.3197638082;19461.12424940881;19538.609227815647;19557.804421955883;7929.326007289445;8080.595970201466;8144.837103257902;8229.05365882919;8250.587470626564;4619.6073333766335;4637.165310244189;4667.253239481666;4725.8582242532775;4727.83452579165;3366;3385.136790118504;3420.8289585520624;3424.732848845893;3463.82230041787;516.359713954701;612.702839123025;618.5051958433236;618.913352130702;621.7140115546899;620.3672254300589;653.3466533466534;744.6314074533033;783.561205724796;809.3201710563037;10028.64899728506;10038.146757525546;10156;10276.588936442458;10300.587976480856;555.2393221286862;665.4011389749264;738.6269933683562;748.5508694783086;759.5556599389419;4693.07246319058;4816.614670826326;4873;4943.629227807929;4947.455779864212;73462.63268683622;73736.262637374;75117;75525;75537.6223118892;63925.36074639287;64307;64886.67556662187;66562.66718666472;67149.66425167941;60346.698266509266;60946;61209.08186377208;61244;62019;9569.760755981157;9632.133108020313;9646.565904534173;9708;9771.364861283993;39388;39505.80247098746;39905.40141897816;40289.59710402859;40342;50694.493055068975;54168;54197.18704219519;54783.726081369336;55220.171697423764;11841.348725820162;11954.880451195724;11984.28094314309;12256.203346782431;12411.62765117048;13435.19388836673;13549.932250338685;13820.378082986088;13937.09408888419;14219.715605688036;12989.870101298866;13071.281079540717;13571.457141714222;13664.180149191081;13796.931015344859;12632.368381581067;12637.810432843698;12708.682282942631;12752.234865908074;13172.802407963696;12195.939020304842;12314.322712250912;12636.684082898;12705.872941270469;12824.422900969292;10214.642487512901;10302.484875756332;10312.793744125225;10722.463876806285;10816.891831081903;10682.62610808649;10713.612882115567;10729.892701073202;10877.945610271898;11096.61161859331 04:30:16 INFO - PROCESS | 2316 | __end_tp_report 04:30:16 INFO - PROCESS | 2316 | __start_cc_report 04:30:16 INFO - PROCESS | 2316 | _x_x_mozilla_cycle_collect,839 04:30:16 INFO - PROCESS | 2316 | __end_cc_report 04:30:16 INFO - PROCESS | 2316 | __startTimestamp1464348616448__endTimestamp 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | ------- Summary: start ------- 04:30:16 INFO - PROCESS | 2316 | Number of tests: 6 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#0] dojo.html Cycles:165 Average:5409.38 Median:5593.69 stddev:626.71 (11.2%) stddev-sans-first:602.39 04:30:16 INFO - PROCESS | 2316 | Values: 3121.6 3131.4 3141.9 3163.2 3176.4 5323.6 5351.5 5407.1 5425.6 5467.4 5403.4 5440.1 5451.3 5524.5 5564.4 4870.8 4916.1 4939.8 4962.6 5046.2 4955.6 5023.1 5045.6 5055.4 5061.7 4760.7 4771.9 4870.3 4873.5 4979.2 4844.6 4855.6 4869.7 4896.5 4945.8 4900.3 4907.8 4919.0 4921.5 4928.8 5277.9 5299.8 5365.0 5426.9 5450.5 5792.3 5809.2 5828.2 5842.7 5847.5 5656.7 5840.1 5870.6 5884.4 5884.9 5411.5 5471.6 5485.7 5547.1 5552.8 6035.6 6071.9 6083.1 6085.5 6087.6 5580.7 5604.7 5836.0 5843.3 5847.8 5721.7 5757.1 5758.6 5759.5 5811.7 5682.1 5723.7 5734.6 5736.5 5738.9 5642.3 5742.0 5744.9 5748.9 5805.9 4424.0 4434.8 4473.1 4476.2 4478.3 3919.7 3937.3 3945.9 3955.7 3993.1 5403.1 5465.1 5576.5 5581.2 5593.7 5747.1 5787.8 5815.6 5897.0 5899.4 5540.8 5551.6 5559.7 5561.6 5563.2 4843.2 5011.2 5035.5 5053.0 5099.3 6093.8 6094.4 6096.0 6101.8 6131.5 5892.7 5908.4 5910.3 5912.1 5921.3 5788.5 5997.2 6075.3 6077.7 6085.4 5763.3 5793.7 5807.8 5809.1 5813.9 5903.5 5912.1 5913.8 5917.0 5918.7 5494.5 5580.9 5602.3 5626.3 5656.6 5633.4 5639.2 5654.2 5656.4 5660.2 5456.2 5553.6 5557.3 5560.7 5568.4 5706.1 5783.8 5793.3 5866.6 5868.0 5651.7 5674.5 5678.5 5684.8 5731.8 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#1] ext.html Cycles:180 Average:64480.06 Median:43397.35 stddev:131791.80 (303.7%) stddev-sans-first:132074.30 04:30:16 INFO - PROCESS | 2316 | Values: 623.5 633.1 639.3 645.3 647.0 43086.8 45192.5 45316.8 49016.5 49092.0 46073.5 46673.1 46721.5 46721.8 46785.3 8807.7 9007.1 9009.9 9013.6 9015.1 8847.3 8932.9 8939.7 8942.7 8943.0 8878.3 8934.3 8944.7 8984.7 8987.6 8909.9 8937.4 8952.1 8957.1 8962.6 8857.8 8944.3 8956.6 8959.7 8963.1 42999.8 43225.6 43332.6 43462.1 43485.3 3475.7 3484.2 3539.2 3552.2 3732.0 32757.7 33161.3 33486.8 33720.7 34057.5 4229.9 4329.8 4391.1 4443.6 4476.1 346687.0 346708.0 351141.0 351819.0 352139.0 60039.7 61019.0 61021.4 61036.4 61062.4 65379.7 65434.7 65469.7 65491.3 65506.0 16578.2 16755.4 16849.8 16872.7 16874.9 12507.1 12652.7 12658.1 12668.2 12671.2 16434.8 18448.0 18737.3 18900.0 19089.3 5158.4 5793.4 5807.7 5862.1 5886.2 941.2 1012.9 1078.9 1132.2 1181.5 33283.0 33685.3 33735.7 33803.8 33977.7 1131.9 1132.6 1145.4 1150.1 1217.3 17107.4 17671.7 17751.3 17887.5 18039.9 482751.0 487209.0 488370.0 737199.0 742186.0 60909.4 61997.4 62103.7 62110.1 62249.4 1251.1 1285.5 1296.5 1348.0 1348.1 31380.7 35446.5 36043.5 36217.3 36700.0 56737.2 57496.0 57660.4 57728.4 58060.4 499110.0 501476.0 501702.0 502028.0 502187.0 22761.3 28251.0 28255.4 28267.3 28660.1 48965.8 49055.0 49676.5 49901.5 50447.2 41234.4 41662.0 42398.8 43015.1 43897.3 41113.2 41879.0 41962.0 42047.4 42230.6 42798.0 42940.6 43633.0 43892.6 43984.3 34627.5 37262.6 37780.6 38527.4 38697.0 28000.3 28475.0 28760.4 28820.7 28915.3 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#2] jquery.html Cycles:180 Average:27948.69 Median:183649.43 stddev:76335.56 (41.6%) stddev-sans-first:76521.63 04:30:16 INFO - PROCESS | 2316 | Values: 379.7 386.9 388.5 403.4 406.0 17809.0 19714.5 19977.2 19977.7 19989.4 17574.9 17655.9 17954.1 18668.3 19006.8 5563.4 5617.4 5754.4 5768.7 5798.6 5616.7 5634.9 5650.2 5656.0 5667.7 5244.4 5526.1 5618.9 5649.0 5674.6 5339.2 5458.8 5502.4 5537.4 5541.3 5513.5 5543.3 5545.9 5545.9 5547.9 13217.0 13434.9 13629.4 13778.9 13788.5 2405.6 2410.2 2423.9 2669.2 2934.9 9597.9 10056.3 10105.6 10250.9 10261.9 1931.1 1942.5 1972.4 1974.4 2024.7 75695.2 81853.6 86259.0 87594.0 87675.0 10533.7 10562.9 10828.2 10905.7 11298.9 15294.0 15351.6 15384.8 15392.9 15405.8 7439.3 7844.9 7872.1 7965.8 8087.3 7445.6 7506.4 7667.2 7671.9 7680.8 4592.4 4609.4 4624.1 4669.3 4681.5 1859.9 1895.5 1922.0 1941.3 1974.3 913.7 957.8 966.4 967.9 1006.3 16338.3 18859.3 18897.6 19072.2 19572.3 955.5 978.9 981.7 1026.9 1045.2 10401.0 10638.7 10642.7 10661.5 10715.1 364364.0 366957.0 509871.0 511087.0 515327.0 93742.0 100141.0 103553.5 104930.2 105787.0 1032.8 1043.6 1062.1 1071.9 1079.3 15960.1 17150.8 17244.0 17291.7 17893.9 42141.8 43515.6 43596.3 43604.1 43988.8 54700.5 55079.0 60217.7 60331.0 61068.0 8385.5 8503.6 8692.4 8722.9 8758.1 8152.7 9603.1 10943.9 13215.1 13304.4 5844.6 8636.1 11669.9 11968.6 12008.5 11598.1 11722.5 11848.5 11877.9 12178.2 12023.7 12205.1 12205.5 12291.0 12310.3 8663.1 8706.7 8708.8 8833.6 8940.0 9171.8 11787.3 11931.9 12109.9 12204.4 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#3] mootools.html Cycles:180 Average:5745.05 Median:4788.41 stddev:3202.77 (66.9%) stddev-sans-first:3194.49 04:30:16 INFO - PROCESS | 2316 | Values: 1321.1 1440.4 1469.1 1590.4 1751.6 8101.1 8401.9 8409.7 8692.7 8693.2 8391.6 8624.0 8632.7 8633.3 8638.0 1999.0 2293.3 2340.4 2353.2 2361.4 2361.1 2386.0 2387.8 2398.8 2399.7 2310.1 2357.9 2358.4 2359.1 2372.3 2022.4 2179.3 2240.9 2242.8 2260.9 2213.6 2229.3 2233.8 2235.4 2245.4 8665.8 8719.5 8723.3 8727.0 8733.5 5089.9 5242.3 5254.1 5256.4 5283.7 3229.9 3349.0 3400.4 3414.4 3434.0 1105.4 1124.6 1149.6 1150.6 1152.7 11804.1 11836.3 11837.5 11838.9 11846.7 4473.0 4586.4 4624.8 4655.8 4748.2 9951.9 9964.2 9965.8 9980.7 9995.4 4766.9 5078.3 5081.9 5085.6 5090.1 4618.2 4721.6 4726.1 4787.7 4789.1 3880.3 3960.6 4018.8 4048.6 4069.5 1266.0 1271.8 1275.1 1299.7 1317.8 911.2 993.4 1014.5 1016.1 1028.3 6114.8 6137.8 6172.0 6391.4 6470.7 969.5 979.9 1016.2 1022.2 1040.2 4234.6 4371.3 4432.0 4454.4 4499.2 10507.4 10790.3 10876.6 10880.1 10881.9 10044.6 10505.7 10683.7 10755.7 10791.8 7961.3 8045.0 8115.8 8166.6 8173.8 5991.6 6166.9 6329.9 6366.3 6457.5 9493.1 9702.1 9741.6 9751.0 10025.5 9957.2 10055.0 10133.2 10158.6 10179.9 6803.6 7500.1 7620.5 7698.3 7941.6 8469.9 8485.2 8507.1 8537.0 8559.8 7540.1 7582.6 7758.5 7819.3 7821.8 7388.6 7466.8 7477.0 7555.7 7693.3 7104.5 7135.2 7167.0 7176.4 7179.8 5135.3 5171.7 5307.6 5342.9 5392.0 4898.4 4940.4 5045.8 5132.0 5391.4 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#4] prototype.html Cycles:180 Average:4562.56 Median:5129.47 stddev:1372.07 (26.7%) stddev-sans-first:1338.34 04:30:16 INFO - PROCESS | 2316 | Values: 313.5 325.5 329.6 330.4 331.1 4947.8 5317.5 5317.7 5354.6 5370.8 5294.5 5303.2 5319.6 5340.2 5346.3 4061.8 4115.1 4116.0 4116.2 4127.2 3869.2 4103.8 4121.7 4126.7 4143.3 3975.3 3993.7 4013.0 4052.4 4066.4 3997.0 4013.4 4020.9 4024.7 4052.5 3536.6 3541.5 3544.8 3545.1 3550.5 4858.3 5098.9 5116.3 5129.3 5186.8 4603.2 4606.9 4622.6 4623.3 4654.4 5506.4 5511.2 5514.2 5523.8 5588.3 3760.8 3816.7 3840.3 3841.0 3842.6 5407.5 5577.9 5687.1 5699.0 5722.9 3861.7 3935.8 3940.3 3942.8 3943.5 3776.1 3844.3 3934.3 3950.4 3992.3 4543.8 4545.7 4563.3 4578.8 4605.6 5555.7 5571.6 5572.4 5590.2 5620.7 1353.8 1373.5 1376.9 1378.9 1385.1 859.4 874.8 878.3 883.4 888.7 4779.3 4789.6 4808.7 4830.2 4832.5 4994.3 5027.4 5038.9 5040.4 5088.6 4472.1 4813.0 4828.6 4837.9 4852.2 2702.4 2706.5 2715.7 2724.6 2749.4 5210.9 5272.2 5274.9 5296.3 5299.9 5062.4 5129.7 5161.7 5376.5 5861.9 5858.4 5875.9 5923.3 5927.6 5930.4 5536.7 5742.4 5816.5 5831.1 5849.6 5349.8 5675.0 5710.7 5728.4 5754.2 5914.1 5931.1 5945.0 5950.6 5958.9 3946.2 4084.1 4093.5 4104.9 4124.3 5779.8 5783.3 5784.6 5790.8 5797.1 5531.9 5560.4 5612.3 5633.6 5639.7 5373.4 5543.6 5571.8 5587.8 5593.0 5411.5 5416.2 5480.2 5480.8 5500.5 5520.8 5587.8 5608.2 5642.7 5726.5 5354.3 5488.4 5488.6 5497.9 5499.1 04:30:16 INFO - PROCESS | 2316 | 04:30:16 INFO - PROCESS | 2316 | [#5] yui.html Cycles:180 Average:16458.37 Median:4628.39 stddev:20292.35 (438.4%) stddev-sans-first:20314.91 04:30:16 INFO - PROCESS | 2316 | Values: 731.9 763.0 764.0 808.1 849.9 14364.5 15512.3 15535.8 15644.6 15990.8 14862.2 14887.7 14901.6 15034.2 15056.3 666.1 775.3 792.8 810.4 810.4 794.1 800.8 801.6 808.7 810.3 837.5 846.6 848.3 848.3 848.9 697.7 818.3 840.0 841.9 844.0 615.1 615.5 617.0 617.0 617.2 14226.2 14293.6 14317.4 14326.6 14408.4 13430.8 13687.7 13750.0 13923.2 14255.9 11243.3 11771.6 11902.8 12007.7 12317.6 3854.4 4449.4 4467.8 4485.8 4586.9 59013.4 59281.0 59287.0 59296.7 59450.1 10428.3 10665.3 10738.6 10828.3 10908.7 19413.5 19435.3 19461.1 19538.6 19557.8 7929.3 8080.6 8144.8 8229.1 8250.6 4619.6 4637.2 4667.3 4725.9 4727.8 3366.0 3385.1 3420.8 3424.7 3463.8 516.4 612.7 618.5 618.9 621.7 620.4 653.3 744.6 783.6 809.3 10028.6 10038.1 10156.0 10276.6 10300.6 555.2 665.4 738.6 748.6 759.6 4693.1 4816.6 4873.0 4943.6 4947.5 73462.6 73736.3 75117.0 75525.0 75537.6 63925.4 64307.0 64886.7 66562.7 67149.7 60346.7 60946.0 61209.1 61244.0 62019.0 9569.8 9632.1 9646.6 9708.0 9771.4 39388.0 39505.8 39905.4 40289.6 40342.0 50694.5 54168.0 54197.2 54783.7 55220.2 11841.3 11954.9 11984.3 12256.2 12411.6 13435.2 13549.9 13820.4 13937.1 14219.7 12989.9 13071.3 13571.5 13664.2 13796.9 12632.4 12637.8 12708.7 12752.2 13172.8 12195.9 12314.3 12636.7 12705.9 12824.4 10214.6 10302.5 10312.8 10722.5 10816.9 10682.6 10713.6 10729.9 10877.9 11096.6 04:30:16 INFO - PROCESS | 2316 | -------- Summary: end -------- 04:30:16 INFO - PROCESS | 2316 | 04:30:17 INFO - TEST-INFO | 2316: exit 0 04:30:17 INFO - TEST-OK | dromaeo_css | took 1113045ms 04:30:17 INFO - TEST-START | kraken 04:30:17 INFO - operating with platform_type : linux_ 04:30:17 INFO - Initialising browser for kraken test... 04:30:17 INFO - TEST-INFO | started process 2589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQONCb/profile http://localhost:53629/getInfo.html) 04:30:21 INFO - PROCESS | 2589 | __metrics Screen width/height:1600/1200 04:30:21 INFO - PROCESS | 2589 | colorDepth:24 04:30:21 INFO - PROCESS | 2589 | Browser inner width/height: 1024/697 04:30:21 INFO - PROCESS | 2589 | __metrics 04:30:22 ERROR - PROCESS | 2589 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:30:23 INFO - TEST-INFO | 2589: exit 0 04:30:23 INFO - Browser initialized. 04:30:23 INFO - Running cycle 1/1 for kraken test... 04:30:23 INFO - TEST-INFO | started process 2684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQONCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:35 INFO - PROCESS | 2684 | RSS: Main: 155275264 04:30:35 INFO - PROCESS | 2684 | 04:30:37 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53629/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:38 INFO - PROCESS | 2684 | RSS: Main: 212967424 04:30:38 INFO - PROCESS | 2684 | 04:30:41 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53629/tests/kraken/driver.html?testName=audio-dft) 04:30:41 INFO - PROCESS | 2684 | RSS: Main: 197394432 04:30:41 INFO - PROCESS | 2684 | 04:30:44 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53629/tests/kraken/driver.html?testName=audio-fft) 04:30:45 INFO - PROCESS | 2684 | RSS: Main: 267956224 04:30:45 INFO - PROCESS | 2684 | 04:30:47 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53629/tests/kraken/driver.html?testName=audio-oscillator) 04:30:48 INFO - PROCESS | 2684 | RSS: Main: 178974720 04:30:48 INFO - PROCESS | 2684 | 04:30:50 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:50 INFO - PROCESS | 2684 | RSS: Main: 183078912 04:30:50 INFO - PROCESS | 2684 | 04:30:53 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53629/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:54 INFO - PROCESS | 2684 | RSS: Main: 218243072 04:30:54 INFO - PROCESS | 2684 | 04:30:57 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53629/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:58 INFO - PROCESS | 2684 | RSS: Main: 219312128 04:30:58 INFO - PROCESS | 2684 | 04:31:01 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53629/tests/kraken/driver.html?testName=json-parse-financial) 04:31:01 INFO - PROCESS | 2684 | RSS: Main: 219246592 04:31:01 INFO - PROCESS | 2684 | 04:31:03 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:31:04 INFO - PROCESS | 2684 | RSS: Main: 208277504 04:31:04 INFO - PROCESS | 2684 | 04:31:05 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:06 INFO - PROCESS | 2684 | RSS: Main: 211095552 04:31:06 INFO - PROCESS | 2684 | 04:31:08 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:09 INFO - PROCESS | 2684 | RSS: Main: 216612864 04:31:09 INFO - PROCESS | 2684 | 04:31:11 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:12 INFO - PROCESS | 2684 | RSS: Main: 221454336 04:31:12 INFO - PROCESS | 2684 | 04:31:15 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:15 INFO - PROCESS | 2684 | RSS: Main: 220020736 04:31:15 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | Cycle 1(1): loaded http://localhost:53629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53629/tests/kraken/driver.html?testName=ai-astar) 04:31:17 INFO - PROCESS | 2684 | RSS: Main: 262684672 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | __start_tp_report 04:31:17 INFO - PROCESS | 2684 | _x_x_mozilla_page_load 04:31:17 INFO - PROCESS | 2684 | _x_x_mozilla_page_load_details 04:31:17 INFO - PROCESS | 2684 | |i|pagename|runs| 04:31:17 INFO - PROCESS | 2684 | |0;ai-astar;111;104;111;111;110;111;109;109;110;109 04:31:17 INFO - PROCESS | 2684 | |1;audio-beat-detection;154;123;126;180;126;124;148;126;156;124 04:31:17 INFO - PROCESS | 2684 | |2;audio-dft;161;161;161;161;162;161;162;161;161;160 04:31:17 INFO - PROCESS | 2684 | |3;audio-fft;75;74;76;131;75;75;75;74;98;76 04:31:17 INFO - PROCESS | 2684 | |4;audio-oscillator;83;84;106;83;83;84;128;84;82;121 04:31:17 INFO - PROCESS | 2684 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 04:31:17 INFO - PROCESS | 2684 | |6;imaging-darkroom;145;146;146;145;146;145;145;146;146;145 04:31:17 INFO - PROCESS | 2684 | |7;imaging-desaturate;95;95;95;95;94;96;95;95;95;95 04:31:17 INFO - PROCESS | 2684 | |8;json-parse-financial;55;52;53;54;53;55;53;54;53;53 04:31:17 INFO - PROCESS | 2684 | |9;json-stringify-tinderbox;61;61;61;61;61;61;61;62;61;62 04:31:17 INFO - PROCESS | 2684 | |10;stanford-crypto-aes;79;79;77;78;78;80;85;80;125;80 04:31:17 INFO - PROCESS | 2684 | |11;stanford-crypto-ccm;127;127;118;128;120;119;133;120;126;126 04:31:17 INFO - PROCESS | 2684 | |12;stanford-crypto-pbkdf2;165;164;156;161;160;158;160;159;163;160 04:31:17 INFO - PROCESS | 2684 | |13;stanford-crypto-sha256-iterative;64;62;65;62;63;62;63;62;61;66 04:31:17 INFO - PROCESS | 2684 | __end_tp_report 04:31:17 INFO - PROCESS | 2684 | __start_cc_report 04:31:17 INFO - PROCESS | 2684 | _x_x_mozilla_cycle_collect,1647 04:31:17 INFO - PROCESS | 2684 | __end_cc_report 04:31:17 INFO - PROCESS | 2684 | __startTimestamp1464348677483__endTimestamp 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | ------- Summary: start ------- 04:31:17 INFO - PROCESS | 2684 | Number of tests: 14 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.12 (1.9%) stddev-sans-first:2.18 04:31:17 INFO - PROCESS | 2684 | Values: 111.0 104.0 111.0 111.0 110.0 111.0 109.0 109.0 110.0 109.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:137.00 stddev:19.69 (14.4%) stddev-sans-first:20.09 04:31:17 INFO - PROCESS | 2684 | Values: 154.0 123.0 126.0 180.0 126.0 124.0 148.0 126.0 156.0 124.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:31:17 INFO - PROCESS | 2684 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 160.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:18.39 (24.5%) stddev-sans-first:19.29 04:31:17 INFO - PROCESS | 2684 | Values: 75.0 74.0 76.0 131.0 75.0 75.0 75.0 74.0 98.0 76.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:83.00 stddev:17.75 (21.4%) stddev-sans-first:18.39 04:31:17 INFO - PROCESS | 2684 | Values: 83.0 84.0 106.0 83.0 83.0 84.0 128.0 84.0 82.0 121.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:31:17 INFO - PROCESS | 2684 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:31:17 INFO - PROCESS | 2684 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:31:17 INFO - PROCESS | 2684 | Values: 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:0.97 (1.8%) stddev-sans-first:0.87 04:31:17 INFO - PROCESS | 2684 | Values: 55.0 52.0 53.0 54.0 53.0 55.0 53.0 54.0 53.0 53.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:31:17 INFO - PROCESS | 2684 | Values: 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 62.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:79.50 stddev:14.53 (18.3%) stddev-sans-first:15.30 04:31:17 INFO - PROCESS | 2684 | Values: 79.0 79.0 77.0 78.0 78.0 80.0 85.0 80.0 125.0 80.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:4.88 (3.9%) stddev-sans-first:5.09 04:31:17 INFO - PROCESS | 2684 | Values: 127.0 127.0 118.0 128.0 120.0 119.0 133.0 120.0 126.0 126.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.50 stddev:2.76 (1.7%) stddev-sans-first:2.42 04:31:17 INFO - PROCESS | 2684 | Values: 165.0 164.0 156.0 161.0 160.0 158.0 160.0 159.0 163.0 160.0 04:31:17 INFO - PROCESS | 2684 | 04:31:17 INFO - PROCESS | 2684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.56 (2.5%) stddev-sans-first:1.62 04:31:17 INFO - PROCESS | 2684 | Values: 64.0 62.0 65.0 62.0 63.0 62.0 63.0 62.0 61.0 66.0 04:31:17 INFO - PROCESS | 2684 | -------- Summary: end -------- 04:31:17 INFO - PROCESS | 2684 | 04:31:18 INFO - TEST-INFO | 2684: exit 0 04:31:18 INFO - TEST-OK | kraken | took 61305ms 04:31:18 INFO - SUITE-END | took 1174s 04:31:18 INFO - Completed test suite (00:19:34) 04:31:18 INFO - javascript benchmark 04:31:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3121.578586890769, 3131.3580715953226, 3141.874325026999, 3163.161762133034, 3176.428242916274, 5323.60072994526, 5351.49160829721, 5407.080796264635, 5425.647332923357, 5467.425920278373, 5403.378611459683, 5440.102383106782, 5451.3458384993755, 5524.475174858392, 5564.387917329091, 4870.780814863331, 4916.090523253191, 4939.753012349386, 4962.627802914778, 5046.217836235371, 4955.628327875405, 5023.0707319145895, 5045.596352291826, 5055.368078990126, 5061.746912654371, 4760.738159401231, 4771.880702982401, 4870.318155458239, 4873.488283730228, 4979.153543897528, 4844.63665225106, 4855.562999330042, 4869.683470574401, 4896.46138924718, 4945.802167913279, 4900.338454308659, 4907.754612269372, 4918.950810491885, 4921.532454416824, 4928.827491037832, 5277.947220527784, 5299.814506492293, 5364.9731751341, 5426.9185962210595, 5450.482204190595, 5792.304923409176, 5809.223775247756, 5828.1549175369755, 5842.737076831553, 5847.532197424196, 5656.717164141817, 5840.065589505659, 5870.589058765888, 5884.382139875294, 5884.911291411103, 5411.512963833235, 5471.562275017989, 5485.6982865942355, 5547.11246200606, 5552.833414997556, 6035.551061277484, 6071.908921366183, 6083.148359229712, 6085.482733967662, 6087.573869829158, 5580.665160090408, 5604.747786349624, 5836.037053886146, 5843.29880414353, 5847.766089356378, 5721.685307308138, 5757.13642953552, 5758.568107391962, 5759.539236861041, 5811.709414529257, 5682.062459694104, 5723.742431590588, 5734.627249228787, 5736.483716465538, 5738.885222295531, 5642.266505354278, 5742.0, 5744.913826292609, 5748.856278593069, 5805.912911306334, 4423.977880110579, 4434.84478043267, 4473.105378924228, 4476.216662084123, 4478.261086920622, 3919.7452165609143, 3937.3109705801944, 3945.9013524662114, 3955.7033222507853, 3993.121513267077, 5403.13549832025, 5465.07093794056, 5576.470235327637, 5581.190727344512, 5593.692346920959, 5747.109198074305, 5787.826365209051, 5815.621984570989, 5897.0269905465975, 5899.380565040695, 5540.7783688652, 5551.555875529948, 5559.694216818033, 5561.610687251934, 5563.221149039137, 4843.2250839865455, 5011.223260394571, 5035.546800787946, 5052.9747351263, 5099.311592934981, 6093.786717464867, 6094.421030002142, 6095.969520152371, 6101.7559297627595, 6131.540134489931, 5892.705364731832, 5908.3500814911185, 5910.290765108214, 5912.083627037816, 5921.289445266596, 5788.479036886701, 5997.190379298739, 6075.30134034574, 6077.726502307319, 6085.421884920926, 5763.279590051244, 5793.739281732248, 5807.767689292381, 5809.099589563624, 5813.94186058134, 5903.498202652822, 5912.142739302691, 5913.793017244548, 5916.994111001226, 5918.674472904032, 5494.5054945055135, 5580.86047848807, 5602.327720673546, 5626.2967129108865, 5656.60403771732, 5633.4084921082695, 5639.238702775237, 5654.15187721845, 5656.37779844225, 5660.207570940154, 5456.181572764117, 5553.639013464273, 5557.277553917965, 5560.694161821139, 5568.415316391721, 5706.058500347563, 5783.768649253982, 5793.275840519935, 5866.560007999332, 5868.0, 5651.745671444877, 5674.4892959633835, 5678.5457163426, 5684.8294551163535, 5731.828045158652], "value": 5366.4257965876095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5416968528131, 633.085191897708, 639.335091504835, 645.2579533536435, 646.9644169570674, 43086.78456607716, 45192.54807451928, 45316.77341613291, 49016.50983490164, 49092.0, 46073.539264607345, 46673.066538669205, 46721.53278467214, 46721.76639116808, 46785.29822052672, 8807.735767926957, 9007.1443212895, 9009.864852027225, 9013.639454421815, 9015.098490150998, 8847.292216622654, 8932.866007009867, 8939.687110951118, 8942.73171804847, 8943.0, 8878.334124940622, 8934.329925255599, 8944.731658050236, 8984.685536006242, 8987.550622468883, 8909.910900890973, 8937.419067760575, 8952.104789521061, 8957.149070838292, 8962.551872406419, 8857.778555536099, 8944.329175311877, 8956.596953137125, 8959.68641097565, 8963.14850089247, 42999.78500107479, 43225.56774432247, 43332.56667433317, 43462.13075738499, 43485.34771978423, 3475.669811367916, 3484.198634314122, 3539.185987222953, 3552.182997910495, 3731.9626803731885, 32757.6724232757, 33161.336773264644, 33486.832565837256, 33720.66279337224, 34057.48913766295, 4229.851955181584, 4329.7618630975285, 4391.055922976543, 4443.622292105175, 4476.082403107388, 346687.0, 346708.0, 351141.0, 351819.0, 352138.99999999744, 60039.69980150071, 61019.0, 61021.38978610157, 61036.38963610396, 61062.389376106556, 65379.67310163514, 65434.672826635564, 65469.672651636436, 65491.345086549474, 65506.0, 16578.17109144538, 16755.41356052532, 16849.831501684825, 16872.746908796376, 16874.915625421796, 12507.124501285005, 12652.746945061048, 12658.113932024855, 12668.239905605693, 12671.17637353569, 16434.76489500219, 18448.0, 18737.25050997972, 18900.0, 19089.331873384366, 5158.3552055993005, 5793.362730099686, 5807.702300297749, 5862.091375836752, 5886.205362276038, 941.2375975459762, 1012.9139023182964, 1078.9298695584762, 1132.1848269246295, 1181.4565299962114, 33283.0, 33685.32629347399, 33735.66264337374, 33803.83098084494, 33977.66022339794, 1131.8698349689726, 1132.6318946342471, 1145.4043897173424, 1150.068444559909, 1217.3365515793914, 17107.401240956508, 17671.73492397615, 17751.289948402176, 17887.463376098738, 18039.909800450914, 482751.0, 487209.0, 488370.0, 737199.0, 742186.0, 60909.390906090375, 61997.380026200066, 62103.68948155321, 62110.068348974804, 62249.37750622526, 1251.0617037222084, 1285.5243559882904, 1296.5462088268841, 1347.968803865044, 1348.1237195822794, 31380.686193137775, 35446.46830297599, 36043.459348109274, 36217.275654486235, 36700.0, 56737.177339926566, 57496.0, 57660.42339576551, 57728.42271577231, 58060.41939580719, 499110.0, 501476.0, 501702.0, 502028.0, 502187.0, 22761.31716048521, 28251.0, 28255.434891301647, 28267.2933176664, 28660.14019579416, 48965.755171223915, 49055.0, 49676.50323496863, 49901.50098498969, 50447.24329134992, 41234.38148427716, 41662.0, 42398.788006059774, 43015.139697206505, 43897.34153987629, 41113.1777364457, 41879.0, 41962.0, 42047.36928946007, 42230.577694222666, 42798.0, 42940.570594294906, 43633.0, 43892.56107439013, 43984.34023489714, 34627.48058779171, 37262.62737372592, 37780.62219377771, 38527.42208866813, 38697.0, 28000.29999250035, 28475.0, 28760.424791503636, 28820.711792881804, 28915.277118072216], "value": 20649.772749084215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.747467933824, 386.8568629607046, 388.4619801574819, 403.41101991093, 405.98782036538915, 17809.0, 19714.507137321572, 19977.200911963504, 19977.700334494977, 19989.400317990447, 17574.94550326978, 17655.91172044138, 17954.10229488527, 18668.25326986919, 19006.809931900676, 5563.388027316992, 5617.38208797032, 5754.424557544233, 5768.740406681688, 5798.623089499169, 5616.719164041802, 5634.915476267839, 5650.237217975562, 5656.0, 5667.744951477172, 5244.370675518924, 5526.06056970316, 5618.915716264239, 5649.0, 5674.574406919498, 5339.199120131972, 5458.836234912959, 5502.394736578973, 5537.418571050022, 5541.251930989325, 5513.50378465936, 5543.334799824007, 5545.861353466155, 5545.861353466155, 5547.916781248285, 13217.0, 13434.93282533581, 13629.386677599532, 13778.862211377858, 13788.517401890886, 2405.5549723301247, 2410.20463247128, 2423.866687332196, 2669.225924481898, 2934.8532573371244, 9597.856032159523, 10056.34633748804, 10105.646302379455, 10250.899640143927, 10261.897381026169, 1931.0537836460032, 1942.5046613113707, 1972.3885595465451, 1974.4076776966997, 2024.6558085125564, 75695.24304756937, 81853.59073204655, 86259.0, 87594.0, 87675.0, 10533.683989480327, 10562.894371056345, 10828.187885908588, 10905.672829815117, 11298.943505282585, 15294.0, 15351.61620959485, 15384.84615153834, 15392.92303538475, 15405.768913466307, 7439.293267139613, 7844.921550784533, 7872.134065252818, 7965.800854978672, 8087.312578430781, 7445.585338785613, 7506.437017223621, 7667.194944530744, 7671.884921726179, 7680.846383072419, 4592.402987611589, 4609.446866376056, 4624.075184963021, 4669.322948172496, 4681.485036645966, 1859.907004649762, 1895.450319407384, 1921.9903900480408, 1941.3205378117545, 1974.338596570165, 913.7441516375426, 957.7749228931195, 966.3766870368573, 967.9274054445804, 1006.2855372685475, 16338.264778085015, 18859.339923102627, 18897.622047558973, 19072.2371105157, 19572.3149689763, 955.507913424587, 978.9363691360039, 981.6564202529057, 1026.9332493387906, 1045.2474218562622, 10401.0, 10638.680839574825, 10642.68071957827, 10661.466926653637, 10715.142788576895, 364364.0, 366957.0, 509871.0, 511087.0, 515327.0, 93742.0, 100141.0, 103553.48223258986, 104930.16390663237, 105787.0, 1032.7779527401494, 1043.5982146873357, 1062.134360496193, 1071.8552995345685, 1079.3092420850662, 15960.122193279482, 17150.7994440388, 17244.0, 17291.740623890902, 17893.910530447265, 42141.78929105458, 43515.56484435115, 43596.34605480857, 43604.12791744211, 43988.78005609952, 54700.45299546954, 55079.0, 60217.698911506915, 60331.0, 61068.0, 8385.496870187808, 8503.574821258788, 8692.434991725517, 8722.869156962777, 8758.12418758119, 8152.714654987047, 9603.135717785433, 10943.945280273547, 13215.074944753775, 13304.401301941629, 5844.557517709337, 8636.136386361313, 11669.941650291694, 11968.640940771791, 12008.519659213884, 11598.07215422781, 11722.472488737856, 11848.52605895789, 11877.881221187678, 12178.208416452902, 12023.699407514881, 12205.084618653458, 12205.511779528719, 12291.0, 12310.322932238454, 8663.090375510732, 8706.651733930572, 8708.78228044304, 8833.602487888189, 8939.955300223717, 9171.77070573241, 11787.292762434281, 11931.880681193077, 12109.939450302692, 12204.389780511117], "value": 8985.702142940492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.0554453565699, 1440.4094321328255, 1469.1258701072861, 1590.3718031377607, 1751.6234009687914, 8101.10887802342, 8401.91598084019, 8409.747707568775, 8692.652293908237, 8693.174148455886, 8391.580420978942, 8624.0, 8632.697855575056, 8633.266172375355, 8638.0, 1998.9700154497693, 2293.334932869466, 2340.3564019894493, 2353.223436266028, 2361.409647588103, 2361.055577768898, 2385.985955968715, 2387.761223877607, 2398.8440751351195, 2399.7240317363467, 2310.06442390832, 2357.917472888449, 2358.398608354867, 2359.1153317505937, 2372.2764556810166, 2022.423609271358, 2179.3244094330807, 2240.88795560223, 2242.7757224277607, 2260.9095636174534, 2213.645816669325, 2229.2532001779423, 2233.7654546272734, 2235.3740952533153, 2245.36007237938, 8665.826683466295, 8719.476831390073, 8723.302135829119, 8727.0, 8733.519656418894, 5089.872753181163, 5242.344706911636, 5254.106801843695, 5256.395514515842, 5283.682979021271, 3229.8869539566003, 3348.9665103349143, 3400.353932752769, 3414.351273258098, 3433.9828300858585, 1105.3699391346936, 1124.612008856943, 1149.5804031528432, 1150.6202953025481, 1152.7463957929326, 11804.05567554585, 11836.349000804952, 11837.467313970892, 11838.934495895412, 11846.703832404173, 4472.955270447319, 4586.4266966629175, 4624.791884365211, 4655.837045703384, 4748.240281554935, 9951.900480995097, 9964.20286377088, 9965.80068398628, 9980.650677226262, 9995.400275983464, 4766.904661906812, 5078.289039534468, 5081.898362032739, 5085.567726743268, 5090.0583392072585, 4618.1918164321105, 4721.5750582447745, 4726.054789042205, 4787.736674482937, 4789.090072886141, 3880.2821478026653, 3960.554397644839, 4018.778967156776, 4048.574899635496, 4069.5320038195396, 1265.9556915507912, 1271.7965125579863, 1275.05645822091, 1299.7465494228534, 1317.7957416600443, 911.2436677557612, 993.3692105513052, 1014.4572653630272, 1016.1362841584742, 1028.311031608824, 6114.847128821726, 6137.785177518855, 6172.0, 6391.424771770563, 6470.676466176672, 969.4667932637021, 979.864433811805, 1016.2225897188508, 1022.2333250062453, 1040.2302296300684, 4234.55537168599, 4371.322445020964, 4432.047109871329, 4454.420925279693, 4499.235130027903, 10507.422091785025, 10790.298630588986, 10876.564937402574, 10880.075193608633, 10881.945590271998, 10044.648437304659, 10505.684829454976, 10683.73290667724, 10755.677329680122, 10791.83812242817, 7961.323287520509, 8044.959775201203, 8115.75652730419, 8166.550839703873, 8173.79565510867, 5991.64050156992, 6166.907496387468, 6329.936700632935, 6366.267879193952, 6457.5479716419395, 9493.145616894513, 9702.126808587262, 9741.561629726537, 9751.024897510193, 10025.548850301608, 9957.203423726229, 10055.044770746767, 10133.189344852246, 10158.593656253666, 10179.949100254747, 6803.625800581016, 7500.13748418917, 7620.504667196615, 7698.307152356315, 7941.642626081955, 8469.915300847159, 8485.193906579112, 8507.106753790762, 8537.0, 8559.786005349915, 7540.132884718328, 7582.582957937367, 7758.495697779852, 7819.257170568787, 7821.765347039371, 7388.556686598821, 7466.813329666802, 7477.0, 7555.659995300334, 7693.307602315818, 7104.502684812013, 7135.215126336203, 7166.964165179141, 7176.390006849476, 7179.784606461814, 5135.281060651587, 5171.715555644325, 5307.6284660073425, 5342.9198562022375, 5391.975524650304, 4898.387701537308, 4940.357753492023, 5045.798168073383, 5132.024915266087, 5391.379991301051], "value": 4624.959876760806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.49683757569085, 325.4759836662973, 329.58472324870655, 330.39319767038074, 331.09445666103204, 4947.8268260610885, 5317.46825317468, 5317.707526086064, 5354.598405119617, 5370.758315875785, 5294.52349288564, 5303.151495760679, 5319.601029922762, 5340.198970154479, 5346.27825243592, 4061.7969101544954, 4115.074108325625, 4115.950432639673, 4116.176764647068, 4127.236461254663, 3869.187470631171, 4103.79481025949, 4121.670266378697, 4126.711130220886, 4143.337066069429, 3975.264576053425, 3993.680505559563, 4013.016810881338, 4052.3516237402023, 4066.430699702044, 3996.980769903656, 4013.3979903014488, 4020.8592699255532, 4024.718269721135, 4052.49343832021, 3536.6463353664685, 3541.486484459739, 3544.805035723034, 3545.1137215696076, 3550.467429885512, 4858.319835223072, 5098.898022039539, 5116.258142569344, 5129.256257842592, 5186.766595503173, 4603.194440972817, 4606.930896036562, 4622.583967442913, 4623.32961720552, 4654.371659825948, 5506.394296627408, 5511.173324001432, 5514.200440936042, 5523.751431185607, 5588.273524441796, 3760.755550889211, 3816.664167541366, 3840.3471409860113, 3841.0, 3842.634949679776, 5407.486288802596, 5577.888442231133, 5687.061634830248, 5698.971505142447, 5722.942770572283, 3861.691064714816, 3935.763854168759, 3940.310445671996, 3942.8225729842225, 3943.526776786804, 3776.0937375030344, 3844.308024555551, 3934.2885844657667, 3950.4469374287623, 3992.341263691458, 4543.7728113594185, 4545.727256364628, 4563.338315944169, 4578.771061446914, 4605.608523275492, 5555.722213889289, 5571.554275657938, 5572.414896435897, 5590.217369568264, 5620.718964051781, 1353.817234673326, 1373.505538006317, 1376.9311534423439, 1378.910370825893, 1385.0858433433884, 859.4070091636751, 874.8250349930039, 878.3368556739621, 883.4142713828693, 888.7422647432302, 4779.2519301401135, 4789.568938795525, 4808.735519546459, 4830.203016502238, 4832.526079545702, 4994.300797888299, 5027.396712394463, 5038.874028149252, 5040.36995375578, 5088.62607096082, 4472.137831787659, 4812.975935120302, 4828.623842205025, 4837.9032419351415, 4852.2479015752615, 2702.4054707964215, 2706.539888218968, 2715.67411910572, 2724.6185534025253, 2749.408877091435, 5210.895782084337, 5272.20916862466, 5274.947250527445, 5296.3379577552805, 5299.894002119936, 5062.443131255559, 5129.6916387625715, 5161.716105614152, 5376.542993845489, 5861.853453663693, 5858.384869588717, 5875.911861321998, 5923.348431672513, 5927.614705044159, 5930.377310382434, 5536.695481748381, 5742.368339482737, 5816.534677225727, 5831.125331200354, 5849.5612829037145, 5349.839504814861, 5674.971625141848, 5710.74487542097, 5728.369879313189, 5754.165645981226, 5914.112883067574, 5931.110333450017, 5944.970275148597, 5950.583459157818, 5958.851028724143, 3946.210757848384, 4084.14233011071, 4093.5087789465456, 4104.856330028435, 4124.278251306069, 5779.815137896637, 5783.277090363705, 5784.566157538286, 5790.826275211751, 5797.130430435468, 5531.8893622126525, 5560.388357280615, 5612.298462692163, 5633.63381380209, 5639.746211420578, 5373.382061063028, 5543.584231182596, 5571.832845014656, 5587.77648894056, 5593.0, 5411.512963833274, 5416.21464887597, 5480.177973304037, 5480.753366098615, 5500.487365974389, 5520.806771763129, 5587.798623296011, 5608.214849921096, 5642.717864106696, 5726.455986681259, 5354.330708661418, 5488.368837583569, 5488.588355873246, 5497.890042199054, 5499.092649712753], "value": 4123.102028502594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.8719224135775, 762.9776100025966, 763.957982310973, 808.115113950225, 849.872519122132, 14364.497242596512, 15512.293647698743, 15535.76696349553, 15644.608884777872, 15990.76013859793, 14862.182579958098, 14887.7022459551, 14901.552953411416, 15034.248287585604, 15056.322465489053, 666.1373521289942, 775.2751177648888, 792.7740593930731, 810.3719617296583, 810.4448452809814, 794.1343935110729, 800.75977206838, 801.587182600961, 808.737160422862, 810.2545657994659, 837.539353355655, 846.5724808971461, 848.2704873808519, 848.3425345357335, 848.9066202717727, 697.6720941157673, 818.251300060444, 839.9748007559783, 841.9031811341713, 843.9704610338639, 615.0958091605333, 615.53527087049, 616.9598976066542, 616.9876602467925, 617.2284644194757, 14226.217558034305, 14293.571192864127, 14317.35571899267, 14326.57020289393, 14408.423663053465, 13430.798538021938, 13687.726245475134, 13750.0, 13923.164610123324, 14255.928720356436, 11243.325400475998, 11771.646850594496, 11902.821457678141, 12007.699807504881, 12317.630471085882, 3854.4218367244857, 4449.377087207794, 4467.82128714851, 4485.842995495142, 4586.885327866797, 59013.40986590165, 59281.0, 59287.0, 59296.70351648257, 59450.10824837674, 10428.27002109845, 10665.253432259822, 10738.569520049406, 10828.296160749525, 10908.727281818017, 19413.51466213328, 19435.3197638082, 19461.12424940881, 19538.609227815647, 19557.804421955883, 7929.326007289445, 8080.595970201466, 8144.837103257902, 8229.05365882919, 8250.587470626564, 4619.6073333766335, 4637.165310244189, 4667.253239481666, 4725.8582242532775, 4727.83452579165, 3366.0, 3385.136790118504, 3420.8289585520624, 3424.732848845893, 3463.82230041787, 516.359713954701, 612.702839123025, 618.5051958433236, 618.913352130702, 621.7140115546899, 620.3672254300589, 653.3466533466534, 744.6314074533033, 783.561205724796, 809.3201710563037, 10028.64899728506, 10038.146757525546, 10156.0, 10276.588936442458, 10300.587976480856, 555.2393221286862, 665.4011389749264, 738.6269933683562, 748.5508694783086, 759.5556599389419, 4693.07246319058, 4816.614670826326, 4873.0, 4943.629227807929, 4947.455779864212, 73462.63268683622, 73736.262637374, 75117.0, 75525.0, 75537.6223118892, 63925.36074639287, 64307.0, 64886.67556662187, 66562.66718666472, 67149.66425167941, 60346.698266509266, 60946.0, 61209.08186377208, 61244.0, 62019.0, 9569.760755981157, 9632.133108020313, 9646.565904534173, 9708.0, 9771.364861283993, 39388.0, 39505.80247098746, 39905.40141897816, 40289.59710402859, 40342.0, 50694.493055068975, 54168.0, 54197.18704219519, 54783.726081369336, 55220.171697423764, 11841.348725820162, 11954.880451195724, 11984.28094314309, 12256.203346782431, 12411.62765117048, 13435.19388836673, 13549.932250338685, 13820.378082986088, 13937.09408888419, 14219.715605688036, 12989.870101298866, 13071.281079540717, 13571.457141714222, 13664.180149191081, 13796.931015344859, 12632.368381581067, 12637.810432843698, 12708.682282942631, 12752.234865908074, 13172.802407963696, 12195.939020304842, 12314.322712250912, 12636.684082898, 12705.872941270469, 12824.422900969292, 10214.642487512901, 10302.484875756332, 10312.793744125225, 10722.463876806285, 10816.891831081903, 10682.62610808649, 10713.612882115567, 10729.892701073202, 10877.945610271898, 11096.61161859331], "value": 7017.324480332383, "unit": "score"}], "name": "dromaeo_css", "value": 7146.890678401729, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 111.0, 110.0, 111.0, 109.0, 109.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 126.0, 180.0, 126.0, 124.0, 148.0, 126.0, 156.0, 124.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 131.0, 75.0, 75.0, 75.0, 74.0, 98.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 106.0, 83.0, 83.0, 84.0, 128.0, 84.0, 82.0, 121.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 54.0, 53.0, 55.0, 53.0, 54.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 78.0, 78.0, 80.0, 85.0, 80.0, 125.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 118.0, 128.0, 120.0, 119.0, 133.0, 120.0, 126.0, 126.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 156.0, 161.0, 160.0, 158.0, 160.0, 159.0, 163.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 66.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1490.1999999999998, "alertThreshold": 2.0}]} 04:31:18 INFO - Return code: 0 04:31:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:31:18 ERROR - # TBPL SUCCESS # 04:31:18 INFO - Running post-action listener: _resource_record_post_action 04:31:18 INFO - ##### 04:31:18 INFO - ##### Finished run-tests step (success) 04:31:18 INFO - ##### 04:31:18 INFO - Running post-run listener: _resource_record_post_run 04:31:18 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 548470784; Read time: 304; Write time: 673600 04:31:18 INFO - TinderboxPrint: CPU usage
13.2% 04:31:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 304 04:31:18 INFO - TinderboxPrint: I/O write bytes / time
548,470,784 / 673,600 04:31:18 INFO - TinderboxPrint: CPU idle
8,257.6 (86.8%) 04:31:18 INFO - TinderboxPrint: CPU user
1,208.2 (12.7%) 04:31:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:31:18 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257429504; Read time: 0; Write time: 359368 04:31:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291041280; Read time: 304; Write time: 314232 04:31:19 INFO - Running post-run listener: _upload_blobber_files 04:31:19 INFO - Blob upload gear active. 04:31:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:19 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 04:31:19 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'] 04:31:19 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 04:31:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:24 INFO - (blobuploader) - INFO - Done attempting. 04:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:25 INFO - (blobuploader) - INFO - Done attempting. 04:31:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:31:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:25 INFO - (blobuploader) - INFO - Done attempting. 04:31:25 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:25 INFO - Return code: 0 04:31:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e46375a54fe3e5be5b9b1be60dd239e0e82d4cba5f05b7687b0b74415f43de3b66759372c2a827c6a6be91cdc84bbd15b673e5ab4c10f9aaf9739950c46deecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84ffbd3644b38c1ca325e38df9838a796a3628ea4a65413c5ed208181ff325a5825edc1acf8c4e5474b54dcb221442ad19627f8527e76aa96c45c4f52b3972e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83ffb95b897bb8997cb59157bdaf88592d4bd49c042e6cfcb3d0ebe83d10b0e3b36aeb2a9f95fac90a9ff111c3cb5ac45314e34ea5baff2a600f917c20b4bf07"} 04:31:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:25 INFO - Contents: 04:31:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e46375a54fe3e5be5b9b1be60dd239e0e82d4cba5f05b7687b0b74415f43de3b66759372c2a827c6a6be91cdc84bbd15b673e5ab4c10f9aaf9739950c46deecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84ffbd3644b38c1ca325e38df9838a796a3628ea4a65413c5ed208181ff325a5825edc1acf8c4e5474b54dcb221442ad19627f8527e76aa96c45c4f52b3972e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83ffb95b897bb8997cb59157bdaf88592d4bd49c042e6cfcb3d0ebe83d10b0e3b36aeb2a9f95fac90a9ff111c3cb5ac45314e34ea5baff2a600f917c20b4bf07"} 04:31:25 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:25 INFO - Copying logs to upload dir... 04:31:25 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.364298 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-27 04:31:25.175888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 04:31:25.179136) ========= 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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 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/e46375a54fe3e5be5b9b1be60dd239e0e82d4cba5f05b7687b0b74415f43de3b66759372c2a827c6a6be91cdc84bbd15b673e5ab4c10f9aaf9739950c46deecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84ffbd3644b38c1ca325e38df9838a796a3628ea4a65413c5ed208181ff325a5825edc1acf8c4e5474b54dcb221442ad19627f8527e76aa96c45c4f52b3972e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83ffb95b897bb8997cb59157bdaf88592d4bd49c042e6cfcb3d0ebe83d10b0e3b36aeb2a9f95fac90a9ff111c3cb5ac45314e34ea5baff2a600f917c20b4bf07"} build_url:https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/KRGWKEONQj-HF1MDxTkbWA/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/e46375a54fe3e5be5b9b1be60dd239e0e82d4cba5f05b7687b0b74415f43de3b66759372c2a827c6a6be91cdc84bbd15b673e5ab4c10f9aaf9739950c46deecb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84ffbd3644b38c1ca325e38df9838a796a3628ea4a65413c5ed208181ff325a5825edc1acf8c4e5474b54dcb221442ad19627f8527e76aa96c45c4f52b3972e0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/83ffb95b897bb8997cb59157bdaf88592d4bd49c042e6cfcb3d0ebe83d10b0e3b36aeb2a9f95fac90a9ff111c3cb5ac45314e34ea5baff2a600f917c20b4bf07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 04:31:25.204366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:31:25.204688) ========= 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=fa44defc139c4ba8574fe040000001db-1464342323.118065-608978737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 04:31:25.287491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 04:31:25.287811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 04:31:25.288085) ========= ========= Total master_lag: 0.17 =========