builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1465934418.91 results: success (0) buildid: 20160614103029 builduid: 021f72d0f7a94ca2a12d5390d63e8bad revision: 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:18.909088) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:18.909482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:18.909769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:18.965132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:18.965647) ========= 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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 13:00:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-06-14 13:00:19 (19.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.051834) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.052154) ========= 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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.101970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.102284) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd --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 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd --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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 13:00:19,372 truncating revision to first 12 chars 2016-06-14 13:00:19,372 Setting DEBUG logging. 2016-06-14 13:00:19,372 attempt 1/10 2016-06-14 13:00:19,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/367a789e26a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 13:00:19,723 unpacking tar archive at: mozilla-inbound-367a789e26a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685639 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.801259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.801580) ========= script_repo_revision: 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.801974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.802366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 13:00:19.812788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 13:00:19.813154) ========= /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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:00:20 INFO - MultiFileLogger online at 20160614 13:00:20 in /builds/slave/test 13:00:20 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 13:00:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:00:20 INFO - {'append_to_log': False, 13:00:20 INFO - 'base_work_dir': '/builds/slave/test', 13:00:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:00:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:00:20 INFO - 'branch': 'Mozilla-Inbound', 13:00:20 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:20 INFO - 'config_files': ('talos/linux_config.py',), 13:00:20 INFO - 'default_actions': ('clobber', 13:00:20 INFO - 'read-buildbot-config', 13:00:20 INFO - 'download-and-extract', 13:00:20 INFO - 'populate-webroot', 13:00:20 INFO - 'create-virtualenv', 13:00:20 INFO - 'install', 13:00:20 INFO - 'run-tests'), 13:00:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:20 INFO - 'download_minidump_stackwalk': True, 13:00:20 INFO - 'download_symbols': 'ondemand', 13:00:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:20 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:20 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:20 INFO - 'installer_path': 'installer.exe', 13:00:20 INFO - 'log_level': 'info', 13:00:20 INFO - 'log_name': 'talos', 13:00:20 INFO - 'log_to_console': True, 13:00:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:00:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:00:20 INFO - 'opt_config_files': (), 13:00:20 INFO - 'pip_index': False, 13:00:20 INFO - 'sps_profile': False, 13:00:20 INFO - 'sps_profile_interval': 0, 13:00:20 INFO - 'suite': 'dromaeojs', 13:00:20 INFO - 'system_bits': '32', 13:00:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:20 INFO - 'title': 'talos-linux64-ix-010', 13:00:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:20 INFO - 'use_talos_json': True, 13:00:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:00:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:20 INFO - 'work_dir': 'build'} 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running clobber step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: clobber 13:00:20 INFO - rmtree: /builds/slave/test/build 13:00:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:00:20 INFO - Running post-action listener: _resource_record_post_action 13:00:20 INFO - ##### 13:00:20 INFO - ##### Finished clobber step (success) 13:00:20 INFO - ##### 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running read-buildbot-config step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: read_buildbot_config 13:00:20 INFO - Using buildbot properties: 13:00:20 INFO - { 13:00:20 INFO - "project": "", 13:00:20 INFO - "product": "firefox", 13:00:20 INFO - "script_repo_revision": "production", 13:00:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:00:20 INFO - "repository": "", 13:00:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:00:20 INFO - "buildid": "20160614103029", 13:00:20 INFO - "pgo_build": "True", 13:00:20 INFO - "basedir": "/builds/slave/test", 13:00:20 INFO - "buildnumber": 1108, 13:00:20 INFO - "slavename": "talos-linux64-ix-010", 13:00:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:00:20 INFO - "platform": "ubuntu64_hw", 13:00:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:00:20 INFO - "branch": "mozilla-inbound", 13:00:20 INFO - "repo_path": "integration/mozilla-inbound", 13:00:20 INFO - "revision": "367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd", 13:00:20 INFO - "stage_platform": "linux64-pgo", 13:00:20 INFO - "builduid": "021f72d0f7a94ca2a12d5390d63e8bad", 13:00:20 INFO - "slavebuilddir": "test" 13:00:20 INFO - } 13:00:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:00:20 INFO - Running post-action listener: _resource_record_post_action 13:00:20 INFO - ##### 13:00:20 INFO - ##### Finished read-buildbot-config step (success) 13:00:20 INFO - ##### 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running download-and-extract step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: download_and_extract 13:00:20 INFO - mkdir: /builds/slave/test/build/tests 13:00: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')]} 13:00:20 INFO - https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:00:25 INFO - Downloaded 1361 bytes. 13:00:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:00:25 INFO - Using the following test package requirements: 13:00:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:00:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:00:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'jsshell-linux-x86_64.zip'], 13:00:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:00:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:00:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:00:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:00:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:00:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:00:25 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')]} 13:00:25 INFO - https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:28 INFO - Downloaded 24220526 bytes. 13:00:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:00:29 INFO - Return code: 0 13:00:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:29 INFO - https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:00:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:35 INFO - Downloaded 24220526 bytes. 13:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:00:36 INFO - Return code: 0 13:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:36 INFO - https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:00:37 INFO - Downloaded 14405384 bytes. 13:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:00:37 INFO - Return code: 0 13:00:37 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')]} 13:00:37 INFO - https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:00:39 INFO - Downloaded 59380999 bytes. 13:00:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:00:39 INFO - mkdir: /builds/slave/test/properties 13:00:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:00:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:00:39 INFO - Contents: 13:00:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:00:40 INFO - Running post-action listener: _resource_record_post_action 13:00:40 INFO - Running post-action listener: set_extra_try_arguments 13:00:40 INFO - ##### 13:00:40 INFO - ##### Finished download-and-extract step (success) 13:00:40 INFO - ##### 13:00:40 INFO - ##### 13:00:40 INFO - ##### Running populate-webroot step. 13:00:40 INFO - ##### 13:00:40 INFO - Running pre-action listener: _resource_record_pre_action 13:00:40 INFO - Running main action method: populate_webroot 13:00:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:40 INFO - '--tppagecycles', 13:00:40 INFO - '7'], 13:00:40 INFO - 'tests': ['tsvgm']}}, 13:00:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:00:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:00:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:00:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['damp', 'tps']}, 13:00:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'tests': ['damp', 'tps']}, 13:00:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['dromaeo_dom']}, 13:00:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['basic_compositor_video']}, 13:00:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:00:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['a11yr', 13:00:40 INFO - 'ts_paint', 13:00:40 INFO - 'tpaint', 13:00:40 INFO - 'sessionrestore', 13:00:40 INFO - 'sessionrestore_no_auto_restore', 13:00:40 INFO - 'tabpaint']}, 13:00:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['tsvgx', 13:00:40 INFO - 'tsvgr_opacity', 13:00:40 INFO - 'tart', 13:00:40 INFO - 'tscrollx', 13:00:40 INFO - 'cart']}, 13:00:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:00:40 INFO - 'tsvgr_opacity', 13:00:40 INFO - 'tart', 13:00:40 INFO - 'tscrollx', 13:00:40 INFO - 'cart']}, 13:00:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'talos_options': ['--disable-e10s'], 13:00:40 INFO - 'tests': ['tp5o']}, 13:00:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'tests': ['tp5o']}, 13:00:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'talos_options': ['--disable-e10s', 13:00:40 INFO - '--xperf_path', 13:00:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:40 INFO - 'tests': ['tp5n']}, 13:00:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:40 INFO - 'talos_options': ['--xperf_path', 13:00:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:40 INFO - 'tests': ['tp5n']}}, 13:00:40 INFO - 'talos.zip': {'path': '', 13:00:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:40 INFO - Running post-action listener: _resource_record_post_action 13:00:40 INFO - ##### 13:00:40 INFO - ##### Finished populate-webroot step (success) 13:00:40 INFO - ##### 13:00:40 INFO - ##### 13:00:40 INFO - ##### Running create-virtualenv step. 13:00:40 INFO - ##### 13:00:40 INFO - Running pre-action listener: _resource_record_pre_action 13:00:40 INFO - Running main action method: create_virtualenv 13:00:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:00:40 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 13:00:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:00:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:40 INFO - Using real prefix '/usr' 13:00:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:00:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:43 INFO - Installing pip.................done. 13:00:43 INFO - Return code: 0 13:00:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:00:43 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')]} 13:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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')]} 13:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:43 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 13:00:43 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 13:00:43 INFO - Using env: {'DISPLAY': ':0', 13:00:43 INFO - 'HOME': '/home/cltbld', 13:00:43 INFO - 'LANG': 'en_US.UTF-8', 13:00:43 INFO - 'LANGUAGE': 'en_US:en', 13:00:43 INFO - 'LOGNAME': 'cltbld', 13:00:43 INFO - 'MAIL': '/var/mail/cltbld', 13:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:43 INFO - 'MOZ_NO_REMOTE': '1', 13:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:43 INFO - 'NO_EM_RESTART': '1', 13:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:43 INFO - 'PWD': '/builds/slave/test', 13:00:43 INFO - 'SHELL': '/bin/bash', 13:00:43 INFO - 'SHLVL': '1', 13:00:43 INFO - 'TERM': 'linux', 13:00:43 INFO - 'TMOUT': '86400', 13:00:43 INFO - 'USER': 'cltbld', 13:00:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:43 INFO - '_': '/tools/buildbot/bin/python'} 13:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:43 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 13:00:43 INFO - Cleaning up... 13:00:43 INFO - Return code: 0 13:00:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:00:43 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')]} 13:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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')]} 13:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:43 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:43 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 13:00:43 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 13:00:43 INFO - Using env: {'DISPLAY': ':0', 13:00:43 INFO - 'HOME': '/home/cltbld', 13:00:43 INFO - 'LANG': 'en_US.UTF-8', 13:00:43 INFO - 'LANGUAGE': 'en_US:en', 13:00:43 INFO - 'LOGNAME': 'cltbld', 13:00:43 INFO - 'MAIL': '/var/mail/cltbld', 13:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:43 INFO - 'MOZ_NO_REMOTE': '1', 13:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:43 INFO - 'NO_EM_RESTART': '1', 13:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:43 INFO - 'PWD': '/builds/slave/test', 13:00:43 INFO - 'SHELL': '/bin/bash', 13:00:43 INFO - 'SHLVL': '1', 13:00:43 INFO - 'TERM': 'linux', 13:00:43 INFO - 'TMOUT': '86400', 13:00:43 INFO - 'USER': 'cltbld', 13:00:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:43 INFO - '_': '/tools/buildbot/bin/python'} 13:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:43 INFO - Downloading/unpacking psutil>=3.1.1 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:43 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 13:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:45 INFO - Installing collected packages: psutil 13:00:45 INFO - Running setup.py install for psutil 13:00:45 INFO - building 'psutil._psutil_linux' extension 13:00:45 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 13:00:45 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 13:00:45 INFO - building 'psutil._psutil_posix' extension 13:00:45 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 13:00:45 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 13:00:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:46 INFO - Successfully installed psutil 13:00:46 INFO - Cleaning up... 13:00:46 INFO - Return code: 0 13:00:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:46 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:46 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 13:00:46 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 13:00:46 INFO - Using env: {'DISPLAY': ':0', 13:00:46 INFO - 'HOME': '/home/cltbld', 13:00:46 INFO - 'LANG': 'en_US.UTF-8', 13:00:46 INFO - 'LANGUAGE': 'en_US:en', 13:00:46 INFO - 'LOGNAME': 'cltbld', 13:00:46 INFO - 'MAIL': '/var/mail/cltbld', 13:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:46 INFO - 'MOZ_NO_REMOTE': '1', 13:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:46 INFO - 'NO_EM_RESTART': '1', 13:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:46 INFO - 'PWD': '/builds/slave/test', 13:00:46 INFO - 'SHELL': '/bin/bash', 13:00:46 INFO - 'SHLVL': '1', 13:00:46 INFO - 'TERM': 'linux', 13:00:46 INFO - 'TMOUT': '86400', 13:00:46 INFO - 'USER': 'cltbld', 13:00:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:46 INFO - '_': '/tools/buildbot/bin/python'} 13:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:00:48 INFO - Installing collected packages: mozsystemmonitor 13:00:48 INFO - Running setup.py install for mozsystemmonitor 13:00:48 INFO - Successfully installed mozsystemmonitor 13:00:48 INFO - Cleaning up... 13:00:48 INFO - Return code: 0 13:00:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:48 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:48 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==2.5.1'] in /builds/slave/test/build 13:00:48 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==2.5.1 13:00:48 INFO - Using env: {'DISPLAY': ':0', 13:00:48 INFO - 'HOME': '/home/cltbld', 13:00:48 INFO - 'LANG': 'en_US.UTF-8', 13:00:48 INFO - 'LANGUAGE': 'en_US:en', 13:00:48 INFO - 'LOGNAME': 'cltbld', 13:00:48 INFO - 'MAIL': '/var/mail/cltbld', 13:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:48 INFO - 'MOZ_NO_REMOTE': '1', 13:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:48 INFO - 'NO_EM_RESTART': '1', 13:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:48 INFO - 'PWD': '/builds/slave/test', 13:00:48 INFO - 'SHELL': '/bin/bash', 13:00:48 INFO - 'SHLVL': '1', 13:00:48 INFO - 'TERM': 'linux', 13:00:48 INFO - 'TMOUT': '86400', 13:00:48 INFO - 'USER': 'cltbld', 13:00:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:48 INFO - '_': '/tools/buildbot/bin/python'} 13:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:48 INFO - Downloading/unpacking jsonschema==2.5.1 13:00:48 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 13:00:48 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 13:00:48 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 13:00:48 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 13:00:48 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 13:00:48 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 13:00:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:50 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:50 INFO - warning: no files found matching '*.txt' 13:00:50 INFO - no previously-included directories found matching 'build' 13:00:50 INFO - no previously-included directories found matching 'dist' 13:00:50 INFO - no previously-included directories found matching '.git*' 13:00:50 INFO - Installing collected packages: jsonschema, functools32 13:00:50 INFO - Running setup.py install for functools32 13:00:50 INFO - warning: no files found matching '*.txt' 13:00:50 INFO - no previously-included directories found matching 'build' 13:00:50 INFO - no previously-included directories found matching 'dist' 13:00:50 INFO - no previously-included directories found matching '.git*' 13:00:50 INFO - Successfully installed jsonschema functools32 13:00:50 INFO - Cleaning up... 13:00:51 INFO - Return code: 0 13:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:51 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:51 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 13:00:51 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 13:00:51 INFO - Using env: {'DISPLAY': ':0', 13:00:51 INFO - 'HOME': '/home/cltbld', 13:00:51 INFO - 'LANG': 'en_US.UTF-8', 13:00:51 INFO - 'LANGUAGE': 'en_US:en', 13:00:51 INFO - 'LOGNAME': 'cltbld', 13:00:51 INFO - 'MAIL': '/var/mail/cltbld', 13:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:51 INFO - 'MOZ_NO_REMOTE': '1', 13:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:51 INFO - 'NO_EM_RESTART': '1', 13:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:51 INFO - 'PWD': '/builds/slave/test', 13:00:51 INFO - 'SHELL': '/bin/bash', 13:00:51 INFO - 'SHLVL': '1', 13:00:51 INFO - 'TERM': 'linux', 13:00:51 INFO - 'TMOUT': '86400', 13:00:51 INFO - 'USER': 'cltbld', 13:00:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:51 INFO - '_': '/tools/buildbot/bin/python'} 13:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:51 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 13:00:51 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 13:00:51 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 13:00:51 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 13:00:51 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 13:00:51 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 13:00:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:00:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 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 13:00:53 INFO - Downloading docopt-0.6.1.tar.gz 13:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:54 INFO - Running setup.py install for blobuploader 13:00:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:00:54 INFO - Running setup.py install for requests 13:00:54 INFO - Running setup.py install for docopt 13:00:54 INFO - Successfully installed blobuploader requests docopt 13:00:54 INFO - Cleaning up... 13:00:54 INFO - Return code: 0 13:00:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00: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')]} 13:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:54 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:54 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 13:00:54 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 13:00:54 INFO - Using env: {'DISPLAY': ':0', 13:00:54 INFO - 'HOME': '/home/cltbld', 13:00:54 INFO - 'LANG': 'en_US.UTF-8', 13:00:54 INFO - 'LANGUAGE': 'en_US:en', 13:00:54 INFO - 'LOGNAME': 'cltbld', 13:00:54 INFO - 'MAIL': '/var/mail/cltbld', 13:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:54 INFO - 'MOZ_NO_REMOTE': '1', 13:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:54 INFO - 'NO_EM_RESTART': '1', 13:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:54 INFO - 'PWD': '/builds/slave/test', 13:00:54 INFO - 'SHELL': '/bin/bash', 13:00:54 INFO - 'SHLVL': '1', 13:00:54 INFO - 'TERM': 'linux', 13:00:54 INFO - 'TMOUT': '86400', 13:00:54 INFO - 'USER': 'cltbld', 13:00:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:54 INFO - '_': '/tools/buildbot/bin/python'} 13:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:54 INFO - Running setup.py (path:/tmp/pip-EYlhkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:54 INFO - Running setup.py (path:/tmp/pip-zHbxQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:55 INFO - Running setup.py (path:/tmp/pip-q6IzUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:55 INFO - Running setup.py (path:/tmp/pip-CyDgBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:55 INFO - Running setup.py (path:/tmp/pip-Sr9v5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:55 INFO - Running setup.py (path:/tmp/pip-83JDfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:55 INFO - Running setup.py (path:/tmp/pip-nkIujO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:55 INFO - Running setup.py (path:/tmp/pip-Le4SIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:55 INFO - Running setup.py (path:/tmp/pip-mDM9Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:55 INFO - Running setup.py (path:/tmp/pip-vnIsNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:55 INFO - Running setup.py (path:/tmp/pip-720zBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:55 INFO - Running setup.py (path:/tmp/pip-RBpfQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:55 INFO - Running setup.py (path:/tmp/pip-b6gRuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:55 INFO - Running setup.py (path:/tmp/pip-8rVtWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:55 INFO - Running setup.py (path:/tmp/pip-HFHbu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:55 INFO - Running setup.py (path:/tmp/pip-A9Lg1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:56 INFO - Running setup.py (path:/tmp/pip-S9zARB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:56 INFO - Running setup.py install for manifestparser 13:00:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozcrash 13:00:56 INFO - Running setup.py install for mozdebug 13:00:56 INFO - Running setup.py install for mozdevice 13:00:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozfile 13:00:56 INFO - Running setup.py install for mozhttpd 13:00:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozinfo 13:00:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozInstall 13:00:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:00:56 INFO - Running setup.py install for mozleak 13:00:56 INFO - Running setup.py install for mozlog 13:00:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for moznetwork 13:00:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozprocess 13:00:57 INFO - Running setup.py install for mozprofile 13:00:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozrunner 13:00:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Running setup.py install for mozscreenshot 13:00:57 INFO - Running setup.py install for moztest 13:00:57 INFO - Running setup.py install for mozversion 13:00:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:00:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:57 INFO - Cleaning up... 13:00:57 INFO - Return code: 0 13:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:57 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:00:57 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 13:00:57 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 13:00:57 INFO - Using env: {'DISPLAY': ':0', 13:00:57 INFO - 'HOME': '/home/cltbld', 13:00:57 INFO - 'LANG': 'en_US.UTF-8', 13:00:57 INFO - 'LANGUAGE': 'en_US:en', 13:00:57 INFO - 'LOGNAME': 'cltbld', 13:00:57 INFO - 'MAIL': '/var/mail/cltbld', 13:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:57 INFO - 'MOZ_NO_REMOTE': '1', 13:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:57 INFO - 'NO_EM_RESTART': '1', 13:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:00:57 INFO - 'PWD': '/builds/slave/test', 13:00:57 INFO - 'SHELL': '/bin/bash', 13:00:57 INFO - 'SHLVL': '1', 13:00:57 INFO - 'TERM': 'linux', 13:00:57 INFO - 'TMOUT': '86400', 13:00:57 INFO - 'USER': 'cltbld', 13:00:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:57 INFO - '_': '/tools/buildbot/bin/python'} 13:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:00:58 INFO - Running setup.py (path:/tmp/pip-QSLGe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:00:58 INFO - Running setup.py (path:/tmp/pip-oR2_Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:00:58 INFO - Running setup.py (path:/tmp/pip-UWfNSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:00:58 INFO - Running setup.py (path:/tmp/pip-HqZEgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:00:58 INFO - Running setup.py (path:/tmp/pip-Z1KfWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:00:58 INFO - Running setup.py (path:/tmp/pip-n3xU0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:00:58 INFO - Running setup.py (path:/tmp/pip-74TSUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:00:58 INFO - Running setup.py (path:/tmp/pip-09lsGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:00:58 INFO - Running setup.py (path:/tmp/pip-oa6dcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:00:58 INFO - Running setup.py (path:/tmp/pip-QZODVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:00:58 INFO - Running setup.py (path:/tmp/pip-qzCCqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:00:58 INFO - Running setup.py (path:/tmp/pip-ze_VT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:00:58 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)) 13:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:00:58 INFO - Running setup.py (path:/tmp/pip-rZPp8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:00:59 INFO - Running setup.py (path:/tmp/pip-I5ihOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:59 INFO - Running setup.py (path:/tmp/pip-LlSxKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:00:59 INFO - Running setup.py (path:/tmp/pip-q9NqAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:00:59 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)) 13:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:00:59 INFO - Running setup.py (path:/tmp/pip-C10bKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:00:59 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)) 13:00:59 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)) 13:00:59 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)) 13:00:59 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)) 13:00:59 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)) 13:00:59 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)) 13:00:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:01 INFO - Downloading blessings-1.6.tar.gz 13:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:01:01 INFO - Installing collected packages: blessings 13:01:01 INFO - Running setup.py install for blessings 13:01:01 INFO - Successfully installed blessings 13:01:01 INFO - Cleaning up... 13:01:01 INFO - Return code: 0 13:01:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:01:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:01 INFO - Reading from file tmpfile_stdout 13:01:01 INFO - Current package versions: 13:01:01 INFO - argparse == 1.2.1 13:01:01 INFO - blessings == 1.6 13:01:01 INFO - blobuploader == 1.2.4 13:01:01 INFO - docopt == 0.6.1 13:01:01 INFO - functools32 == 3.2.3-2 13:01:01 INFO - jsonschema == 2.5.1 13:01:01 INFO - manifestparser == 1.1 13:01:01 INFO - mozInstall == 1.12 13:01:01 INFO - mozcrash == 0.17 13:01:01 INFO - mozdebug == 0.1 13:01:01 INFO - mozdevice == 0.48 13:01:01 INFO - mozfile == 1.2 13:01:01 INFO - mozhttpd == 0.7 13:01:01 INFO - mozinfo == 0.9 13:01:01 INFO - mozleak == 0.1 13:01:01 INFO - mozlog == 3.2 13:01:01 INFO - moznetwork == 0.27 13:01:01 INFO - mozprocess == 0.22 13:01:01 INFO - mozprofile == 0.28 13:01:01 INFO - mozrunner == 6.11 13:01:01 INFO - mozscreenshot == 0.1 13:01:01 INFO - mozsystemmonitor == 0.3 13:01:01 INFO - moztest == 0.7 13:01:01 INFO - mozversion == 1.4 13:01:01 INFO - psutil == 3.1.1 13:01:01 INFO - requests == 1.2.3 13:01:01 INFO - wsgiref == 0.1.2 13:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01:01 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')]} 13:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:01 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')]} 13:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:01 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:01:01 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 13:01:01 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 13:01:01 INFO - Using env: {'DISPLAY': ':0', 13:01:01 INFO - 'HOME': '/home/cltbld', 13:01:01 INFO - 'LANG': 'en_US.UTF-8', 13:01:01 INFO - 'LANGUAGE': 'en_US:en', 13:01:01 INFO - 'LOGNAME': 'cltbld', 13:01:01 INFO - 'MAIL': '/var/mail/cltbld', 13:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:01 INFO - 'MOZ_NO_REMOTE': '1', 13:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:01 INFO - 'NO_EM_RESTART': '1', 13:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:01 INFO - 'PWD': '/builds/slave/test', 13:01:01 INFO - 'SHELL': '/bin/bash', 13:01:01 INFO - 'SHLVL': '1', 13:01:01 INFO - 'TERM': 'linux', 13:01:01 INFO - 'TMOUT': '86400', 13:01:01 INFO - 'USER': 'cltbld', 13:01:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:01 INFO - '_': '/tools/buildbot/bin/python'} 13:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 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)) 13:01:01 INFO - Cleaning up... 13:01:01 INFO - Return code: 0 13:01:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:01:01 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')]} 13:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:01 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')]} 13:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:01 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:01:01 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 13:01:01 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 13:01:01 INFO - Using env: {'DISPLAY': ':0', 13:01:01 INFO - 'HOME': '/home/cltbld', 13:01:01 INFO - 'LANG': 'en_US.UTF-8', 13:01:01 INFO - 'LANGUAGE': 'en_US:en', 13:01:01 INFO - 'LOGNAME': 'cltbld', 13:01:01 INFO - 'MAIL': '/var/mail/cltbld', 13:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:01 INFO - 'MOZ_NO_REMOTE': '1', 13:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:01 INFO - 'NO_EM_RESTART': '1', 13:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:01 INFO - 'PWD': '/builds/slave/test', 13:01:01 INFO - 'SHELL': '/bin/bash', 13:01:01 INFO - 'SHLVL': '1', 13:01:01 INFO - 'TERM': 'linux', 13:01:01 INFO - 'TMOUT': '86400', 13:01:01 INFO - 'USER': 'cltbld', 13:01:01 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:01 INFO - '_': '/tools/buildbot/bin/python'} 13:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:01:02 INFO - Cleaning up... 13:01:02 INFO - Return code: 0 13:01:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:01:02 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')]} 13:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:02 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')]} 13:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:02 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 0x7f0319977f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dc4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, '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': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', '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 13:01:02 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 13:01:02 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 13:01:02 INFO - Using env: {'DISPLAY': ':0', 13:01:02 INFO - 'HOME': '/home/cltbld', 13:01:02 INFO - 'LANG': 'en_US.UTF-8', 13:01:02 INFO - 'LANGUAGE': 'en_US:en', 13:01:02 INFO - 'LOGNAME': 'cltbld', 13:01:02 INFO - 'MAIL': '/var/mail/cltbld', 13:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:02 INFO - 'MOZ_NO_REMOTE': '1', 13:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:02 INFO - 'NO_EM_RESTART': '1', 13:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:02 INFO - 'PWD': '/builds/slave/test', 13:01:02 INFO - 'SHELL': '/bin/bash', 13:01:02 INFO - 'SHLVL': '1', 13:01:02 INFO - 'TERM': 'linux', 13:01:02 INFO - 'TMOUT': '86400', 13:01:02 INFO - 'USER': 'cltbld', 13:01:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:02 INFO - '_': '/tools/buildbot/bin/python'} 13:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:02 INFO - Downloading/unpacking flake8 13:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:01:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:01:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01: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 13:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:01:05 INFO - no previously-included directories found matching 'docs/_build' 13:01:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:01:05 INFO - Running setup.py install for pep8 13:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:01:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:01:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:01:05 INFO - no previously-included directories found matching 'docs/_build' 13:01:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:01:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:01:05 INFO - Cleaning up... 13:01:05 INFO - Return code: 0 13:01:05 INFO - Running post-action listener: _resource_record_post_action 13:01:05 INFO - Running post-action listener: _start_resource_monitoring 13:01:05 INFO - Starting resource monitoring. 13:01:05 INFO - ##### 13:01:05 INFO - ##### Finished create-virtualenv step (success) 13:01:05 INFO - ##### 13:01:05 INFO - ##### 13:01:05 INFO - ##### Running install step. 13:01:05 INFO - ##### 13:01:05 INFO - Running pre-action listener: _resource_record_pre_action 13:01:05 INFO - Running main action method: install 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:01:05 INFO - Reading from file tmpfile_stdout 13:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:01:05 INFO - Reading from file tmpfile_stdout 13:01:05 INFO - Output received: 13:01:05 INFO - Usage: mozinstall [options] installer 13:01:05 INFO - Options: 13:01:05 INFO - -h, --help show this help message and exit 13:01:05 INFO - -d DEST, --destination=DEST 13:01:05 INFO - Directory to install application into. [default: 13:01:05 INFO - "/builds/slave/test"] 13:01:05 INFO - --app=APP Application being installed. [default: firefox] 13:01:05 INFO - mkdir: /builds/slave/test/build/application 13:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:01:22 INFO - Reading from file tmpfile_stdout 13:01:22 INFO - Output received: 13:01:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:01:22 INFO - Running post-action listener: _resource_record_post_action 13:01:22 INFO - ##### 13:01:22 INFO - ##### Finished install step (success) 13:01:22 INFO - ##### 13:01:22 INFO - ##### 13:01:22 INFO - ##### Running run-tests step. 13:01:22 INFO - ##### 13:01:22 INFO - Running pre-action listener: _resource_record_pre_action 13:01:22 INFO - Running main action method: run_tests 13:01:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:01:22 INFO - Python 2.7.3 13:01:22 INFO - Return code: 0 13:01:22 INFO - grabbing minidump binary from tooltool 13:01: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')]} 13:01:22 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 0x1e531c0>, '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 0x1e540c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e54550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:01:22 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 13:01:22 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 13:01:22 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 13:01:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:01:22 INFO - Return code: 0 13:01:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:01:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:01:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:01:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:01:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:01:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:01:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:01:23 INFO - Return code: 0 13:01:23 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/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 13:01:23 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/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 13:01:23 INFO - Using env: {'DISPLAY': ':0', 13:01:23 INFO - 'HOME': '/home/cltbld', 13:01:23 INFO - 'LANG': 'en_US.UTF-8', 13:01:23 INFO - 'LANGUAGE': 'en_US:en', 13:01:23 INFO - 'LOGNAME': 'cltbld', 13:01:23 INFO - 'MAIL': '/var/mail/cltbld', 13:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:23 INFO - 'MOZ_NO_REMOTE': '1', 13:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:01:23 INFO - 'NO_EM_RESTART': '1', 13:01:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:23 INFO - 'PWD': '/builds/slave/test', 13:01:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:01:23 INFO - 'SHELL': '/bin/bash', 13:01:23 INFO - 'SHLVL': '1', 13:01:23 INFO - 'TERM': 'linux', 13:01:23 INFO - 'TMOUT': '86400', 13:01:23 INFO - 'USER': 'cltbld', 13:01:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354', 13:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:23 INFO - '_': '/tools/buildbot/bin/python'} 13:01:23 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/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 13:01:23 INFO - mozversion application_buildid: 20160614103029 13:01:23 INFO - mozversion application_changeset: 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd 13:01:23 INFO - mozversion application_display_name: Nightly 13:01:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:01:23 INFO - mozversion application_name: Firefox 13:01:23 INFO - mozversion application_remotingname: firefox 13:01:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:01:23 INFO - mozversion application_vendor: Mozilla 13:01:23 INFO - mozversion application_version: 50.0a1 13:01:23 INFO - mozversion platform_buildid: 20160614103029 13:01:23 INFO - mozversion platform_changeset: 367a789e26a3cc6ecb5c2ec2372a5b0369ddbddd 13:01:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:01:23 INFO - mozversion platform_version: 50.0a1 13:01:23 INFO - using testdate: 1465934483 13:01:23 INFO - actual date: 1465934483 13:01:23 INFO - starting webserver on 'localhost:47915' 13:01:23 INFO - SUITE-START | Running 2 tests 13:01:23 INFO - TEST-START | dromaeo_css 13:01:23 INFO - operating with platform_type : linux_ 13:01:23 INFO - Initialising browser for dromaeo_css test... 13:01:23 INFO - TEST-INFO | started process 14057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqykmp0/profile http://localhost:47915/getInfo.html) 13:01:28 INFO - PROCESS | 14057 | __metrics Screen width/height:1600/1200 13:01:28 INFO - PROCESS | 14057 | colorDepth:24 13:01:28 INFO - PROCESS | 14057 | Browser inner width/height: 1024/697 13:01:28 INFO - PROCESS | 14057 | __metrics 13:01:29 INFO - PROCESS | 14057 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:01:29 INFO - PROCESS | 14057 | console.error: PushService: 13:01:29 INFO - PROCESS | 14057 | stateChangeProcessEnqueue: Error transitioning state 13:01:29 INFO - PROCESS | 14057 | UnknownError 13:01:30 INFO - TEST-INFO | 14057: exit 0 13:01:30 INFO - Browser initialized. 13:01:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:30 INFO - TEST-INFO | started process 14141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqykmp0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:42 INFO - PROCESS | 14141 | RSS: Main: 173654016 13:01:42 INFO - PROCESS | 14141 | 13:02:33 INFO - PROCESS | 14141 | 1465934553160 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] 13:04:42 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47915/tests/dromaeo/cssquery-ext.html) 13:04:43 INFO - PROCESS | 14141 | RSS: Main: 261443584 13:04:43 INFO - PROCESS | 14141 | 13:07:45 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-ext.html (next: http://localhost:47915/tests/dromaeo/cssquery-jquery.html) 13:07:46 INFO - PROCESS | 14141 | RSS: Main: 258187264 13:07:46 INFO - PROCESS | 14141 | 13:10:48 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47915/tests/dromaeo/cssquery-mootools.html) 13:10:48 INFO - PROCESS | 14141 | RSS: Main: 262955008 13:10:48 INFO - PROCESS | 14141 | 13:13:51 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47915/tests/dromaeo/cssquery-prototype.html) 13:13:51 INFO - PROCESS | 14141 | RSS: Main: 258785280 13:13:51 INFO - PROCESS | 14141 | 13:16:54 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47915/tests/dromaeo/cssquery-yui.html) 13:16:55 INFO - PROCESS | 14141 | RSS: Main: 226803712 13:16:55 INFO - PROCESS | 14141 | 13:19:57 INFO - PROCESS | 14141 | Cycle 1(1): loaded http://localhost:47915/tests/dromaeo/cssquery-yui.html (next: http://localhost:47915/tests/dromaeo/cssquery-dojo.html) 13:19:58 INFO - PROCESS | 14141 | RSS: Main: 320864256 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | __start_tp_report 13:19:58 INFO - PROCESS | 14141 | _x_x_mozilla_page_load 13:19:58 INFO - PROCESS | 14141 | _x_x_mozilla_page_load_details 13:19:58 INFO - PROCESS | 14141 | |i|pagename|runs| 13:19:58 INFO - PROCESS | 14141 | |0;dojo.html;3064.9080527584165;3104.2704964333393;3105.5496952941826;3112.813231206128;3114;5441.347038355393;5457.372402173752;5464.836054918349;5579.7489112989915;5605.495505404513;5407;5461.644993075447;5464.12573988162;5513.58648101393;5582.748776305066;4861.197902346117;4929.7781599828095;4930.482299358569;4946.035523073002;5144.8713782155555;5058.140116180258;5077.796888124471;5097.949020509803;5103.464136265694;5122.487751224885;4888.804447822083;4891.828785992491;4921.753912304388;4936.3829521309835;4998.750062496861;4956.752162391866;4962.801487940478;4981.701097934136;5009.5491405773655;5028.974855125737;4975.651704380694;4997.325361076245;4998.425181104183;5011.874703132451;5035.370578677665;5322.866928326784;5400.864978375533;5481.013417584833;5488.451154884519;5561.165825126223;5882.441168089024;5913.733881975321;5935.643861368331;5937.435943585352;5938;5931.495822855062;5993.250843644544;6004.909926351108;6007.699615019275;6010.218671572711;5298.231756395339;5391.757370918318;5400.810971616014;5404.729763511808;5499.395066542677;5964.85087872798;5977.013792724239;5980.372060933626;5981.880362392815;5986.191864098378;5643.492085712223;5776.1624564437925;5777.075667893117;5777.277840269966;5783.334916484574;5836.153757705109;5882.029465138205;5898.882022359615;5924.111383292455;5928.140419639129;5843.357230704619;5872.29532456108;5882.411758824083;5890.1164825276555;5898.2332296802;5584.888302233932;5779.162021506858;5889.23439952812;5890.646561206341;5896.380880007623;4441.933370999438;4461.486929003141;4464.732116072981;4499.1451624191295;4515.68390212682;3965.088029753173;3974.6224108709625;3993.0815912340327;3993.72043956926;4025.1547175092974;5463.945360546423;5506.614536982373;5526.032944234743;5559.9444005560235;5614.382417934024;5752.07966725322;5772.855678608068;5817.331006934257;5851.239338885917;5857.6192547485125;5501.092319767274;5511.366192887869;5511.53151982078;5512.200730893998;5518.641288316247;4833.226683730657;4916.827911023097;4925.162722337212;4936.703797772145;4972.154733695281;6050.334463209044;6136.88672321611;6138.633639632459;6139.676133582418;6145.9692701536205;5946.643201407929;5947.286325640951;5948.970255148696;5950.553708471795;5993.340732519332;5874.353821079763;6032.306284777307;6037.758489660365;6097.75608975636;6131.601445906002;5835.416458354131;5846.064629659234;5848.210491583752;5854.4730974210825;5894.233749612695;5862.618929769551;5887.087501437284;5888.3228428729535;5896.7936122235515;5906.497947674496;5522.641028333306;5612.326520817528;5657.575681823962;5683.9715801420725;5690.3456102548735;5695.715214239354;5697.4587414195585;5699.5725320600295;5706.115552089433;5708.172315014383;5599.80400685974;5633.6619802811965;5639.8590035249445;5642.435756424325;5644.322681278109;5625.718714064362;5702.173184888251;5759.2512973313205;5784.4504772046585;5874.647521148745;5665.3201615806365;5682.801101961411;5688.54491640676;5699.772009119589;5703.686297253691 13:19:58 INFO - PROCESS | 14141 | |1;ext.html;600.6246096189882;614.8800983808158;638.9233292004957;652.103357882911;653.180258775237;31322.53016204756;31990.20024499389;42600.78699606498;43469.56530434695;43509.34735978963;45118;45614;45707.54292457074;45862.77068614652;46004.309935351;8973.68592099275;9098.86351704725;9135.54322283883;9137;9138.268938484905;8922.375433719642;9058.773530661752;9061.275097992146;9062.229710474618;9062.546872656374;9100.453972761623;9117.772055698595;9133.68032118876;9136.132067453615;9140.268778497704;9041.502717350542;9070.365074444791;9082;9087.818243635156;9089.091090890925;8927.687530936451;8987.595558199897;8989.37074404792;8990.505522196276;8994.86507702385;41798.79100604508;42399.57600423987;42430.15139697189;42516.78741606303;42807.143857122996;3632.4914511968345;3680.3191409589313;3772.320982223199;3802.904927376838;4127.153933443637;32582.6741732582;32625.51061734076;32798.50802237968;32977.175570610685;33208.16979575506;4018.718689691723;4025.1547175093265;4027.8388864445387;4030.7380020298588;4076.5719599441927;331087;331264.9999999976;331488;333576;335021;57870.710646446496;58742.41257587455;58890.70554647285;58903.410965889794;58927.116093258635;54002.18996715052;59457;60794.392056078876;60857.69571152116;66313;17274.395396161075;17347;17433.302667893397;17441;17452;12379;12682.556110536087;12758.362081895868;12761.808572871414;12763.617091487271;16181.757273640906;16351.91824040896;16629.417970370978;16936.153192340334;16948.83051169497;6240.2870292176085;6381;6423;6435.806925792233;6448.001119652922;910.4628269321132;922.9861552076724;1021.1422405179685;1060.9734756631146;1117.4859564600374;31547.36905261882;32153;32383.352332953207;32481.187970300933;32747.345053098805;1120.6021862238788;1180.740237147826;1187.3232257613079;1198.748262864808;1201.141184053406;16777.328906843588;16817.49547513552;16840;16943.491695249162;17004.744928826076;475386;475843;476299;478073;479897;56822;58329;58389;58445.415545844;58551;1247.7754004279318;1290.2129700882454;1292.6962163891478;1382.2121390807345;1395.6789938314041;25215.621765673895;32859.83570082134;33344.49983250205;35533.789237557256;35888.8205558981;49943.00113997772;61615.69192154011;61741.691291543255;65434;66893;453641;463435;464589;464636;466971;40080.1983960325;44986.32520512129;45719.54280457153;45986.540134598225;47025.29462058003;50282.497175029246;50425;51582.48417515927;52187.73906130445;52213.47786522238;42345;43561.782191088845;43574.12851743011;43721.344179837964;44354;42667.988598339325;43220.56779432166;43387;43773.78113109414;43777.781111095515;42539.5746042548;43058.354124687525;43253;43629;44018.779906100266;36176.45735314025;38341.42487862628;38518;38646.6135338643;38949.6105038946;28125.296867578476;28339.291517712223;28396.102029284873;28396.148115556567;28687.569686455136 13:19:58 INFO - PROCESS | 14141 | |2;jquery.html;390.1961958365765;395.4246571238848;395.8673844262172;398.7308566717466;412.5173546950068;14365.598251231157;17491.650166996653;18339.908300458497;19915.103820328102;19917.99999999998;15398.69202615947;15874.206289685528;18348.541286467844;18665.626687466243;18784.62430751384;4975.129352363331;5264.842054738364;5270.868228294285;5274.4198138204765;5275.657082289639;3853.537575490931;5176.922346164811;5306.177542480922;5311.760970756325;5314.123169676998;5543.445655434464;5817.360090390053;5823.4467725566;5915.704214789265;5923.555733320019;5438.91841622376;5726.169705392695;5854.941450585504;5876.76492940284;5885.087811389241;5627.915581266284;5642.830715078554;5655.830325090254;5659.717014149276;5662.858428539278;13582.660433489144;21045.368638940858;23047.53904921909;23923.521529569483;24000;2279.8518096323687;2435.8538487690794;2671.905697445988;2822.5625028120676;3010.1722026442685;9684.349035303258;10245.436500992442;10500;10549.9472502637;10627.28726854946;1877.2772482594164;2000.2297966299784;2006.8294194993443;2041.6835390514493;2055;81225;83031.16968830295;84720.15279847245;85818.14181858164;85922.57038714828;10987.175961802737;11180.832287515694;11199.328040317607;11232.438378081064;11443.313401195956;15559.611009724622;15683.451079212173;15686.607834804221;15697.607559811097;15742.68514629701;7251.419886409075;7989.400794940403;8192.590370481452;8235;8419.326453883674;7996.280334769783;8001.5599142046585;8043.919560804434;8316.085230624627;8350.83298334042;4680.297955306663;4682.812687492462;4692.53074692528;4726.645501587326;4832.589229915427;1935.748352714138;1959.6570600144917;1996.241428257282;2011.2558353409331;2040.7449068866392;920.6731610278255;942.2320808541017;967.9951600241953;973.8654467545372;1044.3472829481575;19564.21743130259;19927.60144797096;19994.300199492947;20290.79709202889;20303.796962030192;979.2117345536769;1004.6835246897203;1036.7563622548696;1095.1020163466042;1097.155190503308;10953.890461095287;11471.426428678533;11547.595834145932;11573.652790416301;11582.36297003673;241070;475017;500201;502409;503931;97797;101138;104039;105466;106440.46779766206;1002.2810879341963;1035.5288343803552;1056.1920131099714;1068.8396740488988;1075.8816530181673;18145.727814082536;18171.09144542794;18620.16209270613;18696.35033602256;18794.906025469783;41892.79053604713;43155;43708.56291437045;44041.339379908684;44438.77780611076;42669.573304267804;60412.697936510034;61099;62029;62890.371096290284;8661.826763464822;8872.556372181494;8939.957889694908;9005.81988360216;9008.954955225181;9702.078302561245;13275.734485310433;13558.593242202749;13608.86391136076;13996.650083747987;11962.461689223832;12302.692432688897;12445.191062580903;12474.18917770342;12493.75012499763;12060.819087713517;12087.274763514217;12149.392530373623;12243.877561224273;12420.503179872703;12224.87775122273;12311.138220324492;12557.309347985583;12691;12816.166949148275;8350.039745429354;8385.874211886949;8538.060813310407;8562.058173601023;8937.776555586162;11637.301761894314;12078.698032549257;12285.078619103782;12315.69210769738;12317.630471085882 13:19:58 INFO - PROCESS | 14141 | |3;mootools.html;1298.9285589292585;1450.5575799381188;1525.4355888321322;1629.5926018495377;1778.0576294563878;8478.618462169201;8779.956100219506;8781.692640757576;9106.63573457061;9113.589888455019;8836.293096552277;9049.819003619923;9120.726378208648;9138.360314777969;9141.725748227564;2072.4300817275293;2291.702078729763;2351.3886389538716;2357.446000189954;2379.0602711928777;2343.9765602344014;2350.048230466664;2351.0478256306224;2355.034435881289;2356.7171939367213;2333.696619439479;2346.85918844869;2382.4639456122322;2382.642603609464;2385.0936644075227;1990.044778506325;2182.90176942038;2256.334381357487;2258.672492488596;2287.633978563422;2332.0671731307443;2350.1891847312822;2365.219477572397;2365.976340236593;2373.050779688121;9263.536823158882;9308.906910930871;9379.624815007392;9381.953090234574;9387.76530586734;5326.547243484309;5414.3232095988005;5452.454754524555;5459.808906688287;5462.235287059815;3130.311331507065;3351.3967485852536;3409.539712138854;3414.4878268259713;3416.197193659488;1089.9400133747224;1098.8681657892305;1113.8106521891216;1136.6874109619837;1144.7596004838995;12802.80795788064;12806.871931280568;12834.229946203257;12835.743285134338;12841.422136003903;4651.441826980784;4749.928751068736;4824.252240902666;4846.982133751952;4847.587955023792;10485.947570262253;10591.84112238317;10595.417252051211;10626.681199564026;10626.787464250672;5263.894722105613;5303.04545181871;5307.708076055854;5308.973455132699;5320.52115309624;4430.62339701129;4880.41435027799;5014.047331007097;5016.673916195508;5102.693838369635;4036.4216652586565;4055.6349928506575;4122.196171746481;4126.360414135814;4158.293090174678;1292.3409061378577;1302.4529697527062;1312.8162057311984;1315.1188703568632;1324.8608896065966;864.394923553515;987.3286165407449;1018.0821319136485;1020.1583693452783;1044.8276034454382;6145.784897528565;6167.84580385494;6309.14826498426;6327.303996560375;6369.872602547923;444.94660640722674;448.0098981251406;453.1209453659955;462.38733677876945;471.1237098995865;4333.674974376934;4342.08816148606;4353.085851971122;4360.6729495287345;4378.2994720845145;10950.507227174796;11329.263597866113;11395.088392928546;11405.543778248943;11444.771104578029;10616.575336986434;11206.439678016066;11225.438728063564;11240.55037798479;11247.83128253077;8206.876896846552;8326.084130745734;8377.162283771575;8402.621882015324;8405.285550728257;6072.119542666201;6340.397662222082;6393.6163830170335;6410.070539771614;6453.806385808433;9987.800243995225;10317.27779055489;10321.329113607591;10376.740581485523;10436.060754532129;10509.684709458728;10538.998795114452;10756.677299681021;10921.453927303444;10930.617428389969;7396.112466504054;7631.465797394129;7634.427417943787;8010.559419231999;8232.876506852523;8358.122397148456;8463.36524760633;8478.618462169094;8545.273651739422;8707.259882910024;7687.346575541142;7848.84302313962;7937.8412431752195;8063.6774529018185;8208.425410221227;7884.881726774218;7918.524888506708;7974.202579741979;8101.392395570238;8130.87803682957;7203.603801790951;7218.927810722035;7255.4921155520715;7279.308465695751;7291.453141014551;5364;5441.564674826083;5461.399246082849;5512.283403157564;5553.278073850373;5124.410692770379;5335.599830012687;5440.129579267298;5490.1764735288425;5621.409751975983 13:19:58 INFO - PROCESS | 14141 | |4;prototype.html;325.45811224311524;339.55009612263757;339.9694027537522;342.4572053295525;344.2237753865034;5288.814891478799;5335.866603334918;5342.2253773202865;5356.705381204032;5382.366902340914;5276.630635855492;5278.155495120782;5306.257124002633;5307.52232299093;5317.255584218203;3876.7867767272787;4157.584241575833;4163.0008797888595;4184.430838435579;4224.873253802375;4076.001379661987;4104.97947510262;4126.793660316987;4138.875833724978;4143.564925682806;4080.6123418275215;4085.7957102144924;4085.9591404086023;4093.7953102344763;4107.014316564018;3897.66869816066;3949.3878448840333;4097.242010228118;4098.200850834089;4101.282275601788;3609.151849315409;3628.727845411578;3630.8729194478333;3648.434492653643;3657.683234035745;4917.9426423319155;5138.7173705446185;5153.433122356538;5175.974120129413;5214.940098661008;4595.4025976622825;4667;4673.247532175435;4683.718976861365;4768.5946694531;5506.394296627368;5511.944880551183;5513.8345849624575;5553.222548843165;5590.944090559083;3792.1467669774356;3973.443717879499;3994.2211268802594;3994.4807175067053;4000.699947503949;5736.7992120276;5739.139129130622;5744.655320680731;5771.163181338724;5785.971070144622;4032.5765794591734;4040.0709485622688;4040.5353384360587;4040.8989775255855;4047.7571345719352;4085.9387109193385;4097.385392191195;4110.260153172458;4114.341705327193;4128.525219599725;4522.8643140705835;4700.482946875841;4714.986277950257;4717.693349932243;4724.71651700899;5554.50009499147;5577.972110139423;5598.776048957996;5600.27196464457;5607.243022192033;1416.4617445370693;1435.5191011011427;1439.7192547453355;1443.3937746146644;1448.7681970884607;944.9385789923633;986.2011770465803;992.8758905136858;999.1107913956585;999.1207737191226;5219.295395121686;5344.5724342052545;5363.704996225245;5365.463453654604;5375.623706340519;5595.356533998561;5614.466625670555;5624;5666.829995100154;5704.942950570524;5156.871078222999;5176.7411629418375;5310.9734451327495;5325.414204437587;5339;3008.3080891395102;3008.7592992560544;3021.8942337018098;3035.5446682997726;3041.5893854329825;5836.970815145982;5868.647881127146;5889.587728858939;5898.705064746746;5904.645721256738;5565.3599836019375;5806.187133801272;5828.504577110908;5849.239598852207;5902.852428689317;5788.797392091173;5867.5305975521005;5924.822255332347;5925.644461332334;5944.524438044946;5431.728413579226;5680.261565996394;5714.857028594381;5716.742746576498;5778.624389414675;5636.435421883115;5657.924994251079;5678.716064196857;5714.257146570919;5726.79737255181;5857;5861.853453663522;5884.176215329943;5928.584999050025;5943.91084133747;4071.633552980246;4184.853530126431;4206.6634669227;4208.894777630584;4222.408862759277;5595.384507704068;5688.63023903445;5694.943050569441;5718;5743.869591072958;5389.59578031657;5478.753456094565;5550.028744969695;5590.468905453975;5623.943760562505;5508.641938274;5512.972435137799;5525.530329922001;5527.391986881359;5535.806246781343;5399.5950303726595;5412.296401467784;5413.215083812904;5426.70153141581;5444.3194600674915;5389.919151212656;5525.392206857323;5548.445155484581;5568.582356323211;5581.246531718166;5407.567394608343;5434.456554344534;5446.700431476307;5453.890922181455;5469.15228139639 13:19:58 INFO - PROCESS | 14141 | |5;yui.html;742.2911119880515;745.4260219630888;780.9101953275375;844.8774927635491;872.720729366603;15606;16575.419860304894;16647.167641617914;16744.916275418607;16771.66456670866;12228.571999980002;15054.473093441731;15219.61950951224;15224;15249.771253431207;784.2823816208177;802.8474589827944;807.1283014344494;816.3306089007017;816.4692949582759;793.6785601831267;795.1690483444814;798.4690181029608;798.6366203377478;801.210807354755;697.069412334534;847.2332539052168;849.2399302624148;849.413904405961;849.4903058165113;828.4283844147549;839.345310657688;841.5581819544727;844.1389782421895;845.6067928413256;616.2358675242667;616.8057062025448;616.808789275326;616.9598976066542;617.213053356969;14462.71074578513;14508.274586270643;14521.346539405646;14528.854711452856;14586.854131458656;13995;14316.42734290627;14342.354594043292;14371.568852934428;14375.353109110116;12654.746905061847;12753.61739147827;12841.743165136739;12880.80678789819;12885.87114128856;3793.3551296279697;3913.491246137984;3949.881503554898;3977.2642061218767;4007.499062617173;67764;69044.6547767258;79809.60095199545;79817.60091199506;80007.59996199982;10528.26302158857;10774.353538787698;10811.243212975016;10816.329564997584;11226.831597526043;19716.112774925165;19722.408327750192;19728.112234949174;19735.210591576175;19742.90128549348;8492.70275540353;8747.51888646118;9000.8649870252;9085.81828363429;9097.408668436663;4820.68665536739;4855.101806165871;4876.786496277673;4907.631927605373;4949.678270912379;3561.71506279497;3632.9273414531563;3649.197176621139;3677.282929828658;3678.1356381250384;626.3923993726079;640.3660376227501;645.7287939065603;645.9160309159779;655.8458762190882;681.7273090763734;683.8427161752725;708.7023450150846;708.8475977664826;733.336330620789;9170;9446.291528135418;9551.856722149174;9692.321537492307;9872.753181170385;662.9801105966828;699.951003429755;710.9786706398817;711.7651175112201;719.5394947233774;4668.789904454307;5282.735863206824;5431.21247419122;5451.563874889999;5508.898220355944;88692.55653721691;91483.54258228667;92020;103884.48057759662;108282;85984;86792;89769;90016.09983900208;90418;73123.63438182882;80086;81837;82981;83909;10086.949565252127;10420.270581059556;10468.162546996069;10514.789704206027;10570.8414373786;46446.767766160956;47141.17152970833;47430;47483.76258118687;47763;62550;64186.358136419905;65920.67039664963;71523.28476715166;72114;13024.869751302365;13107.344632768132;13133.343332833128;13140.737185256432;14119.523175134567;14976.550703478913;15126.773098403313;15494.380224790882;15649.530514084596;15663.608409789846;14077.436902524194;14342.85657143457;14633.634159146106;14704.191269480281;14780.260986950825;14323.427062917366;14332.928335358256;14498.637534061732;14580.85419145795;14966.17686027279;13937.442502299795;14591.562253132422;14599.416023359372;14709.190994495406;15109.697806044038;11403.828942566033;11762.470688819194;11940.880591194324;12138.878611214128;12404.379781010733;11118.888811111785;11368.374739389414;12060.457279422271;12447.439865205906;12457.688557785765 13:19:58 INFO - PROCESS | 14141 | __end_tp_report 13:19:58 INFO - PROCESS | 14141 | __start_cc_report 13:19:58 INFO - PROCESS | 14141 | _x_x_mozilla_cycle_collect,994 13:19:58 INFO - PROCESS | 14141 | __end_cc_report 13:19:58 INFO - PROCESS | 14141 | __startTimestamp1465935598022__endTimestamp 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | ------- Summary: start ------- 13:19:58 INFO - PROCESS | 14141 | Number of tests: 6 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#0] dojo.html Cycles:165 Average:5443.66 Median:5642.44 stddev:635.28 (11.3%) stddev-sans-first:609.20 13:19:58 INFO - PROCESS | 14141 | Values: 3064.9 3104.3 3105.5 3112.8 3114.0 5441.3 5457.4 5464.8 5579.7 5605.5 5407.0 5461.6 5464.1 5513.6 5582.7 4861.2 4929.8 4930.5 4946.0 5144.9 5058.1 5077.8 5097.9 5103.5 5122.5 4888.8 4891.8 4921.8 4936.4 4998.8 4956.8 4962.8 4981.7 5009.5 5029.0 4975.7 4997.3 4998.4 5011.9 5035.4 5322.9 5400.9 5481.0 5488.5 5561.2 5882.4 5913.7 5935.6 5937.4 5938.0 5931.5 5993.3 6004.9 6007.7 6010.2 5298.2 5391.8 5400.8 5404.7 5499.4 5964.9 5977.0 5980.4 5981.9 5986.2 5643.5 5776.2 5777.1 5777.3 5783.3 5836.2 5882.0 5898.9 5924.1 5928.1 5843.4 5872.3 5882.4 5890.1 5898.2 5584.9 5779.2 5889.2 5890.6 5896.4 4441.9 4461.5 4464.7 4499.1 4515.7 3965.1 3974.6 3993.1 3993.7 4025.2 5463.9 5506.6 5526.0 5559.9 5614.4 5752.1 5772.9 5817.3 5851.2 5857.6 5501.1 5511.4 5511.5 5512.2 5518.6 4833.2 4916.8 4925.2 4936.7 4972.2 6050.3 6136.9 6138.6 6139.7 6146.0 5946.6 5947.3 5949.0 5950.6 5993.3 5874.4 6032.3 6037.8 6097.8 6131.6 5835.4 5846.1 5848.2 5854.5 5894.2 5862.6 5887.1 5888.3 5896.8 5906.5 5522.6 5612.3 5657.6 5684.0 5690.3 5695.7 5697.5 5699.6 5706.1 5708.2 5599.8 5633.7 5639.9 5642.4 5644.3 5625.7 5702.2 5759.3 5784.5 5874.6 5665.3 5682.8 5688.5 5699.8 5703.7 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#1] ext.html Cycles:180 Average:59853.62 Median:43535.56 stddev:113376.75 (260.4%) stddev-sans-first:113607.52 13:19:58 INFO - PROCESS | 14141 | Values: 600.6 614.9 638.9 652.1 653.2 31322.5 31990.2 42600.8 43469.6 43509.3 45118.0 45614.0 45707.5 45862.8 46004.3 8973.7 9098.9 9135.5 9137.0 9138.3 8922.4 9058.8 9061.3 9062.2 9062.5 9100.5 9117.8 9133.7 9136.1 9140.3 9041.5 9070.4 9082.0 9087.8 9089.1 8927.7 8987.6 8989.4 8990.5 8994.9 41798.8 42399.6 42430.2 42516.8 42807.1 3632.5 3680.3 3772.3 3802.9 4127.2 32582.7 32625.5 32798.5 32977.2 33208.2 4018.7 4025.2 4027.8 4030.7 4076.6 331087.0 331265.0 331488.0 333576.0 335021.0 57870.7 58742.4 58890.7 58903.4 58927.1 54002.2 59457.0 60794.4 60857.7 66313.0 17274.4 17347.0 17433.3 17441.0 17452.0 12379.0 12682.6 12758.4 12761.8 12763.6 16181.8 16351.9 16629.4 16936.2 16948.8 6240.3 6381.0 6423.0 6435.8 6448.0 910.5 923.0 1021.1 1061.0 1117.5 31547.4 32153.0 32383.4 32481.2 32747.3 1120.6 1180.7 1187.3 1198.7 1201.1 16777.3 16817.5 16840.0 16943.5 17004.7 475386.0 475843.0 476299.0 478073.0 479897.0 56822.0 58329.0 58389.0 58445.4 58551.0 1247.8 1290.2 1292.7 1382.2 1395.7 25215.6 32859.8 33344.5 35533.8 35888.8 49943.0 61615.7 61741.7 65434.0 66893.0 453641.0 463435.0 464589.0 464636.0 466971.0 40080.2 44986.3 45719.5 45986.5 47025.3 50282.5 50425.0 51582.5 52187.7 52213.5 42345.0 43561.8 43574.1 43721.3 44354.0 42668.0 43220.6 43387.0 43773.8 43777.8 42539.6 43058.4 43253.0 43629.0 44018.8 36176.5 38341.4 38518.0 38646.6 38949.6 28125.3 28339.3 28396.1 28396.1 28687.6 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#2] jquery.html Cycles:180 Average:28178.50 Median:23485.53 stddev:75885.62 (323.1%) stddev-sans-first:76069.81 13:19:58 INFO - PROCESS | 14141 | Values: 390.2 395.4 395.9 398.7 412.5 14365.6 17491.7 18339.9 19915.1 19918.0 15398.7 15874.2 18348.5 18665.6 18784.6 4975.1 5264.8 5270.9 5274.4 5275.7 3853.5 5176.9 5306.2 5311.8 5314.1 5543.4 5817.4 5823.4 5915.7 5923.6 5438.9 5726.2 5854.9 5876.8 5885.1 5627.9 5642.8 5655.8 5659.7 5662.9 13582.7 21045.4 23047.5 23923.5 24000.0 2279.9 2435.9 2671.9 2822.6 3010.2 9684.3 10245.4 10500.0 10549.9 10627.3 1877.3 2000.2 2006.8 2041.7 2055.0 81225.0 83031.2 84720.2 85818.1 85922.6 10987.2 11180.8 11199.3 11232.4 11443.3 15559.6 15683.5 15686.6 15697.6 15742.7 7251.4 7989.4 8192.6 8235.0 8419.3 7996.3 8001.6 8043.9 8316.1 8350.8 4680.3 4682.8 4692.5 4726.6 4832.6 1935.7 1959.7 1996.2 2011.3 2040.7 920.7 942.2 968.0 973.9 1044.3 19564.2 19927.6 19994.3 20290.8 20303.8 979.2 1004.7 1036.8 1095.1 1097.2 10953.9 11471.4 11547.6 11573.7 11582.4 241070.0 475017.0 500201.0 502409.0 503931.0 97797.0 101138.0 104039.0 105466.0 106440.5 1002.3 1035.5 1056.2 1068.8 1075.9 18145.7 18171.1 18620.2 18696.4 18794.9 41892.8 43155.0 43708.6 44041.3 44438.8 42669.6 60412.7 61099.0 62029.0 62890.4 8661.8 8872.6 8940.0 9005.8 9009.0 9702.1 13275.7 13558.6 13608.9 13996.7 11962.5 12302.7 12445.2 12474.2 12493.8 12060.8 12087.3 12149.4 12243.9 12420.5 12224.9 12311.1 12557.3 12691.0 12816.2 8350.0 8385.9 8538.1 8562.1 8937.8 11637.3 12078.7 12285.1 12315.7 12317.6 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#3] mootools.html Cycles:180 Average:5959.97 Median:457.75 stddev:3439.45 (751.4%) stddev-sans-first:3431.26 13:19:58 INFO - PROCESS | 14141 | Values: 1298.9 1450.6 1525.4 1629.6 1778.1 8478.6 8780.0 8781.7 9106.6 9113.6 8836.3 9049.8 9120.7 9138.4 9141.7 2072.4 2291.7 2351.4 2357.4 2379.1 2344.0 2350.0 2351.0 2355.0 2356.7 2333.7 2346.9 2382.5 2382.6 2385.1 1990.0 2182.9 2256.3 2258.7 2287.6 2332.1 2350.2 2365.2 2366.0 2373.1 9263.5 9308.9 9379.6 9382.0 9387.8 5326.5 5414.3 5452.5 5459.8 5462.2 3130.3 3351.4 3409.5 3414.5 3416.2 1089.9 1098.9 1113.8 1136.7 1144.8 12802.8 12806.9 12834.2 12835.7 12841.4 4651.4 4749.9 4824.3 4847.0 4847.6 10485.9 10591.8 10595.4 10626.7 10626.8 5263.9 5303.0 5307.7 5309.0 5320.5 4430.6 4880.4 5014.0 5016.7 5102.7 4036.4 4055.6 4122.2 4126.4 4158.3 1292.3 1302.5 1312.8 1315.1 1324.9 864.4 987.3 1018.1 1020.2 1044.8 6145.8 6167.8 6309.1 6327.3 6369.9 444.9 448.0 453.1 462.4 471.1 4333.7 4342.1 4353.1 4360.7 4378.3 10950.5 11329.3 11395.1 11405.5 11444.8 10616.6 11206.4 11225.4 11240.6 11247.8 8206.9 8326.1 8377.2 8402.6 8405.3 6072.1 6340.4 6393.6 6410.1 6453.8 9987.8 10317.3 10321.3 10376.7 10436.1 10509.7 10539.0 10756.7 10921.5 10930.6 7396.1 7631.5 7634.4 8010.6 8232.9 8358.1 8463.4 8478.6 8545.3 8707.3 7687.3 7848.8 7937.8 8063.7 8208.4 7884.9 7918.5 7974.2 8101.4 8130.9 7203.6 7218.9 7255.5 7279.3 7291.5 5364.0 5441.6 5461.4 5512.3 5553.3 5124.4 5335.6 5440.1 5490.2 5621.4 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#4] prototype.html Cycles:180 Average:4672.37 Median:5360.21 stddev:1369.87 (25.6%) stddev-sans-first:1334.29 13:19:58 INFO - PROCESS | 14141 | Values: 325.5 339.6 340.0 342.5 344.2 5288.8 5335.9 5342.2 5356.7 5382.4 5276.6 5278.2 5306.3 5307.5 5317.3 3876.8 4157.6 4163.0 4184.4 4224.9 4076.0 4105.0 4126.8 4138.9 4143.6 4080.6 4085.8 4086.0 4093.8 4107.0 3897.7 3949.4 4097.2 4098.2 4101.3 3609.2 3628.7 3630.9 3648.4 3657.7 4917.9 5138.7 5153.4 5176.0 5214.9 4595.4 4667.0 4673.2 4683.7 4768.6 5506.4 5511.9 5513.8 5553.2 5590.9 3792.1 3973.4 3994.2 3994.5 4000.7 5736.8 5739.1 5744.7 5771.2 5786.0 4032.6 4040.1 4040.5 4040.9 4047.8 4085.9 4097.4 4110.3 4114.3 4128.5 4522.9 4700.5 4715.0 4717.7 4724.7 5554.5 5578.0 5598.8 5600.3 5607.2 1416.5 1435.5 1439.7 1443.4 1448.8 944.9 986.2 992.9 999.1 999.1 5219.3 5344.6 5363.7 5365.5 5375.6 5595.4 5614.5 5624.0 5666.8 5704.9 5156.9 5176.7 5311.0 5325.4 5339.0 3008.3 3008.8 3021.9 3035.5 3041.6 5837.0 5868.6 5889.6 5898.7 5904.6 5565.4 5806.2 5828.5 5849.2 5902.9 5788.8 5867.5 5924.8 5925.6 5944.5 5431.7 5680.3 5714.9 5716.7 5778.6 5636.4 5657.9 5678.7 5714.3 5726.8 5857.0 5861.9 5884.2 5928.6 5943.9 4071.6 4184.9 4206.7 4208.9 4222.4 5595.4 5688.6 5694.9 5718.0 5743.9 5389.6 5478.8 5550.0 5590.5 5623.9 5508.6 5513.0 5525.5 5527.4 5535.8 5399.6 5412.3 5413.2 5426.7 5444.3 5389.9 5525.4 5548.4 5568.6 5581.2 5407.6 5434.5 5446.7 5453.9 5469.2 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - PROCESS | 14141 | [#5] yui.html Cycles:180 Average:19675.45 Median:47456.88 stddev:26729.26 (56.3%) stddev-sans-first:26766.44 13:19:58 INFO - PROCESS | 14141 | Values: 742.3 745.4 780.9 844.9 872.7 15606.0 16575.4 16647.2 16744.9 16771.7 12228.6 15054.5 15219.6 15224.0 15249.8 784.3 802.8 807.1 816.3 816.5 793.7 795.2 798.5 798.6 801.2 697.1 847.2 849.2 849.4 849.5 828.4 839.3 841.6 844.1 845.6 616.2 616.8 616.8 617.0 617.2 14462.7 14508.3 14521.3 14528.9 14586.9 13995.0 14316.4 14342.4 14371.6 14375.4 12654.7 12753.6 12841.7 12880.8 12885.9 3793.4 3913.5 3949.9 3977.3 4007.5 67764.0 69044.7 79809.6 79817.6 80007.6 10528.3 10774.4 10811.2 10816.3 11226.8 19716.1 19722.4 19728.1 19735.2 19742.9 8492.7 8747.5 9000.9 9085.8 9097.4 4820.7 4855.1 4876.8 4907.6 4949.7 3561.7 3632.9 3649.2 3677.3 3678.1 626.4 640.4 645.7 645.9 655.8 681.7 683.8 708.7 708.8 733.3 9170.0 9446.3 9551.9 9692.3 9872.8 663.0 700.0 711.0 711.8 719.5 4668.8 5282.7 5431.2 5451.6 5508.9 88692.6 91483.5 92020.0 103884.5 108282.0 85984.0 86792.0 89769.0 90016.1 90418.0 73123.6 80086.0 81837.0 82981.0 83909.0 10086.9 10420.3 10468.2 10514.8 10570.8 46446.8 47141.2 47430.0 47483.8 47763.0 62550.0 64186.4 65920.7 71523.3 72114.0 13024.9 13107.3 13133.3 13140.7 14119.5 14976.6 15126.8 15494.4 15649.5 15663.6 14077.4 14342.9 14633.6 14704.2 14780.3 14323.4 14332.9 14498.6 14580.9 14966.2 13937.4 14591.6 14599.4 14709.2 15109.7 11403.8 11762.5 11940.9 12138.9 12404.4 11118.9 11368.4 12060.5 12447.4 12457.7 13:19:58 INFO - PROCESS | 14141 | -------- Summary: end -------- 13:19:58 INFO - PROCESS | 14141 | 13:19:58 INFO - TEST-INFO | 14141: exit 0 13:19:58 INFO - TEST-OK | dromaeo_css | took 1115068ms 13:19:58 INFO - TEST-START | kraken 13:19:58 INFO - operating with platform_type : linux_ 13:19:58 INFO - Initialising browser for kraken test... 13:19:58 INFO - TEST-INFO | started process 14333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqR1MMo/profile http://localhost:47915/getInfo.html) 13:20:03 INFO - PROCESS | 14333 | __metrics Screen width/height:1600/1200 13:20:03 INFO - PROCESS | 14333 | colorDepth:24 13:20:03 INFO - PROCESS | 14333 | Browser inner width/height: 1024/697 13:20:03 INFO - PROCESS | 14333 | __metrics 13:20:04 INFO - PROCESS | 14333 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:20:04 INFO - PROCESS | 14333 | console.error: PushService: 13:20:04 INFO - PROCESS | 14333 | stateChangeProcessEnqueue: Error transitioning state 13:20:04 INFO - PROCESS | 14333 | UnknownError 13:20:05 INFO - TEST-INFO | 14333: exit 0 13:20:05 INFO - Browser initialized. 13:20:05 INFO - Running cycle 1/1 for kraken test... 13:20:05 INFO - TEST-INFO | started process 14415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqR1MMo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:17 INFO - PROCESS | 14415 | RSS: Main: 174223360 13:20:17 INFO - PROCESS | 14415 | 13:20:19 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-beat-detection) 13:20:20 INFO - PROCESS | 14415 | RSS: Main: 232456192 13:20:20 INFO - PROCESS | 14415 | 13:20:23 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-dft) 13:20:23 INFO - PROCESS | 14415 | RSS: Main: 220835840 13:20:23 INFO - PROCESS | 14415 | 13:20:27 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-fft) 13:20:27 INFO - PROCESS | 14415 | RSS: Main: 286449664 13:20:27 INFO - PROCESS | 14415 | 13:20:29 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47915/tests/kraken/driver.html?testName=audio-oscillator) 13:20:30 INFO - PROCESS | 14415 | RSS: Main: 197550080 13:20:30 INFO - PROCESS | 14415 | 13:20:32 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:20:33 INFO - PROCESS | 14415 | RSS: Main: 201465856 13:20:33 INFO - PROCESS | 14415 | 13:20:36 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:36 INFO - PROCESS | 14415 | RSS: Main: 236183552 13:20:36 INFO - PROCESS | 14415 | 13:20:40 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47915/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:40 INFO - PROCESS | 14415 | RSS: Main: 237985792 13:20:40 INFO - PROCESS | 14415 | 13:20:43 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47915/tests/kraken/driver.html?testName=json-parse-financial) 13:20:44 INFO - PROCESS | 14415 | RSS: Main: 238579712 13:20:44 INFO - PROCESS | 14415 | 13:20:45 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47915/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:46 INFO - PROCESS | 14415 | RSS: Main: 226103296 13:20:46 INFO - PROCESS | 14415 | 13:20:47 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:48 INFO - PROCESS | 14415 | RSS: Main: 231931904 13:20:48 INFO - PROCESS | 14415 | 13:20:50 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:51 INFO - PROCESS | 14415 | RSS: Main: 238174208 13:20:51 INFO - PROCESS | 14415 | 13:20:53 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:54 INFO - PROCESS | 14415 | RSS: Main: 237764608 13:20:54 INFO - PROCESS | 14415 | 13:20:57 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:57 INFO - PROCESS | 14415 | RSS: Main: 238661632 13:20:57 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | Cycle 1(1): loaded http://localhost:47915/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47915/tests/kraken/driver.html?testName=ai-astar) 13:20:59 INFO - PROCESS | 14415 | RSS: Main: 282259456 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | __start_tp_report 13:20:59 INFO - PROCESS | 14415 | _x_x_mozilla_page_load 13:20:59 INFO - PROCESS | 14415 | _x_x_mozilla_page_load_details 13:20:59 INFO - PROCESS | 14415 | |i|pagename|runs| 13:20:59 INFO - PROCESS | 14415 | |0;ai-astar;112;107;111;110;111;112;110;111;110;111 13:20:59 INFO - PROCESS | 14415 | |1;audio-beat-detection;151;129;129;180;130;126;161;124;159;125 13:20:59 INFO - PROCESS | 14415 | |2;audio-dft;160;161;160;160;160;163;161;161;160;162 13:20:59 INFO - PROCESS | 14415 | |3;audio-fft;75;75;76;128;74;75;75;74;97;75 13:20:59 INFO - PROCESS | 14415 | |4;audio-oscillator;86;85;120;86;85;86;114;85;84;128 13:20:59 INFO - PROCESS | 14415 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;116;117;117 13:20:59 INFO - PROCESS | 14415 | |6;imaging-darkroom;146;145;146;145;145;145;146;145;145;145 13:20:59 INFO - PROCESS | 14415 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;96;95 13:20:59 INFO - PROCESS | 14415 | |8;json-parse-financial;53;53;53;55;53;53;53;54;54;55 13:20:59 INFO - PROCESS | 14415 | |9;json-stringify-tinderbox;62;62;62;62;63;62;62;63;62;63 13:20:59 INFO - PROCESS | 14415 | |10;stanford-crypto-aes;86;80;81;84;85;81;88;82;116;80 13:20:59 INFO - PROCESS | 14415 | |11;stanford-crypto-ccm;140;122;120;123;123;128;118;127;124;124 13:20:59 INFO - PROCESS | 14415 | |12;stanford-crypto-pbkdf2;161;163;160;162;162;166;168;160;160;161 13:20:59 INFO - PROCESS | 14415 | |13;stanford-crypto-sha256-iterative;63;63;66;63;63;61;62;64;62;61 13:20:59 INFO - PROCESS | 14415 | __end_tp_report 13:20:59 INFO - PROCESS | 14415 | __start_cc_report 13:20:59 INFO - PROCESS | 14415 | _x_x_mozilla_cycle_collect,1627 13:20:59 INFO - PROCESS | 14415 | __end_cc_report 13:20:59 INFO - PROCESS | 14415 | __startTimestamp1465935659747__endTimestamp 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | ------- Summary: start ------- 13:20:59 INFO - PROCESS | 14415 | Number of tests: 14 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.43 (1.3%) stddev-sans-first:1.41 13:20:59 INFO - PROCESS | 14415 | Values: 112.0 107.0 111.0 110.0 111.0 112.0 110.0 111.0 110.0 111.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:140.50 stddev:19.78 (14.1%) stddev-sans-first:20.68 13:20:59 INFO - PROCESS | 14415 | Values: 151.0 129.0 129.0 180.0 130.0 126.0 161.0 124.0 159.0 125.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 13:20:59 INFO - PROCESS | 14415 | Values: 160.0 161.0 160.0 160.0 160.0 163.0 161.0 161.0 160.0 162.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:17.48 (23.3%) stddev-sans-first:18.33 13:20:59 INFO - PROCESS | 14415 | Values: 75.0 75.0 76.0 128.0 74.0 75.0 75.0 74.0 97.0 75.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.42 (20.5%) stddev-sans-first:18.10 13:20:59 INFO - PROCESS | 14415 | Values: 86.0 85.0 120.0 86.0 85.0 86.0 114.0 85.0 84.0 128.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:20:59 INFO - PROCESS | 14415 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:20:59 INFO - PROCESS | 14415 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:20:59 INFO - PROCESS | 14415 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.87 13:20:59 INFO - PROCESS | 14415 | Values: 53.0 53.0 53.0 55.0 53.0 53.0 53.0 54.0 54.0 55.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 13:20:59 INFO - PROCESS | 14415 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:83.00 stddev:10.78 (13.0%) stddev-sans-first:11.43 13:20:59 INFO - PROCESS | 14415 | Values: 86.0 80.0 81.0 84.0 85.0 81.0 88.0 82.0 116.0 80.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:124.00 stddev:6.06 (4.9%) stddev-sans-first:3.11 13:20:59 INFO - PROCESS | 14415 | Values: 140.0 122.0 120.0 123.0 123.0 128.0 118.0 127.0 124.0 124.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.00 stddev:2.71 (1.7%) stddev-sans-first:2.83 13:20:59 INFO - PROCESS | 14415 | Values: 161.0 163.0 160.0 162.0 162.0 166.0 168.0 160.0 160.0 161.0 13:20:59 INFO - PROCESS | 14415 | 13:20:59 INFO - PROCESS | 14415 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.48 (2.3%) stddev-sans-first:1.56 13:20:59 INFO - PROCESS | 14415 | Values: 63.0 63.0 66.0 63.0 63.0 61.0 62.0 64.0 62.0 61.0 13:20:59 INFO - PROCESS | 14415 | -------- Summary: end -------- 13:20:59 INFO - PROCESS | 14415 | 13:21:00 INFO - TEST-INFO | 14415: exit 0 13:21:00 INFO - TEST-OK | kraken | took 61940ms 13:21:00 INFO - SUITE-END | took 1177s 13:21:00 INFO - Completed test suite (00:19:37) 13:21:00 INFO - javascript benchmark 13:21:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.9080527584165, 3104.2704964333393, 3105.5496952941826, 3112.813231206128, 3114.0, 5441.347038355393, 5457.372402173752, 5464.836054918349, 5579.7489112989915, 5605.495505404513, 5407.0, 5461.644993075447, 5464.12573988162, 5513.58648101393, 5582.748776305066, 4861.197902346117, 4929.7781599828095, 4930.482299358569, 4946.035523073002, 5144.8713782155555, 5058.140116180258, 5077.796888124471, 5097.949020509803, 5103.464136265694, 5122.487751224885, 4888.804447822083, 4891.828785992491, 4921.753912304388, 4936.3829521309835, 4998.750062496861, 4956.752162391866, 4962.801487940478, 4981.701097934136, 5009.5491405773655, 5028.974855125737, 4975.651704380694, 4997.325361076245, 4998.425181104183, 5011.874703132451, 5035.370578677665, 5322.866928326784, 5400.864978375533, 5481.013417584833, 5488.451154884519, 5561.165825126223, 5882.441168089024, 5913.733881975321, 5935.643861368331, 5937.435943585352, 5938.0, 5931.495822855062, 5993.250843644544, 6004.909926351108, 6007.699615019275, 6010.218671572711, 5298.231756395339, 5391.757370918318, 5400.810971616014, 5404.729763511808, 5499.395066542677, 5964.85087872798, 5977.013792724239, 5980.372060933626, 5981.880362392815, 5986.191864098378, 5643.492085712223, 5776.1624564437925, 5777.075667893117, 5777.277840269966, 5783.334916484574, 5836.153757705109, 5882.029465138205, 5898.882022359615, 5924.111383292455, 5928.140419639129, 5843.357230704619, 5872.29532456108, 5882.411758824083, 5890.1164825276555, 5898.2332296802, 5584.888302233932, 5779.162021506858, 5889.23439952812, 5890.646561206341, 5896.380880007623, 4441.933370999438, 4461.486929003141, 4464.732116072981, 4499.1451624191295, 4515.68390212682, 3965.088029753173, 3974.6224108709625, 3993.0815912340327, 3993.72043956926, 4025.1547175092974, 5463.945360546423, 5506.614536982373, 5526.032944234743, 5559.9444005560235, 5614.382417934024, 5752.07966725322, 5772.855678608068, 5817.331006934257, 5851.239338885917, 5857.6192547485125, 5501.092319767274, 5511.366192887869, 5511.53151982078, 5512.200730893998, 5518.641288316247, 4833.226683730657, 4916.827911023097, 4925.162722337212, 4936.703797772145, 4972.154733695281, 6050.334463209044, 6136.88672321611, 6138.633639632459, 6139.676133582418, 6145.9692701536205, 5946.643201407929, 5947.286325640951, 5948.970255148696, 5950.553708471795, 5993.340732519332, 5874.353821079763, 6032.306284777307, 6037.758489660365, 6097.75608975636, 6131.601445906002, 5835.416458354131, 5846.064629659234, 5848.210491583752, 5854.4730974210825, 5894.233749612695, 5862.618929769551, 5887.087501437284, 5888.3228428729535, 5896.7936122235515, 5906.497947674496, 5522.641028333306, 5612.326520817528, 5657.575681823962, 5683.9715801420725, 5690.3456102548735, 5695.715214239354, 5697.4587414195585, 5699.5725320600295, 5706.115552089433, 5708.172315014383, 5599.80400685974, 5633.6619802811965, 5639.8590035249445, 5642.435756424325, 5644.322681278109, 5625.718714064362, 5702.173184888251, 5759.2512973313205, 5784.4504772046585, 5874.647521148745, 5665.3201615806365, 5682.801101961411, 5688.54491640676, 5699.772009119589, 5703.686297253691], "value": 5399.276393386329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.6246096189882, 614.8800983808158, 638.9233292004957, 652.103357882911, 653.180258775237, 31322.53016204756, 31990.20024499389, 42600.78699606498, 43469.56530434695, 43509.34735978963, 45118.0, 45614.0, 45707.54292457074, 45862.77068614652, 46004.309935351, 8973.68592099275, 9098.86351704725, 9135.54322283883, 9137.0, 9138.268938484905, 8922.375433719642, 9058.773530661752, 9061.275097992146, 9062.229710474618, 9062.546872656374, 9100.453972761623, 9117.772055698595, 9133.68032118876, 9136.132067453615, 9140.268778497704, 9041.502717350542, 9070.365074444791, 9082.0, 9087.818243635156, 9089.091090890925, 8927.687530936451, 8987.595558199897, 8989.37074404792, 8990.505522196276, 8994.86507702385, 41798.79100604508, 42399.57600423987, 42430.15139697189, 42516.78741606303, 42807.143857122996, 3632.4914511968345, 3680.3191409589313, 3772.320982223199, 3802.904927376838, 4127.153933443637, 32582.6741732582, 32625.51061734076, 32798.50802237968, 32977.175570610685, 33208.16979575506, 4018.718689691723, 4025.1547175093265, 4027.8388864445387, 4030.7380020298588, 4076.5719599441927, 331087.0, 331264.9999999976, 331488.0, 333576.0, 335021.0, 57870.710646446496, 58742.41257587455, 58890.70554647285, 58903.410965889794, 58927.116093258635, 54002.18996715052, 59457.0, 60794.392056078876, 60857.69571152116, 66313.0, 17274.395396161075, 17347.0, 17433.302667893397, 17441.0, 17452.0, 12379.0, 12682.556110536087, 12758.362081895868, 12761.808572871414, 12763.617091487271, 16181.757273640906, 16351.91824040896, 16629.417970370978, 16936.153192340334, 16948.83051169497, 6240.2870292176085, 6381.0, 6423.0, 6435.806925792233, 6448.001119652922, 910.4628269321132, 922.9861552076724, 1021.1422405179685, 1060.9734756631146, 1117.4859564600374, 31547.36905261882, 32153.0, 32383.352332953207, 32481.187970300933, 32747.345053098805, 1120.6021862238788, 1180.740237147826, 1187.3232257613079, 1198.748262864808, 1201.141184053406, 16777.328906843588, 16817.49547513552, 16840.0, 16943.491695249162, 17004.744928826076, 475386.0, 475843.0, 476299.0, 478073.0, 479897.0, 56822.0, 58329.0, 58389.0, 58445.415545844, 58551.0, 1247.7754004279318, 1290.2129700882454, 1292.6962163891478, 1382.2121390807345, 1395.6789938314041, 25215.621765673895, 32859.83570082134, 33344.49983250205, 35533.789237557256, 35888.8205558981, 49943.00113997772, 61615.69192154011, 61741.691291543255, 65434.0, 66893.0, 453641.0, 463435.0, 464589.0, 464636.0, 466971.0, 40080.1983960325, 44986.32520512129, 45719.54280457153, 45986.540134598225, 47025.29462058003, 50282.497175029246, 50425.0, 51582.48417515927, 52187.73906130445, 52213.47786522238, 42345.0, 43561.782191088845, 43574.12851743011, 43721.344179837964, 44354.0, 42667.988598339325, 43220.56779432166, 43387.0, 43773.78113109414, 43777.781111095515, 42539.5746042548, 43058.354124687525, 43253.0, 43629.0, 44018.779906100266, 36176.45735314025, 38341.42487862628, 38518.0, 38646.6135338643, 38949.6105038946, 28125.296867578476, 28339.291517712223, 28396.102029284873, 28396.148115556567, 28687.569686455136], "value": 20534.175240315057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.1961958365765, 395.4246571238848, 395.8673844262172, 398.7308566717466, 412.5173546950068, 14365.598251231157, 17491.650166996653, 18339.908300458497, 19915.103820328102, 19917.99999999998, 15398.69202615947, 15874.206289685528, 18348.541286467844, 18665.626687466243, 18784.62430751384, 4975.129352363331, 5264.842054738364, 5270.868228294285, 5274.4198138204765, 5275.657082289639, 3853.537575490931, 5176.922346164811, 5306.177542480922, 5311.760970756325, 5314.123169676998, 5543.445655434464, 5817.360090390053, 5823.4467725566, 5915.704214789265, 5923.555733320019, 5438.91841622376, 5726.169705392695, 5854.941450585504, 5876.76492940284, 5885.087811389241, 5627.915581266284, 5642.830715078554, 5655.830325090254, 5659.717014149276, 5662.858428539278, 13582.660433489144, 21045.368638940858, 23047.53904921909, 23923.521529569483, 24000.0, 2279.8518096323687, 2435.8538487690794, 2671.905697445988, 2822.5625028120676, 3010.1722026442685, 9684.349035303258, 10245.436500992442, 10500.0, 10549.9472502637, 10627.28726854946, 1877.2772482594164, 2000.2297966299784, 2006.8294194993443, 2041.6835390514493, 2055.0, 81225.0, 83031.16968830295, 84720.15279847245, 85818.14181858164, 85922.57038714828, 10987.175961802737, 11180.832287515694, 11199.328040317607, 11232.438378081064, 11443.313401195956, 15559.611009724622, 15683.451079212173, 15686.607834804221, 15697.607559811097, 15742.68514629701, 7251.419886409075, 7989.400794940403, 8192.590370481452, 8235.0, 8419.326453883674, 7996.280334769783, 8001.5599142046585, 8043.919560804434, 8316.085230624627, 8350.83298334042, 4680.297955306663, 4682.812687492462, 4692.53074692528, 4726.645501587326, 4832.589229915427, 1935.748352714138, 1959.6570600144917, 1996.241428257282, 2011.2558353409331, 2040.7449068866392, 920.6731610278255, 942.2320808541017, 967.9951600241953, 973.8654467545372, 1044.3472829481575, 19564.21743130259, 19927.60144797096, 19994.300199492947, 20290.79709202889, 20303.796962030192, 979.2117345536769, 1004.6835246897203, 1036.7563622548696, 1095.1020163466042, 1097.155190503308, 10953.890461095287, 11471.426428678533, 11547.595834145932, 11573.652790416301, 11582.36297003673, 241070.0, 475017.0, 500201.0, 502409.0, 503931.0, 97797.0, 101138.0, 104039.0, 105466.0, 106440.46779766206, 1002.2810879341963, 1035.5288343803552, 1056.1920131099714, 1068.8396740488988, 1075.8816530181673, 18145.727814082536, 18171.09144542794, 18620.16209270613, 18696.35033602256, 18794.906025469783, 41892.79053604713, 43155.0, 43708.56291437045, 44041.339379908684, 44438.77780611076, 42669.573304267804, 60412.697936510034, 61099.0, 62029.0, 62890.371096290284, 8661.826763464822, 8872.556372181494, 8939.957889694908, 9005.81988360216, 9008.954955225181, 9702.078302561245, 13275.734485310433, 13558.593242202749, 13608.86391136076, 13996.650083747987, 11962.461689223832, 12302.692432688897, 12445.191062580903, 12474.18917770342, 12493.75012499763, 12060.819087713517, 12087.274763514217, 12149.392530373623, 12243.877561224273, 12420.503179872703, 12224.87775122273, 12311.138220324492, 12557.309347985583, 12691.0, 12816.166949148275, 8350.039745429354, 8385.874211886949, 8538.060813310407, 8562.058173601023, 8937.776555586162, 11637.301761894314, 12078.698032549257, 12285.078619103782, 12315.69210769738, 12317.630471085882], "value": 9302.071468588101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.9285589292585, 1450.5575799381188, 1525.4355888321322, 1629.5926018495377, 1778.0576294563878, 8478.618462169201, 8779.956100219506, 8781.692640757576, 9106.63573457061, 9113.589888455019, 8836.293096552277, 9049.819003619923, 9120.726378208648, 9138.360314777969, 9141.725748227564, 2072.4300817275293, 2291.702078729763, 2351.3886389538716, 2357.446000189954, 2379.0602711928777, 2343.9765602344014, 2350.048230466664, 2351.0478256306224, 2355.034435881289, 2356.7171939367213, 2333.696619439479, 2346.85918844869, 2382.4639456122322, 2382.642603609464, 2385.0936644075227, 1990.044778506325, 2182.90176942038, 2256.334381357487, 2258.672492488596, 2287.633978563422, 2332.0671731307443, 2350.1891847312822, 2365.219477572397, 2365.976340236593, 2373.050779688121, 9263.536823158882, 9308.906910930871, 9379.624815007392, 9381.953090234574, 9387.76530586734, 5326.547243484309, 5414.3232095988005, 5452.454754524555, 5459.808906688287, 5462.235287059815, 3130.311331507065, 3351.3967485852536, 3409.539712138854, 3414.4878268259713, 3416.197193659488, 1089.9400133747224, 1098.8681657892305, 1113.8106521891216, 1136.6874109619837, 1144.7596004838995, 12802.80795788064, 12806.871931280568, 12834.229946203257, 12835.743285134338, 12841.422136003903, 4651.441826980784, 4749.928751068736, 4824.252240902666, 4846.982133751952, 4847.587955023792, 10485.947570262253, 10591.84112238317, 10595.417252051211, 10626.681199564026, 10626.787464250672, 5263.894722105613, 5303.04545181871, 5307.708076055854, 5308.973455132699, 5320.52115309624, 4430.62339701129, 4880.41435027799, 5014.047331007097, 5016.673916195508, 5102.693838369635, 4036.4216652586565, 4055.6349928506575, 4122.196171746481, 4126.360414135814, 4158.293090174678, 1292.3409061378577, 1302.4529697527062, 1312.8162057311984, 1315.1188703568632, 1324.8608896065966, 864.394923553515, 987.3286165407449, 1018.0821319136485, 1020.1583693452783, 1044.8276034454382, 6145.784897528565, 6167.84580385494, 6309.14826498426, 6327.303996560375, 6369.872602547923, 444.94660640722674, 448.0098981251406, 453.1209453659955, 462.38733677876945, 471.1237098995865, 4333.674974376934, 4342.08816148606, 4353.085851971122, 4360.6729495287345, 4378.2994720845145, 10950.507227174796, 11329.263597866113, 11395.088392928546, 11405.543778248943, 11444.771104578029, 10616.575336986434, 11206.439678016066, 11225.438728063564, 11240.55037798479, 11247.83128253077, 8206.876896846552, 8326.084130745734, 8377.162283771575, 8402.621882015324, 8405.285550728257, 6072.119542666201, 6340.397662222082, 6393.6163830170335, 6410.070539771614, 6453.806385808433, 9987.800243995225, 10317.27779055489, 10321.329113607591, 10376.740581485523, 10436.060754532129, 10509.684709458728, 10538.998795114452, 10756.677299681021, 10921.453927303444, 10930.617428389969, 7396.112466504054, 7631.465797394129, 7634.427417943787, 8010.559419231999, 8232.876506852523, 8358.122397148456, 8463.36524760633, 8478.618462169094, 8545.273651739422, 8707.259882910024, 7687.346575541142, 7848.84302313962, 7937.8412431752195, 8063.6774529018185, 8208.425410221227, 7884.881726774218, 7918.524888506708, 7974.202579741979, 8101.392395570238, 8130.87803682957, 7203.603801790951, 7218.927810722035, 7255.4921155520715, 7279.308465695751, 7291.453141014551, 5364.0, 5441.564674826083, 5461.399246082849, 5512.283403157564, 5553.278073850373, 5124.410692770379, 5335.599830012687, 5440.129579267298, 5490.1764735288425, 5621.409751975983], "value": 4657.4558782287895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.45811224311524, 339.55009612263757, 339.9694027537522, 342.4572053295525, 344.2237753865034, 5288.814891478799, 5335.866603334918, 5342.2253773202865, 5356.705381204032, 5382.366902340914, 5276.630635855492, 5278.155495120782, 5306.257124002633, 5307.52232299093, 5317.255584218203, 3876.7867767272787, 4157.584241575833, 4163.0008797888595, 4184.430838435579, 4224.873253802375, 4076.001379661987, 4104.97947510262, 4126.793660316987, 4138.875833724978, 4143.564925682806, 4080.6123418275215, 4085.7957102144924, 4085.9591404086023, 4093.7953102344763, 4107.014316564018, 3897.66869816066, 3949.3878448840333, 4097.242010228118, 4098.200850834089, 4101.282275601788, 3609.151849315409, 3628.727845411578, 3630.8729194478333, 3648.434492653643, 3657.683234035745, 4917.9426423319155, 5138.7173705446185, 5153.433122356538, 5175.974120129413, 5214.940098661008, 4595.4025976622825, 4667.0, 4673.247532175435, 4683.718976861365, 4768.5946694531, 5506.394296627368, 5511.944880551183, 5513.8345849624575, 5553.222548843165, 5590.944090559083, 3792.1467669774356, 3973.443717879499, 3994.2211268802594, 3994.4807175067053, 4000.699947503949, 5736.7992120276, 5739.139129130622, 5744.655320680731, 5771.163181338724, 5785.971070144622, 4032.5765794591734, 4040.0709485622688, 4040.5353384360587, 4040.8989775255855, 4047.7571345719352, 4085.9387109193385, 4097.385392191195, 4110.260153172458, 4114.341705327193, 4128.525219599725, 4522.8643140705835, 4700.482946875841, 4714.986277950257, 4717.693349932243, 4724.71651700899, 5554.50009499147, 5577.972110139423, 5598.776048957996, 5600.27196464457, 5607.243022192033, 1416.4617445370693, 1435.5191011011427, 1439.7192547453355, 1443.3937746146644, 1448.7681970884607, 944.9385789923633, 986.2011770465803, 992.8758905136858, 999.1107913956585, 999.1207737191226, 5219.295395121686, 5344.5724342052545, 5363.704996225245, 5365.463453654604, 5375.623706340519, 5595.356533998561, 5614.466625670555, 5624.0, 5666.829995100154, 5704.942950570524, 5156.871078222999, 5176.7411629418375, 5310.9734451327495, 5325.414204437587, 5339.0, 3008.3080891395102, 3008.7592992560544, 3021.8942337018098, 3035.5446682997726, 3041.5893854329825, 5836.970815145982, 5868.647881127146, 5889.587728858939, 5898.705064746746, 5904.645721256738, 5565.3599836019375, 5806.187133801272, 5828.504577110908, 5849.239598852207, 5902.852428689317, 5788.797392091173, 5867.5305975521005, 5924.822255332347, 5925.644461332334, 5944.524438044946, 5431.728413579226, 5680.261565996394, 5714.857028594381, 5716.742746576498, 5778.624389414675, 5636.435421883115, 5657.924994251079, 5678.716064196857, 5714.257146570919, 5726.79737255181, 5857.0, 5861.853453663522, 5884.176215329943, 5928.584999050025, 5943.91084133747, 4071.633552980246, 4184.853530126431, 4206.6634669227, 4208.894777630584, 4222.408862759277, 5595.384507704068, 5688.63023903445, 5694.943050569441, 5718.0, 5743.869591072958, 5389.59578031657, 5478.753456094565, 5550.028744969695, 5590.468905453975, 5623.943760562505, 5508.641938274, 5512.972435137799, 5525.530329922001, 5527.391986881359, 5535.806246781343, 5399.5950303726595, 5412.296401467784, 5413.215083812904, 5426.70153141581, 5444.3194600674915, 5389.919151212656, 5525.392206857323, 5548.445155484581, 5568.582356323211, 5581.246531718166, 5407.567394608343, 5434.456554344534, 5446.700431476307, 5453.890922181455, 5469.15228139639], "value": 4241.121110935908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.2911119880515, 745.4260219630888, 780.9101953275375, 844.8774927635491, 872.720729366603, 15606.0, 16575.419860304894, 16647.167641617914, 16744.916275418607, 16771.66456670866, 12228.571999980002, 15054.473093441731, 15219.61950951224, 15224.0, 15249.771253431207, 784.2823816208177, 802.8474589827944, 807.1283014344494, 816.3306089007017, 816.4692949582759, 793.6785601831267, 795.1690483444814, 798.4690181029608, 798.6366203377478, 801.210807354755, 697.069412334534, 847.2332539052168, 849.2399302624148, 849.413904405961, 849.4903058165113, 828.4283844147549, 839.345310657688, 841.5581819544727, 844.1389782421895, 845.6067928413256, 616.2358675242667, 616.8057062025448, 616.808789275326, 616.9598976066542, 617.213053356969, 14462.71074578513, 14508.274586270643, 14521.346539405646, 14528.854711452856, 14586.854131458656, 13995.0, 14316.42734290627, 14342.354594043292, 14371.568852934428, 14375.353109110116, 12654.746905061847, 12753.61739147827, 12841.743165136739, 12880.80678789819, 12885.87114128856, 3793.3551296279697, 3913.491246137984, 3949.881503554898, 3977.2642061218767, 4007.499062617173, 67764.0, 69044.6547767258, 79809.60095199545, 79817.60091199506, 80007.59996199982, 10528.26302158857, 10774.353538787698, 10811.243212975016, 10816.329564997584, 11226.831597526043, 19716.112774925165, 19722.408327750192, 19728.112234949174, 19735.210591576175, 19742.90128549348, 8492.70275540353, 8747.51888646118, 9000.8649870252, 9085.81828363429, 9097.408668436663, 4820.68665536739, 4855.101806165871, 4876.786496277673, 4907.631927605373, 4949.678270912379, 3561.71506279497, 3632.9273414531563, 3649.197176621139, 3677.282929828658, 3678.1356381250384, 626.3923993726079, 640.3660376227501, 645.7287939065603, 645.9160309159779, 655.8458762190882, 681.7273090763734, 683.8427161752725, 708.7023450150846, 708.8475977664826, 733.336330620789, 9170.0, 9446.291528135418, 9551.856722149174, 9692.321537492307, 9872.753181170385, 662.9801105966828, 699.951003429755, 710.9786706398817, 711.7651175112201, 719.5394947233774, 4668.789904454307, 5282.735863206824, 5431.21247419122, 5451.563874889999, 5508.898220355944, 88692.55653721691, 91483.54258228667, 92020.0, 103884.48057759662, 108282.0, 85984.0, 86792.0, 89769.0, 90016.09983900208, 90418.0, 73123.63438182882, 80086.0, 81837.0, 82981.0, 83909.0, 10086.949565252127, 10420.270581059556, 10468.162546996069, 10514.789704206027, 10570.8414373786, 46446.767766160956, 47141.17152970833, 47430.0, 47483.76258118687, 47763.0, 62550.0, 64186.358136419905, 65920.67039664963, 71523.28476715166, 72114.0, 13024.869751302365, 13107.344632768132, 13133.343332833128, 13140.737185256432, 14119.523175134567, 14976.550703478913, 15126.773098403313, 15494.380224790882, 15649.530514084596, 15663.608409789846, 14077.436902524194, 14342.85657143457, 14633.634159146106, 14704.191269480281, 14780.260986950825, 14323.427062917366, 14332.928335358256, 14498.637534061732, 14580.85419145795, 14966.17686027279, 13937.442502299795, 14591.562253132422, 14599.416023359372, 14709.190994495406, 15109.697806044038, 11403.828942566033, 11762.470688819194, 11940.880591194324, 12138.878611214128, 12404.379781010733, 11118.888811111785, 11368.374739389414, 12060.457279422271, 12447.439865205906, 12457.688557785765], "value": 7574.647218996009, "unit": "score"}], "name": "dromaeo_css", "value": 7323.830710187009, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 111.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 129.0, 180.0, 130.0, 126.0, 161.0, 124.0, 159.0, 125.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 160.0, 163.0, 161.0, 161.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 128.0, 74.0, 75.0, 75.0, 74.0, 97.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 120.0, 86.0, 85.0, 86.0, 114.0, 85.0, 84.0, 128.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 55.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 81.0, 84.0, 85.0, 81.0, 88.0, 82.0, 116.0, 80.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 122.0, 120.0, 123.0, 123.0, 128.0, 118.0, 127.0, 124.0, 124.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 162.0, 162.0, 166.0, 168.0, 160.0, 160.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 63.0, 63.0, 61.0, 62.0, 64.0, 62.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1500.4, "alertThreshold": 2.0}]} 13:21:00 INFO - Return code: 0 13:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:21:01 INFO - # TBPL SUCCESS # 13:21:01 INFO - Running post-action listener: _resource_record_post_action 13:21:01 INFO - ##### 13:21:01 INFO - ##### Finished run-tests step (success) 13:21:01 INFO - ##### 13:21:01 INFO - Running post-run listener: _resource_record_post_run 13:21:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 548806656; Read time: 0; Write time: 544832 13:21:01 INFO - TinderboxPrint: CPU usage
13.2% 13:21:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:21:01 INFO - TinderboxPrint: I/O write bytes / time
548,806,656 / 544,832 13:21:01 INFO - TinderboxPrint: CPU idle
8,279.1 (86.8%) 13:21:01 INFO - TinderboxPrint: CPU user
1,207.9 (12.7%) 13:21:01 INFO - TinderboxPrint: Swap in / out
0 / 0 13:21:01 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256008192; Read time: 0; Write time: 339956 13:21:01 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 292798464; Read time: 0; Write time: 204876 13:21:01 INFO - Running post-run listener: _upload_blobber_files 13:21:01 INFO - Blob upload gear active. 13:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:21:01 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 13:21:01 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'] 13:21:01 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 13:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 13:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:02 INFO - (blobuploader) - INFO - Done attempting. 13:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:21:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:06 INFO - (blobuploader) - INFO - Done attempting. 13:21:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:21:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:21:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:07 INFO - (blobuploader) - INFO - Done attempting. 13:21:07 INFO - (blobuploader) - INFO - Iteration through files over. 13:21:07 INFO - Return code: 0 13:21:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:21:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:21:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4e845046023c564c3d18c539adbbf23ab20993bbbb1913ef1730368aed79b395d244f5900992396f3d7835e3de1ddc0a8dfb71c8a184c3fcc78a2f2721125f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ccd718be98ae46c7294fceefebea490a8a23c6464b31a26f9929c773fa037e5a96bcaf8a1e701177d91f682f3b5967811ff7d5a915d47d2d9f13a35ae1a1ae5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3a1266ce47fc679c27dd85a3401a909696e4877cea53b3a4d73e6fd664fac8f71d4c66c66ccb73c9585d10c6854ccf16f8569869f12cb122db74dd1b175c4bc"} 13:21:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:21:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:21:07 INFO - Contents: 13:21:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4e845046023c564c3d18c539adbbf23ab20993bbbb1913ef1730368aed79b395d244f5900992396f3d7835e3de1ddc0a8dfb71c8a184c3fcc78a2f2721125f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ccd718be98ae46c7294fceefebea490a8a23c6464b31a26f9929c773fa037e5a96bcaf8a1e701177d91f682f3b5967811ff7d5a915d47d2d9f13a35ae1a1ae5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3a1266ce47fc679c27dd85a3401a909696e4877cea53b3a4d73e6fd664fac8f71d4c66c66ccb73c9585d10c6854ccf16f8569869f12cb122db74dd1b175c4bc"} 13:21:07 INFO - Running post-run listener: copy_logs_to_upload_dir 13:21:07 INFO - Copying logs to upload dir... 13:21:07 INFO - mkdir: /builds/slave/test/build/upload/logs 13:21:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.091232 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-14 13:21:06.915910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 13:21:06.919946) ========= 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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 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/d4e845046023c564c3d18c539adbbf23ab20993bbbb1913ef1730368aed79b395d244f5900992396f3d7835e3de1ddc0a8dfb71c8a184c3fcc78a2f2721125f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ccd718be98ae46c7294fceefebea490a8a23c6464b31a26f9929c773fa037e5a96bcaf8a1e701177d91f682f3b5967811ff7d5a915d47d2d9f13a35ae1a1ae5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3a1266ce47fc679c27dd85a3401a909696e4877cea53b3a4d73e6fd664fac8f71d4c66c66ccb73c9585d10c6854ccf16f8569869f12cb122db74dd1b175c4bc"} build_url:https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/Azteq8sxTdma1U-Cc3q9Lg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4e845046023c564c3d18c539adbbf23ab20993bbbb1913ef1730368aed79b395d244f5900992396f3d7835e3de1ddc0a8dfb71c8a184c3fcc78a2f2721125f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6ccd718be98ae46c7294fceefebea490a8a23c6464b31a26f9929c773fa037e5a96bcaf8a1e701177d91f682f3b5967811ff7d5a915d47d2d9f13a35ae1a1ae5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3a1266ce47fc679c27dd85a3401a909696e4877cea53b3a4d73e6fd664fac8f71d4c66c66ccb73c9585d10c6854ccf16f8569869f12cb122db74dd1b175c4bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 13:21:06.944916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:21:06.945220) ========= 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=eca2ab57546de7b41f256b19000001ef-1465933259.161046-1801232354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 13:21:07.028532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 13:21:07.028873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 13:21:07.029162) ========= ========= Total master_lag: 0.16 =========