builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1465849744.73 results: success (0) buildid: 20160613103044 builduid: 5b55d0393fb6491e9782b5a62de95651 revision: 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.728430) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.728896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.729224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.770682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.771021) ========= 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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 13:29:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227K=0.05s 2016-06-13 13:29:05 (227 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.958844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:04.959162) ========= 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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019347 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.012355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.012876) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f --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 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f --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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 13:29:06,037 truncating revision to first 12 chars 2016-06-13 13:29:06,037 Setting DEBUG logging. 2016-06-13 13:29:06,037 attempt 1/10 2016-06-13 13:29:06,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1bd6da31483d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 13:29:06,524 unpacking tar archive at: mozilla-inbound-1bd6da31483d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.865623) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.865950) ========= script_repo_revision: 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.866422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.866792) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 13:29:05.879604) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 13:29:05.879932) ========= /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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:29:06 INFO - MultiFileLogger online at 20160613 13:29:06 in /builds/slave/test 13:29:06 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:29:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:29:06 INFO - {'append_to_log': False, 13:29:06 INFO - 'base_work_dir': '/builds/slave/test', 13:29:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:29:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:29:06 INFO - 'branch': 'Mozilla-Inbound', 13:29:06 INFO - 'buildbot_json_path': 'buildprops.json', 13:29:06 INFO - 'config_files': ('talos/linux_config.py',), 13:29:06 INFO - 'default_actions': ('clobber', 13:29:06 INFO - 'read-buildbot-config', 13:29:06 INFO - 'download-and-extract', 13:29:06 INFO - 'populate-webroot', 13:29:06 INFO - 'create-virtualenv', 13:29:06 INFO - 'install', 13:29:06 INFO - 'run-tests'), 13:29:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:29:06 INFO - 'download_minidump_stackwalk': True, 13:29:06 INFO - 'download_symbols': 'ondemand', 13:29:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:29:06 INFO - 'tooltool.py': '/tools/tooltool.py', 13:29:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:29:06 INFO - '/tools/misc-python/virtualenv.py')}, 13:29:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:29:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:29:06 INFO - 'installer_path': 'installer.exe', 13:29:06 INFO - 'log_level': 'info', 13:29:06 INFO - 'log_name': 'talos', 13:29:06 INFO - 'log_to_console': True, 13:29:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:29:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:29:06 INFO - 'opt_config_files': (), 13:29:06 INFO - 'pip_index': False, 13:29:06 INFO - 'sps_profile': False, 13:29:06 INFO - 'sps_profile_interval': 0, 13:29:06 INFO - 'suite': 'dromaeojs', 13:29:06 INFO - 'system_bits': '32', 13:29:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:29:06 INFO - 'title': 'talos-linux64-ix-053', 13:29:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:29:06 INFO - 'use_talos_json': True, 13:29:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:29:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:29:06 INFO - 'work_dir': 'build'} 13:29:06 INFO - ##### 13:29:06 INFO - ##### Running clobber step. 13:29:06 INFO - ##### 13:29:06 INFO - Running pre-action listener: _resource_record_pre_action 13:29:06 INFO - Running main action method: clobber 13:29:06 INFO - rmtree: /builds/slave/test/build 13:29:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:29:07 INFO - Running post-action listener: _resource_record_post_action 13:29:07 INFO - ##### 13:29:07 INFO - ##### Finished clobber step (success) 13:29:07 INFO - ##### 13:29:07 INFO - ##### 13:29:07 INFO - ##### Running read-buildbot-config step. 13:29:07 INFO - ##### 13:29:07 INFO - Running pre-action listener: _resource_record_pre_action 13:29:07 INFO - Running main action method: read_buildbot_config 13:29:07 INFO - Using buildbot properties: 13:29:07 INFO - { 13:29:07 INFO - "project": "", 13:29:07 INFO - "product": "firefox", 13:29:07 INFO - "script_repo_revision": "production", 13:29:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:29:07 INFO - "repository": "", 13:29:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:29:07 INFO - "buildid": "20160613103044", 13:29:07 INFO - "pgo_build": "True", 13:29:07 INFO - "basedir": "/builds/slave/test", 13:29:07 INFO - "buildnumber": 1175, 13:29:07 INFO - "slavename": "talos-linux64-ix-053", 13:29:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:29:07 INFO - "platform": "ubuntu64_hw", 13:29:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:29:07 INFO - "branch": "mozilla-inbound", 13:29:07 INFO - "repo_path": "integration/mozilla-inbound", 13:29:07 INFO - "revision": "1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f", 13:29:07 INFO - "stage_platform": "linux64-pgo", 13:29:07 INFO - "builduid": "5b55d0393fb6491e9782b5a62de95651", 13:29:07 INFO - "slavebuilddir": "test" 13:29:07 INFO - } 13:29:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:29:07 INFO - Running post-action listener: _resource_record_post_action 13:29:07 INFO - ##### 13:29:07 INFO - ##### Finished read-buildbot-config step (success) 13:29:07 INFO - ##### 13:29:07 INFO - ##### 13:29:07 INFO - ##### Running download-and-extract step. 13:29:07 INFO - ##### 13:29:07 INFO - Running pre-action listener: _resource_record_pre_action 13:29:07 INFO - Running main action method: download_and_extract 13:29:07 INFO - mkdir: /builds/slave/test/build/tests 13:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:07 INFO - https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:29:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:18 INFO - Downloaded 1361 bytes. 13:29:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:29:18 INFO - Using the following test package requirements: 13:29:18 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:18 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:29:18 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:29:18 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'jsshell-linux-x86_64.zip'], 13:29:18 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:29:18 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:29:18 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:29:18 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:29:18 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:29:18 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:29:18 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:29:18 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:29:18 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:29:18 INFO - https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:20 INFO - Downloaded 24220070 bytes. 13:29:20 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:29:20 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:29:21 INFO - Return code: 0 13:29:21 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:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:21 INFO - https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:27 INFO - Downloaded 24220070 bytes. 13:29:27 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:29:27 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:29:29 INFO - Return code: 0 13:29: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:29:29 INFO - https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:29:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:29:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:35 INFO - Downloaded 14405384 bytes. 13:29:35 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:29:35 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:29:36 INFO - Return code: 0 13:29: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:29:36 INFO - https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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:29:37 INFO - Downloaded 59346083 bytes. 13:29:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:37 INFO - mkdir: /builds/slave/test/properties 13:29:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:29:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:29:37 INFO - Contents: 13:29:37 INFO - build_url:https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:29:38 INFO - Running post-action listener: _resource_record_post_action 13:29:38 INFO - Running post-action listener: set_extra_try_arguments 13:29:38 INFO - ##### 13:29:38 INFO - ##### Finished download-and-extract step (success) 13:29:38 INFO - ##### 13:29:38 INFO - ##### 13:29:38 INFO - ##### Running populate-webroot step. 13:29:38 INFO - ##### 13:29:38 INFO - Running pre-action listener: _resource_record_pre_action 13:29:38 INFO - Running main action method: populate_webroot 13:29:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:29:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:29:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:29:38 INFO - '--tppagecycles', 13:29:38 INFO - '7'], 13:29:38 INFO - 'tests': ['tsvgm']}}, 13:29:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:29:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:29:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:29:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:29:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:29:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['damp', 'tps']}, 13:29:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'tests': ['damp', 'tps']}, 13:29:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['dromaeo_dom']}, 13:29:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:29:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['basic_compositor_video']}, 13:29:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:29:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'other-e10s': {'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['a11yr', 13:29:38 INFO - 'ts_paint', 13:29:38 INFO - 'tpaint', 13:29:38 INFO - 'sessionrestore', 13:29:38 INFO - 'sessionrestore_no_auto_restore', 13:29:38 INFO - 'tabpaint']}, 13:29:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['tsvgx', 13:29:38 INFO - 'tsvgr_opacity', 13:29:38 INFO - 'tart', 13:29:38 INFO - 'tscrollx', 13:29:38 INFO - 'cart']}, 13:29:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:29:38 INFO - 'tsvgr_opacity', 13:29:38 INFO - 'tart', 13:29:38 INFO - 'tscrollx', 13:29:38 INFO - 'cart']}, 13:29:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'talos_options': ['--disable-e10s'], 13:29:38 INFO - 'tests': ['tp5o']}, 13:29:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'tests': ['tp5o']}, 13:29:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'talos_options': ['--disable-e10s', 13:29:38 INFO - '--xperf_path', 13:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:38 INFO - 'tests': ['tp5n']}, 13:29:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:29:38 INFO - 'talos_options': ['--xperf_path', 13:29:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:29:38 INFO - 'tests': ['tp5n']}}, 13:29:38 INFO - 'talos.zip': {'path': '', 13:29:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:29:38 INFO - Running post-action listener: _resource_record_post_action 13:29:38 INFO - ##### 13:29:38 INFO - ##### Finished populate-webroot step (success) 13:29:38 INFO - ##### 13:29:38 INFO - ##### 13:29:38 INFO - ##### Running create-virtualenv step. 13:29:38 INFO - ##### 13:29:38 INFO - Running pre-action listener: _resource_record_pre_action 13:29:38 INFO - Running main action method: create_virtualenv 13:29:38 INFO - Creating virtualenv /builds/slave/test/build/venv 13:29:38 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:29:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:29:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:29:38 INFO - Using real prefix '/usr' 13:29:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:29:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:29:40 INFO - Installing pip.................done. 13:29:40 INFO - Return code: 0 13:29:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:29:40 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:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:40 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:29:40 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:29:40 INFO - Using env: {'DISPLAY': ':0', 13:29:40 INFO - 'HOME': '/home/cltbld', 13:29:40 INFO - 'LANG': 'en_US.UTF-8', 13:29:40 INFO - 'LANGUAGE': 'en_US:en', 13:29:40 INFO - 'LOGNAME': 'cltbld', 13:29:40 INFO - 'MAIL': '/var/mail/cltbld', 13:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:40 INFO - 'MOZ_NO_REMOTE': '1', 13:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:40 INFO - 'NO_EM_RESTART': '1', 13:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:40 INFO - 'PWD': '/builds/slave/test', 13:29:40 INFO - 'SHELL': '/bin/bash', 13:29:40 INFO - 'SHLVL': '1', 13:29:40 INFO - 'TERM': 'linux', 13:29:40 INFO - 'TMOUT': '86400', 13:29:40 INFO - 'USER': 'cltbld', 13:29:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:40 INFO - '_': '/tools/buildbot/bin/python'} 13:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:40 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:29:40 INFO - Cleaning up... 13:29:40 INFO - Return code: 0 13:29:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:29:40 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:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:40 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:40 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:29:40 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:29:40 INFO - Using env: {'DISPLAY': ':0', 13:29:40 INFO - 'HOME': '/home/cltbld', 13:29:40 INFO - 'LANG': 'en_US.UTF-8', 13:29:40 INFO - 'LANGUAGE': 'en_US:en', 13:29:40 INFO - 'LOGNAME': 'cltbld', 13:29:40 INFO - 'MAIL': '/var/mail/cltbld', 13:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:40 INFO - 'MOZ_NO_REMOTE': '1', 13:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:40 INFO - 'NO_EM_RESTART': '1', 13:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:40 INFO - 'PWD': '/builds/slave/test', 13:29:40 INFO - 'SHELL': '/bin/bash', 13:29:40 INFO - 'SHLVL': '1', 13:29:40 INFO - 'TERM': 'linux', 13:29:40 INFO - 'TMOUT': '86400', 13:29:40 INFO - 'USER': 'cltbld', 13:29:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:40 INFO - '_': '/tools/buildbot/bin/python'} 13:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:41 INFO - Downloading/unpacking psutil>=3.1.1 13:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:41 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:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:43 INFO - Installing collected packages: psutil 13:29:43 INFO - Running setup.py install for psutil 13:29:43 INFO - building 'psutil._psutil_linux' extension 13:29:43 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:29:43 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:29:43 INFO - building 'psutil._psutil_posix' extension 13:29:43 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:29:43 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:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:29:43 INFO - Successfully installed psutil 13:29:43 INFO - Cleaning up... 13:29:43 INFO - Return code: 0 13:29:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:29: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:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:29: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 mozsystemmonitor==0.3 13:29:43 INFO - Using env: {'DISPLAY': ':0', 13:29:43 INFO - 'HOME': '/home/cltbld', 13:29:43 INFO - 'LANG': 'en_US.UTF-8', 13:29:43 INFO - 'LANGUAGE': 'en_US:en', 13:29:43 INFO - 'LOGNAME': 'cltbld', 13:29:43 INFO - 'MAIL': '/var/mail/cltbld', 13:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:43 INFO - 'MOZ_NO_REMOTE': '1', 13:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:43 INFO - 'NO_EM_RESTART': '1', 13:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:43 INFO - 'PWD': '/builds/slave/test', 13:29:43 INFO - 'SHELL': '/bin/bash', 13:29:43 INFO - 'SHLVL': '1', 13:29:43 INFO - 'TERM': 'linux', 13:29:43 INFO - 'TMOUT': '86400', 13:29:43 INFO - 'USER': 'cltbld', 13:29:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:43 INFO - '_': '/tools/buildbot/bin/python'} 13:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:29: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:29: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:29: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:29: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:29: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:29: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:29:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:29:45 INFO - Installing collected packages: mozsystemmonitor 13:29:45 INFO - Running setup.py install for mozsystemmonitor 13:29:45 INFO - Successfully installed mozsystemmonitor 13:29:45 INFO - Cleaning up... 13:29:45 INFO - Return code: 0 13:29:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:29:45 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:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:45 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:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:45 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:45 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:29:45 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:29:45 INFO - Using env: {'DISPLAY': ':0', 13:29:45 INFO - 'HOME': '/home/cltbld', 13:29:45 INFO - 'LANG': 'en_US.UTF-8', 13:29:45 INFO - 'LANGUAGE': 'en_US:en', 13:29:45 INFO - 'LOGNAME': 'cltbld', 13:29:45 INFO - 'MAIL': '/var/mail/cltbld', 13:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:45 INFO - 'MOZ_NO_REMOTE': '1', 13:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:45 INFO - 'NO_EM_RESTART': '1', 13:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:45 INFO - 'PWD': '/builds/slave/test', 13:29:45 INFO - 'SHELL': '/bin/bash', 13:29:45 INFO - 'SHLVL': '1', 13:29:45 INFO - 'TERM': 'linux', 13:29:45 INFO - 'TMOUT': '86400', 13:29:45 INFO - 'USER': 'cltbld', 13:29:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:45 INFO - '_': '/tools/buildbot/bin/python'} 13:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:29: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:29: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:29: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:29: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:29: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:29: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:29:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:29:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:29: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:29: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:29: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:29: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:29: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:29: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:29:48 INFO - Downloading functools32-3.2.3-2.tar.gz 13:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:29:48 INFO - warning: no files found matching '*.txt' 13:29:48 INFO - no previously-included directories found matching 'build' 13:29:48 INFO - no previously-included directories found matching 'dist' 13:29:48 INFO - no previously-included directories found matching '.git*' 13:29:48 INFO - Installing collected packages: jsonschema, functools32 13:29:48 INFO - Running setup.py install for functools32 13:29:48 INFO - warning: no files found matching '*.txt' 13:29:48 INFO - no previously-included directories found matching 'build' 13:29:48 INFO - no previously-included directories found matching 'dist' 13:29:48 INFO - no previously-included directories found matching '.git*' 13:29:48 INFO - Successfully installed jsonschema functools32 13:29:48 INFO - Cleaning up... 13:29:48 INFO - Return code: 0 13:29:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:29: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:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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', '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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:29: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 blobuploader==1.2.4 13:29:48 INFO - Using env: {'DISPLAY': ':0', 13:29:48 INFO - 'HOME': '/home/cltbld', 13:29:48 INFO - 'LANG': 'en_US.UTF-8', 13:29:48 INFO - 'LANGUAGE': 'en_US:en', 13:29:48 INFO - 'LOGNAME': 'cltbld', 13:29:48 INFO - 'MAIL': '/var/mail/cltbld', 13:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:48 INFO - 'MOZ_NO_REMOTE': '1', 13:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:48 INFO - 'NO_EM_RESTART': '1', 13:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:48 INFO - 'PWD': '/builds/slave/test', 13:29:48 INFO - 'SHELL': '/bin/bash', 13:29:48 INFO - 'SHLVL': '1', 13:29:48 INFO - 'TERM': 'linux', 13:29:48 INFO - 'TMOUT': '86400', 13:29:48 INFO - 'USER': 'cltbld', 13:29:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:48 INFO - '_': '/tools/buildbot/bin/python'} 13:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:48 INFO - Downloading/unpacking blobuploader==1.2.4 13:29: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:29: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:29: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:29: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:29: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:29: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:29:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:29:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:29: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:29: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:29: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:29: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:29: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:29: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:29:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:29:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:29: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:29: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:29: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:29: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:29: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:29: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:29:51 INFO - Downloading docopt-0.6.1.tar.gz 13:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:29:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:29:51 INFO - Running setup.py install for blobuploader 13:29:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:29:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:29:51 INFO - Running setup.py install for requests 13:29:51 INFO - Running setup.py install for docopt 13:29:51 INFO - Successfully installed blobuploader requests docopt 13:29:51 INFO - Cleaning up... 13:29:51 INFO - Return code: 0 13:29:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29: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:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29: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:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:51 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:51 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:29:51 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:29:51 INFO - Using env: {'DISPLAY': ':0', 13:29:51 INFO - 'HOME': '/home/cltbld', 13:29:51 INFO - 'LANG': 'en_US.UTF-8', 13:29:51 INFO - 'LANGUAGE': 'en_US:en', 13:29:51 INFO - 'LOGNAME': 'cltbld', 13:29:51 INFO - 'MAIL': '/var/mail/cltbld', 13:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:51 INFO - 'MOZ_NO_REMOTE': '1', 13:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:52 INFO - 'NO_EM_RESTART': '1', 13:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:52 INFO - 'PWD': '/builds/slave/test', 13:29:52 INFO - 'SHELL': '/bin/bash', 13:29:52 INFO - 'SHLVL': '1', 13:29:52 INFO - 'TERM': 'linux', 13:29:52 INFO - 'TMOUT': '86400', 13:29:52 INFO - 'USER': 'cltbld', 13:29:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:52 INFO - '_': '/tools/buildbot/bin/python'} 13:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:52 INFO - Running setup.py (path:/tmp/pip-HAGAjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:52 INFO - Running setup.py (path:/tmp/pip-OY5ipa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:52 INFO - Running setup.py (path:/tmp/pip-RM4WjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:52 INFO - Running setup.py (path:/tmp/pip-Bcd1I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:52 INFO - Running setup.py (path:/tmp/pip-jxh6mC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:52 INFO - Running setup.py (path:/tmp/pip-5E2rml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:52 INFO - Running setup.py (path:/tmp/pip-gkvZnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:52 INFO - Running setup.py (path:/tmp/pip-M_b5c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:52 INFO - Running setup.py (path:/tmp/pip-hIsiKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:52 INFO - Running setup.py (path:/tmp/pip-_3mm6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:52 INFO - Running setup.py (path:/tmp/pip-b6CpEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:52 INFO - Running setup.py (path:/tmp/pip-oH_g0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:53 INFO - Running setup.py (path:/tmp/pip-Dl22no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:53 INFO - Running setup.py (path:/tmp/pip-tHiGP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:53 INFO - Running setup.py (path:/tmp/pip-6SlzOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:53 INFO - Running setup.py (path:/tmp/pip-tyjxk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:53 INFO - Running setup.py (path:/tmp/pip-3wU85R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:29:53 INFO - Running setup.py install for manifestparser 13:29:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:29:53 INFO - Running setup.py install for mozcrash 13:29:53 INFO - Running setup.py install for mozdebug 13:29:53 INFO - Running setup.py install for mozdevice 13:29:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:29:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:29:53 INFO - Running setup.py install for mozfile 13:29:53 INFO - Running setup.py install for mozhttpd 13:29:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozinfo 13:29:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozInstall 13:29:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozleak 13:29:54 INFO - Running setup.py install for mozlog 13:29:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for moznetwork 13:29:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozprocess 13:29:54 INFO - Running setup.py install for mozprofile 13:29:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozrunner 13:29:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:29:54 INFO - Running setup.py install for mozscreenshot 13:29:55 INFO - Running setup.py install for moztest 13:29:55 INFO - Running setup.py install for mozversion 13:29:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:29:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:29:55 INFO - Cleaning up... 13:29:55 INFO - Return code: 0 13:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:55 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:55 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:29:55 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:29:55 INFO - Using env: {'DISPLAY': ':0', 13:29:55 INFO - 'HOME': '/home/cltbld', 13:29:55 INFO - 'LANG': 'en_US.UTF-8', 13:29:55 INFO - 'LANGUAGE': 'en_US:en', 13:29:55 INFO - 'LOGNAME': 'cltbld', 13:29:55 INFO - 'MAIL': '/var/mail/cltbld', 13:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:55 INFO - 'MOZ_NO_REMOTE': '1', 13:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:55 INFO - 'NO_EM_RESTART': '1', 13:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:55 INFO - 'PWD': '/builds/slave/test', 13:29:55 INFO - 'SHELL': '/bin/bash', 13:29:55 INFO - 'SHLVL': '1', 13:29:55 INFO - 'TERM': 'linux', 13:29:55 INFO - 'TMOUT': '86400', 13:29:55 INFO - 'USER': 'cltbld', 13:29:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:55 INFO - '_': '/tools/buildbot/bin/python'} 13:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:29:55 INFO - Running setup.py (path:/tmp/pip-VaCxm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:29:55 INFO - Running setup.py (path:/tmp/pip-JN515W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:29:55 INFO - Running setup.py (path:/tmp/pip-v3TCVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:29:55 INFO - Running setup.py (path:/tmp/pip-iRxwUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:29:55 INFO - Running setup.py (path:/tmp/pip-BQXbgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:29:55 INFO - Running setup.py (path:/tmp/pip-ZygvU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:29:55 INFO - Running setup.py (path:/tmp/pip-lF03Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:29:55 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:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:29:55 INFO - Running setup.py (path:/tmp/pip-R_dLxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:29:56 INFO - Running setup.py (path:/tmp/pip-iOEubA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:29:56 INFO - Running setup.py (path:/tmp/pip-vHPkn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:29:56 INFO - Running setup.py (path:/tmp/pip-hP4BSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:29:56 INFO - Running setup.py (path:/tmp/pip-mFFc0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:29:56 INFO - Running setup.py (path:/tmp/pip-kmHeYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:29:56 INFO - Running setup.py (path:/tmp/pip-L19i5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:56 INFO - Running setup.py (path:/tmp/pip-GaQuqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:29:56 INFO - Running setup.py (path:/tmp/pip-xIZqX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:29:56 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:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:29:56 INFO - Running setup.py (path:/tmp/pip-TcJ8nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:56 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:29:58 INFO - Downloading blessings-1.6.tar.gz 13:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:29:58 INFO - Installing collected packages: blessings 13:29:58 INFO - Running setup.py install for blessings 13:29:58 INFO - Successfully installed blessings 13:29:58 INFO - Cleaning up... 13:29:58 INFO - Return code: 0 13:29:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:29:58 INFO - Reading from file tmpfile_stdout 13:29:58 INFO - Current package versions: 13:29:58 INFO - argparse == 1.2.1 13:29:58 INFO - blessings == 1.6 13:29:58 INFO - blobuploader == 1.2.4 13:29:58 INFO - docopt == 0.6.1 13:29:58 INFO - functools32 == 3.2.3-2 13:29:58 INFO - jsonschema == 2.5.1 13:29:58 INFO - manifestparser == 1.1 13:29:59 INFO - mozInstall == 1.12 13:29:59 INFO - mozcrash == 0.17 13:29:59 INFO - mozdebug == 0.1 13:29:59 INFO - mozdevice == 0.48 13:29:59 INFO - mozfile == 1.2 13:29:59 INFO - mozhttpd == 0.7 13:29:59 INFO - mozinfo == 0.9 13:29:59 INFO - mozleak == 0.1 13:29:59 INFO - mozlog == 3.2 13:29:59 INFO - moznetwork == 0.27 13:29:59 INFO - mozprocess == 0.22 13:29:59 INFO - mozprofile == 0.28 13:29:59 INFO - mozrunner == 6.11 13:29:59 INFO - mozscreenshot == 0.1 13:29:59 INFO - mozsystemmonitor == 0.3 13:29:59 INFO - moztest == 0.7 13:29:59 INFO - mozversion == 1.4 13:29:59 INFO - psutil == 3.1.1 13:29:59 INFO - requests == 1.2.3 13:29:59 INFO - wsgiref == 0.1.2 13:29:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:59 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:29:59 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:29:59 INFO - Using env: {'DISPLAY': ':0', 13:29:59 INFO - 'HOME': '/home/cltbld', 13:29:59 INFO - 'LANG': 'en_US.UTF-8', 13:29:59 INFO - 'LANGUAGE': 'en_US:en', 13:29:59 INFO - 'LOGNAME': 'cltbld', 13:29:59 INFO - 'MAIL': '/var/mail/cltbld', 13:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:59 INFO - 'MOZ_NO_REMOTE': '1', 13:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:59 INFO - 'NO_EM_RESTART': '1', 13:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:59 INFO - 'PWD': '/builds/slave/test', 13:29:59 INFO - 'SHELL': '/bin/bash', 13:29:59 INFO - 'SHLVL': '1', 13:29:59 INFO - 'TERM': 'linux', 13:29:59 INFO - 'TMOUT': '86400', 13:29:59 INFO - 'USER': 'cltbld', 13:29:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:59 INFO - '_': '/tools/buildbot/bin/python'} 13:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 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:29:59 INFO - Cleaning up... 13:29:59 INFO - Return code: 0 13:29:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:59 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:29:59 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:29:59 INFO - Using env: {'DISPLAY': ':0', 13:29:59 INFO - 'HOME': '/home/cltbld', 13:29:59 INFO - 'LANG': 'en_US.UTF-8', 13:29:59 INFO - 'LANGUAGE': 'en_US:en', 13:29:59 INFO - 'LOGNAME': 'cltbld', 13:29:59 INFO - 'MAIL': '/var/mail/cltbld', 13:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:59 INFO - 'MOZ_NO_REMOTE': '1', 13:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:59 INFO - 'NO_EM_RESTART': '1', 13:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:59 INFO - 'PWD': '/builds/slave/test', 13:29:59 INFO - 'SHELL': '/bin/bash', 13:29:59 INFO - 'SHLVL': '1', 13:29:59 INFO - 'TERM': 'linux', 13:29:59 INFO - 'TMOUT': '86400', 13:29:59 INFO - 'USER': 'cltbld', 13:29:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:59 INFO - '_': '/tools/buildbot/bin/python'} 13:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:29:59 INFO - Cleaning up... 13:29:59 INFO - Return code: 0 13:29:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:29:59 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 0x7f9041c9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, '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': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', '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:29:59 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:29:59 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:29:59 INFO - Using env: {'DISPLAY': ':0', 13:29:59 INFO - 'HOME': '/home/cltbld', 13:29:59 INFO - 'LANG': 'en_US.UTF-8', 13:29:59 INFO - 'LANGUAGE': 'en_US:en', 13:29:59 INFO - 'LOGNAME': 'cltbld', 13:29:59 INFO - 'MAIL': '/var/mail/cltbld', 13:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:29:59 INFO - 'MOZ_NO_REMOTE': '1', 13:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:29:59 INFO - 'NO_EM_RESTART': '1', 13:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:29:59 INFO - 'PWD': '/builds/slave/test', 13:29:59 INFO - 'SHELL': '/bin/bash', 13:29:59 INFO - 'SHLVL': '1', 13:29:59 INFO - 'TERM': 'linux', 13:29:59 INFO - 'TMOUT': '86400', 13:29:59 INFO - 'USER': 'cltbld', 13:29:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:29:59 INFO - '_': '/tools/buildbot/bin/python'} 13:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:29:59 INFO - Downloading/unpacking flake8 13:29: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:29: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:29: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:29: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:29: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:29: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:30:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:30:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:30:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:01 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:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:30:02 INFO - no previously-included directories found matching 'docs/_build' 13:30:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:30:02 INFO - Running setup.py install for pep8 13:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:30:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:30:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:30:02 INFO - no previously-included directories found matching 'docs/_build' 13:30:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:30:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:30:02 INFO - Cleaning up... 13:30:02 INFO - Return code: 0 13:30:02 INFO - Running post-action listener: _resource_record_post_action 13:30:02 INFO - Running post-action listener: _start_resource_monitoring 13:30:02 INFO - Starting resource monitoring. 13:30:02 INFO - ##### 13:30:02 INFO - ##### Finished create-virtualenv step (success) 13:30:02 INFO - ##### 13:30:02 INFO - ##### 13:30:02 INFO - ##### Running install step. 13:30:02 INFO - ##### 13:30:02 INFO - Running pre-action listener: _resource_record_pre_action 13:30:02 INFO - Running main action method: install 13:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:30:02 INFO - Reading from file tmpfile_stdout 13:30:02 INFO - Detecting whether we're running mozinstall >=1.0... 13:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:30:02 INFO - Reading from file tmpfile_stdout 13:30:02 INFO - Output received: 13:30:02 INFO - Usage: mozinstall [options] installer 13:30:02 INFO - Options: 13:30:02 INFO - -h, --help show this help message and exit 13:30:02 INFO - -d DEST, --destination=DEST 13:30:02 INFO - Directory to install application into. [default: 13:30:02 INFO - "/builds/slave/test"] 13:30:02 INFO - --app=APP Application being installed. [default: firefox] 13:30:02 INFO - mkdir: /builds/slave/test/build/application 13:30:02 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:30:02 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:30:19 INFO - Reading from file tmpfile_stdout 13:30:19 INFO - Output received: 13:30:19 INFO - /builds/slave/test/build/application/firefox/firefox 13:30:19 INFO - Running post-action listener: _resource_record_post_action 13:30:19 INFO - ##### 13:30:19 INFO - ##### Finished install step (success) 13:30:19 INFO - ##### 13:30:19 INFO - ##### 13:30:19 INFO - ##### Running run-tests step. 13:30:19 INFO - ##### 13:30:19 INFO - Running pre-action listener: _resource_record_pre_action 13:30:19 INFO - Running main action method: run_tests 13:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:30:19 INFO - Python 2.7.3 13:30:19 INFO - Return code: 0 13:30:19 INFO - grabbing minidump binary from tooltool 13:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:30:19 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 0x1c792e0>, '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 0x1be5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:30:19 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:30:19 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:30:19 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:30:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:30:19 INFO - Return code: 0 13:30:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:30:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:30:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:30:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:30:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:30:20 INFO - Return code: 0 13:30:20 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/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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:30:20 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/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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:30:20 INFO - Using env: {'DISPLAY': ':0', 13:30:20 INFO - 'HOME': '/home/cltbld', 13:30:20 INFO - 'LANG': 'en_US.UTF-8', 13:30:20 INFO - 'LANGUAGE': 'en_US:en', 13:30:20 INFO - 'LOGNAME': 'cltbld', 13:30:20 INFO - 'MAIL': '/var/mail/cltbld', 13:30:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:30:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:30:20 INFO - 'MOZ_NO_REMOTE': '1', 13:30:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:30:20 INFO - 'NO_EM_RESTART': '1', 13:30:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:30:20 INFO - 'PWD': '/builds/slave/test', 13:30:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:30:20 INFO - 'SHELL': '/bin/bash', 13:30:20 INFO - 'SHLVL': '1', 13:30:20 INFO - 'TERM': 'linux', 13:30:20 INFO - 'TMOUT': '86400', 13:30:20 INFO - 'USER': 'cltbld', 13:30:20 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107', 13:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:30:20 INFO - '_': '/tools/buildbot/bin/python'} 13:30:20 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/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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:30:20 INFO - mozversion application_buildid: 20160613103044 13:30:20 INFO - mozversion application_changeset: 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f 13:30:20 INFO - mozversion application_display_name: Nightly 13:30:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:30:20 INFO - mozversion application_name: Firefox 13:30:20 INFO - mozversion application_remotingname: firefox 13:30:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:30:20 INFO - mozversion application_vendor: Mozilla 13:30:20 INFO - mozversion application_version: 50.0a1 13:30:20 INFO - mozversion platform_buildid: 20160613103044 13:30:20 INFO - mozversion platform_changeset: 1bd6da31483db28d8fd65a0ef69d8dfe42cb0f0f 13:30:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:30:20 INFO - mozversion platform_version: 50.0a1 13:30:20 INFO - using testdate: 1465849820 13:30:20 INFO - actual date: 1465849820 13:30:20 INFO - starting webserver on 'localhost:52446' 13:30:20 INFO - SUITE-START | Running 2 tests 13:30:20 INFO - TEST-START | dromaeo_css 13:30:20 INFO - operating with platform_type : linux_ 13:30:20 INFO - Initialising browser for dromaeo_css test... 13:30:20 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplmIWxp/profile http://localhost:52446/getInfo.html) 13:30:25 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 13:30:25 INFO - PROCESS | 1967 | colorDepth:24 13:30:25 INFO - PROCESS | 1967 | Browser inner width/height: 1024/697 13:30:25 INFO - PROCESS | 1967 | __metrics 13:30:26 INFO - PROCESS | 1967 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:30:26 INFO - PROCESS | 1967 | console.error: PushService: 13:30:26 INFO - PROCESS | 1967 | stateChangeProcessEnqueue: Error transitioning state 13:30:26 INFO - PROCESS | 1967 | UnknownError 13:30:27 INFO - TEST-INFO | 1967: exit 0 13:30:27 INFO - Browser initialized. 13:30:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:30:27 INFO - TEST-INFO | started process 2051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplmIWxp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:30:39 INFO - PROCESS | 2051 | RSS: Main: 177958912 13:30:39 INFO - PROCESS | 2051 | 13:31:30 INFO - PROCESS | 2051 | 1465849890763 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:33:38 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52446/tests/dromaeo/cssquery-ext.html) 13:33:39 INFO - PROCESS | 2051 | RSS: Main: 272707584 13:33:39 INFO - PROCESS | 2051 | 13:36:42 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-ext.html (next: http://localhost:52446/tests/dromaeo/cssquery-jquery.html) 13:36:42 INFO - PROCESS | 2051 | RSS: Main: 256950272 13:36:42 INFO - PROCESS | 2051 | 13:39:44 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52446/tests/dromaeo/cssquery-mootools.html) 13:39:45 INFO - PROCESS | 2051 | RSS: Main: 265166848 13:39:45 INFO - PROCESS | 2051 | 13:42:47 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52446/tests/dromaeo/cssquery-prototype.html) 13:42:47 INFO - PROCESS | 2051 | RSS: Main: 259694592 13:42:47 INFO - PROCESS | 2051 | 13:45:50 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52446/tests/dromaeo/cssquery-yui.html) 13:45:51 INFO - PROCESS | 2051 | RSS: Main: 246812672 13:45:51 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | Cycle 1(1): loaded http://localhost:52446/tests/dromaeo/cssquery-yui.html (next: http://localhost:52446/tests/dromaeo/cssquery-dojo.html) 13:48:54 INFO - PROCESS | 2051 | RSS: Main: 292491264 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | __start_tp_report 13:48:54 INFO - PROCESS | 2051 | _x_x_mozilla_page_load 13:48:54 INFO - PROCESS | 2051 | _x_x_mozilla_page_load_details 13:48:54 INFO - PROCESS | 2051 | |i|pagename|runs| 13:48:54 INFO - PROCESS | 2051 | |0;dojo.html;3119.0642807157856;3134.7335476484513;3155.7633177511693;3163.0827060152556;3189.968100318996;5293.708846013467;5329.866753331169;5402.35171779386;5434.130539113743;5451.264079349292;5294.100002999489;5299.046171689094;5374.274472946161;5390.353157621091;5409;4826.3725715657;4890.510948905099;4903.31353610493;4911.607071434277;5038.974805125969;4929.235968424882;4947.257911313314;4970.850874473754;4980.651354405193;5000.62495312853;4709.270063140201;4784.306275590055;4832.492588278251;4847.951520484785;4937.185364414867;4858.101251268491;4874.0251949609865;4944.728039957801;4945.109880221558;4994.2009278515625;4723.149833030053;4892.315075889378;4918.163912134945;4931.950680493185;4967.10592093423;5116.846494605168;5166.61250406221;5170.896582068338;5244.842654720364;5259.368875734898;5602.38373778884;5602.691851948141;5614.410486898858;5626.127950167731;5634.098544232903;5488.890222195574;5620.91568626471;5626.324841019104;5656.519195868356;5658.943410565883;5340.359156901158;5408.945910540883;5428.212909128154;5434.402215756264;5436.510714035677;5910.34986151523;5929.080992446177;5929.911051334234;5933.495652869555;5935.376785437553;5411.18832175169;5518.944810551923;5523.6409633373705;5683.8010669626365;5689.061304884648;5704.030314846403;5763.279590051244;5765.452282033284;5774.913376299359;5777;5681.886362272731;5700.401457846866;5704.401037891044;5704.629199102045;5713.457221563945;5585.636933599303;5639.097744360883;5649.632773869767;5654.943450565442;5676.148577713376;4406.33904914259;4421.712588681726;4425.137098265872;4426.15902978433;4459.620932220732;3938.724289299779;3944.546377166605;3960.603939606074;3999.060220848098;4022.3966405039478;5264.078786212397;5317.521423071942;5346.759395827197;5351.732413379394;5357.196420536873;5684.317881854204;5702.574356410897;5708.80019199326;5708.971455142698;5743.282089738783;5405.513503784599;5412.648177868505;5415.918761218585;5417.160340147283;5419.295491586068;4900.852974410774;4912.557869791664;4937.901241975141;4946.554810067111;4999.3000979862845;5954.166416701665;5954.76180952757;5957.076653118774;5965.910511342333;5965.940340596625;5671.858203544944;5682.943170568242;5689.1750696148;5690.800821971211;5692.573057020657;5628.549716022627;5902.2622172228475;5984.730687119003;6043.607165534227;6121.8469538260115;5660.745266462936;5684.7441865117;5685.175649530712;5690.146478028329;5690.914636280377;5534.252875861707;5789.1895134680335;5796.0436527972415;5798.6810725410505;5798.94201057984;5468.617196796186;5511.311086114236;5519.69641669712;5554.555635549227;5565.1930470082425;5549;5549.278593782782;5555.111182210989;5558.471945165203;5563.193336966198;5327.573794096385;5493.423190565093;5498.3127109111365;5498.945010549844;5548.278723765885;5764.567657425626;5771;5772.1630363596205;5781.190633311256;5781.4218578141845;5553.250311208097;5585.972070139624;5586.413426590149;5597.972010140086;5601.719914004365 13:48:54 INFO - PROCESS | 2051 | |1;ext.html;586.6392168816177;621.7326549583677;625.6715224507135;629.7638385605399;646.5635695905265;32069.51895721563;35579.64420355796;35617.46573801392;35645;42740;40833;45758.542414575844;45855.31217031747;45866;45925.77037114818;8833.07252738463;9073.909260907405;9079.954600226989;9082.046385129566;9082.273418126533;8845.380823342337;8892.110788921122;8950.641974321052;8956.19394254517;8958.193762561368;8963.910360896405;9007.459552426842;9009.234215091725;9009.279257659371;9012.819743605123;8916.465012099263;8952.462852228855;8959.552022398919;8973.147550982614;8974.14745599167;8858.114188581154;8903.37676362655;8918.866217006685;8928.821423571557;8929.687460938836;41699;42122.36816447756;42139;42141.1571768566;42143.57856421458;3644.21649345392;3677.3564626190578;3817.408301713239;3875.1668391296007;4242.215190189825;32755.50866737001;33223.66776332254;33266.33467330664;33576;34374;4307.289297265947;4318.52496225415;4366.279563871957;4378.78106094694;4551.476580193287;321688;321731;322071;322772;323615;55760;56116.43883561112;56260;56294;56700;36518.45222321667;37505.43741843875;37518.43722344167;39750.60249397469;39787.6127432355;17588.12059397025;17725.645487090187;17757.46727598174;17762.111894405487;17768.91115544414;13624.795628065587;13752.174869507862;13813.51652692171;13821.654458638615;13829;19377.321793737152;19533.413997580094;19581.1188496518;19627.31304404339;19777.208911643662;7256.927430725731;7261.5280006799385;7311.89032164518;7407.333349996207;7432.591207483532;998.5805961496189;1083.5936523803573;1145.0496088246734;1148.4831825678311;1188.5127097889824;32003.51994720081;32100.518492222636;32136.83931580327;32535.349293014006;33113;1111.2332490581473;1115.4255558387438;1166.6966588687003;1176.7705297466912;1195.2649120790652;16732.24704888283;17052.65894682124;17151.142442877805;17239.74140387895;17350.13249337528;543323;546527;547399;549028;551236;58880;59642;59694;59737;59754;1279.5649479177125;1344.287527610368;1353.5127354152498;1365.1399618240644;1403.8315402151602;31178.296666216873;32475;32760.344793104483;33053;33294.50058249177;49451;54036.459635403146;56251;56357.71821140868;62187;479593;480653;483115;483861;486274;36989.815050924575;44954.77522612366;45057.324140137265;45558.772206138754;46620.53379466297;48130.35283059465;48196.518034820605;49264;49264.75367623139;49712.502874970785;37473;40993.385099224135;41340.37989430221;41943.7902810484;42501;40072.7996360028;40413;40757.38863916984;41378.379324310765;41491;40275.3958690614;40790.38814417727;41380.37929431121;41382.586174139076;41524.37713434362;31192.37615247637;33885.491717623765;34480.82759586186;34526.48210276798;34714.479282811284;27541.586876196474;27622.309442264104;27702;27882.860585697752;28124.71875281221 13:48:54 INFO - PROCESS | 2051 | |2;jquery.html;405.96549293310056;410.70634496335117;410.84182589702976;423.59335038363173;429.7185343599943;13400.66498337542;17758.644827103468;19481.805181948177;19790.10944507497;19802;13917.652058698537;18164.545886352847;18251.36120235792;18709.251629934788;19100.331488397907;5632.887342253162;5877.617954832944;5880.529557635379;5881.35305116439;5913.231279933602;5715.799947001856;5774.480296773289;5821.912671309934;5821.970890145543;5827.883442331151;4132.97933510332;6084;6392.552521323486;6396.93603063968;6510.283868774431;6216.844578885519;6442.742290308382;6459.09572659828;6467.353264673542;6496.123023391829;5684.8010319638615;5727;5727.541796656257;5761;5767.855803604902;19087.522811929673;20556.897215513975;22519.887400562893;22572.54854902893;23032.309030729106;2250.5273892482596;2262.083856038307;2273.693051438051;2337.8597284162834;2379.2862141357523;10336.17310615149;10336.5348559315;10910.290831096032;11239.775204495945;14694.55916322512;1800.7568978187908;1913.5120544261263;1965.2040923426036;1995.4811748945233;2000.1899230811543;78202.60898695527;79211.60394197992;83426.58286708589;85251.6961972234;85490.57254713749;10835.349879007284;11076.778464430667;11196.440177991068;11212.943935280271;11397.943010284895;15510.844891551165;15603.375864965501;15674.529764107096;15692.607684807972;15711;7533.660985255567;7686.116096648845;7762.805929851799;7894.565798881002;7976.401769867167;7143.107111611049;7290.744823931243;7297.70809167638;7381.88927166093;7769.650365733555;4361.5856493633055;4528.43394575678;4591.655625828076;4647.697899636512;4892.241702536113;2027.8884661343768;2034.5523984723336;2054.1167298061678;2073.896305184765;2104.168853302937;898.5148020069089;965.6620182935916;989.2382865193761;1015.9238057145743;1024.134606257711;17164.313427462763;18526.444206673823;18720.53198670017;18835.52911177204;18901.990415780303;1000.9599616015278;1018;1019.6431249062917;1027.9691609251734;1030.7062487191265;9189.264858811279;10369.222308326755;10499.422531760674;10584.523696433525;10587.364758114538;442615;445118;464834;470811;474809;65732.41274491722;86485;87696;99186.5040674792;102213;1003.3377970539555;1007.2445665750687;1041.5833666533447;1045.764702941832;1058.3226734889677;16964;17107.401240956508;17132.40036598713;17326.653466930842;17823.643527129127;33764.49353259654;42629.36055959225;42734.78632606817;43311.56688433075;44431.55568444274;62019.37980620136;62335;62785;63424.365756341846;64612.67693661502;8930.821383572422;9079.500627465553;9139.680111196076;9169.816603668023;9296.860547091934;9798.412095274307;12321.93839030799;12857.742845143232;13238;13560.660983475493;11202.66392008241;11422;11422.48598813072;11525.077993760648;11697.415129243675;11125.44372781374;11364.886351136383;11656;11678.299302041905;11824.586139485076;11548.364839933884;11621;12200.51197952072;12231.082668800054;12238.816417753918;8942.642294308154;8949.910500894908;9012.774680633036;9025.638974440948;9169.954150229472;10973.177011723992;11035.668929932115;11210.719732006764;11568.24806387582;12089.637310880687 13:48:54 INFO - PROCESS | 2051 | |3;mootools.html;1297.5458589493674;1470.602937206954;1495.4541592318806;1595.290095907321;1734.75713400124;8634.4387614805;9007.549622518873;9019.098090190986;9300.627974880997;9326.253899688025;9084.954575227115;9296.116868897461;9306;9312.208462280714;9318.161365477106;2464.408541949928;2488.464980029293;2491.3397949543387;2492.7756501914823;2492.987535062331;2438.5244877248942;2517.748225177486;2520.823542352036;2522.445062086338;2536.581464058428;2380.321608341623;2384.1297926256966;2420.987895060522;2422.321749910028;2423.6243382275775;2401.255610760661;2414.2515820095737;2421.69728783902;2422.8909699063584;2432.3067925641194;2353;2358.5282943411385;2386.3198988288254;2416.190576156972;2419.068658566447;8063.717769878085;8321.625526851245;9380.296477764196;9421.858672119924;9498.14516693501;5445.210444485528;5605.271314729059;5611.859703507404;5693.77224911003;5700.287464066992;3392.1858753899132;3436.1237884339585;3464.7574669773126;3489.2323688788424;3489.70337521311;1076.6178006807627;1076.9138468922545;1082.6860210538935;1083.6478144603036;1098.3080659184743;13032;13152.473901043946;13170.078094533386;13187.670308242275;13196.14225075367;5007;5033.395992480852;5122.615803814729;5123.795048198105;5150.356205474316;11197.552097916156;11217.55129794799;11223.943880280547;11244.325340479434;11272.267302625303;5706;5711.029125048752;5716;5718.771249150071;5725.885482290414;4938.777755001033;5108.438071812097;5123.641345105807;5124.052050370693;5179.922301165486;3884.1649045455365;4023.657989070903;4026.859059932947;4045.858394956221;4111.301078816608;1165.7260543772206;1177;1177.9764404711857;1187.091874715843;1224.253205544617;920.07992007992;973.9172170365598;990.3711143423977;1005.0799698376744;1014.4927536231884;6220.471259942956;6256.655883926337;6325.715342809584;6491.318411566812;6591.604503729792;470.37440204527894;477.25309890022004;490.0737605924805;490.88464210910405;496.9875753106201;4073.6130067643526;4494.303382975644;4523.36672865799;4538.9546104539195;4570.451545814523;11402.885971140182;11771.587994420153;11848.229865058744;11964.521419143137;11985.880141198477;11882.584109556125;11884.584039558575;11892.108091893142;11894.464749086312;11900.821487677691;8260.091389947102;8585.141485851489;8674.826503470022;8895.955520222358;8905.931288245323;6338.207724034496;6482.157319548429;6597.406233439014;6611.603303801788;6699.899501507579;10823.458827058457;10922.399268040333;11147.498362573866;11172.385518796544;11177.049950754277;10849.945750271198;10993.340399576051;11224.7755044897;11258.605948791754;11269.943650281695;8393.706220282262;8485.618147183268;8553.914460855312;8556.443831150955;8561.272291855013;8176.503603482721;8460.280876125598;8471.788205294917;8990.505522196341;9067.818643627223;8205.79485512867;8215.424920255764;8241.917580824114;8297.170282971654;8345.33237340999;7765;7866.724664636939;8111.918880811352;8170.673173073011;8217.219364160395;7519.887201691869;7555.168931417649;7573.9242607575425;7592.164861865301;7597.734079307198;5229.111051121243;5301.5493683037375;5337.572994160536;5444.754986025559;5477.780888764405;5269.657472264291;5669.801556945487;5686.147077938177;5800.535957123336;5852.707364631837 13:48:54 INFO - PROCESS | 2051 | |4;prototype.html;339.3586122228988;346.8664564142805;352.95235143255667;360.88451695457434;361.03063275106325;5244.351602440762;5252.947470525299;5270.893112446382;5272.657277276974;5284.762185701643;5190.662606930547;5196.246544251091;5223;5223.112070947938;5223.764930578123;4083.816228269735;4136.420901073837;4155.628642547952;4172.853950111747;4173.791310434482;4125.876223713293;4144.792760361985;4151.979240103795;4163;4178.623923846853;3913.902152446183;4123.773192474413;4133.793310334487;4142.295809712341;4145.419641250227;3898.1034362096593;3902.804859757001;4039.1113954930015;4041.898952526181;4054.3715724062818;3669.8348574313954;3681.4109742441083;3684.9263014739554;3688.2254726507467;3708.295423869456;5024.171011783088;5068.239764035387;5068.315777370045;5077.64456488046;5108.003939231851;4497.9325310120375;4529.592336689714;4703.43558772946;4720.12677654635;4722.858314250578;5426.294581704393;5468.371137319219;5468.9726551367385;5476.534494567966;5483.232347471358;4043.6158564936286;4052.0882801369753;4052.3111071117983;4058.2492238935893;4059.391091336294;5535.225068490415;5541.9168712469345;5599.272094627713;5622.943770562283;5707.600467967244;4125.133721918431;4137.627613514738;4139.2135494256;4140.254754144223;4145.922060264353;4163.7293575917465;4175.62419382257;4177.143685544456;4177.561356057631;4184.895377615523;4421.579949904753;4698.694584851974;4703.2004559225015;4704.858854234379;4714.45783734868;5450.4549545045975;5476.205950137208;5480.7533660985355;5511.724413779295;5542.39033706292;1411.2238268952035;1424.3803945283835;1425.1805212002932;1428.5642878921822;1431.484665520412;889.3685483306924;928.382625553999;932.9580168892417;935.5743136872707;940.9811803763887;4710.586823952801;4710.882227944328;4726.550977657117;4727.95272047282;4769.76151192439;5005.724685142352;5006.823396501819;5029.5724863386295;5030.7171671223605;5041.294218809369;4789;4801.903961920742;4811.724892903383;4847.812285989955;4978.6017118630425;2960.8371539565533;2965.6654505472625;2975.523916173402;3002.9549556756665;3017.562453444238;5873.119032145127;5903.675297858573;5906.940930590725;5923.111533270044;5925.34821169671;5497.367802702661;5544.251526044013;5635.859103522363;5788.27646544182;5806.825795226066;5708.7174874447355;5766.250387449605;5781.802914892398;5782.219400380979;5846.093855452412;5520.846869720732;5532.419095994863;5543.057680194296;5631.859203519781;5643.661380317194;5534.066944519411;5580.693061881636;5668.744906479301;5682.857928551819;5682.971585142048;5816.3892791258;5896.498797602252;5909.23179986599;5925.822225333247;5969.9701501493955;4000.219957108336;4074.388841673654;4076.8381011411607;4087.325591277406;4112.98463752765;5508.779648814003;5578.30271216098;5621.213030175697;5621.241132447068;5636.718164091697;5459.454054594509;5474.425185355481;5488.4237155098135;5492.203630473638;5502.257195278747;5225.843224703265;5450.645708028966;5461.399246083007;5490.972545137249;5512.448755124456;5389.541888939484;5424.891502170013;5465.890682186414;5466.863328416822;5467.797084641373;5482.643628164316;5510.1459273812625;5551.195861344998;5567.888642227052;5580.832575022756;5209.869753256199;5351.197320401815;5453.454654534515;5473.8357849264585;5477.068898287221 13:48:54 INFO - PROCESS | 2051 | |5;yui.html;788.3653658804661;790.7509134622593;797.6011994002998;806.8305655812279;821.909589945106;13649.31753412329;14473;14546.199959002251;14566.781498277522;16473.67052658946;14701.1914344711;14719.632009199775;14813.18527480988;14826.258687065658;14852.257387130654;682.9590224586541;788.7673136424739;803.120582961659;821.6179476543406;823.798169448486;814.3892080939296;825.6243409248807;825.6986200036973;826.277007618334;826.6528058215564;868.1145231863495;871.8910136232971;872.2193636695154;872.8297981893534;872.9127087291283;708.3023222126227;811.4887620798918;831.2601784411878;863.6243234193115;864.8054187807725;617.57387402692;617.8023032629516;617.9258488981351;618.1253526260336;618.7524990004034;14625.341859616236;14637.121772693672;14651.340689668883;14666;14685.48600798967;13728.382222799899;13801.930990344985;13905.374258158407;13957.092788968685;14298;12430.813537796941;12453.688657783538;12472.251664900135;12505.74988500234;12632.431540580605;4489.079738653568;4589.059242855206;4591.724496530219;4593.862184134481;4733.290006499018;71390;72599;72981;72999.33506981743;74273;11368.602098926498;11524.539018439336;11545.826812597817;11952.103592230618;12024.278543287432;21477.355679329332;21511.784882151293;21517;21520.139194432362;21568;8282.213189746964;8420;8450.112738162405;8454.577271136419;8557.27263182624;4457.621102206349;4508.436445444319;4644.071185762861;4654.604358629486;4658.161530924466;3459.7232221422228;3564.091156755063;3576.5529308836394;3576.660217279354;3582.964170358315;618.9009758438629;628.0892705576932;631.8988961766096;640.503609702475;640.5644161969905;587.318710296063;588.855730346068;657.3131078023476;668.2849351194176;672.6367761408882;8176.269167783213;8716.389852710376;8750.781230469289;8901.643934242558;8938;467.39238989313753;500.4220125754686;546.7840203119825;563.6646195513663;588.4321629627344;4018.1865315970954;4293.463317085364;4295.162443323585;4332.054723825326;4433.46798384196;87627;109826;111630.44184779024;112283.43858280656;115654;97253.51373243089;99345;99742;99859.50070249602;100178.49910750546;87217;88105.55947220222;88508.9999999987;88820.11179888119;88945.55527222322;7792.649330780242;7823.085135040693;7896.131425543301;7991.520508769492;8044.436889417684;51686.74156629193;51709.7414512925;51797;54012;54255;69619.3038069633;76087;76695.61652191704;76823;76907.23092769;10625.734356641145;10787.190960677824;10795.29830561011;11044.668659940215;11266.549338026387;11343.602973896204;11673.883261167279;11881.465334060162;12287.888818648176;12411.193272437262;9948.701538953843;9952.502374881082;9971.850422243817;10213.895207310592;10300.330478518872;10917.290376125526;11296.43517824089;11522.654320370402;11649.825252621387;11672.124590655905;9973.900260997587;10232.795344092927;10233.437160956219;10493.861091261697;10567.365958042234;8788.780280492783;8915.148726018446;9015.05341939087;9379.531023448937;9401.435913845191;8075.016424774635;8317.209865062809;8587.927348292586;8819.470831750115;9067.274618030673 13:48:54 INFO - PROCESS | 2051 | __end_tp_report 13:48:54 INFO - PROCESS | 2051 | __start_cc_report 13:48:54 INFO - PROCESS | 2051 | _x_x_mozilla_cycle_collect,865 13:48:54 INFO - PROCESS | 2051 | __end_cc_report 13:48:54 INFO - PROCESS | 2051 | __startTimestamp1465850934285__endTimestamp 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | ------- Summary: start ------- 13:48:54 INFO - PROCESS | 2051 | Number of tests: 6 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#0] dojo.html Cycles:165 Average:5319.07 Median:5511.31 stddev:586.87 (10.6%) stddev-sans-first:562.72 13:48:54 INFO - PROCESS | 2051 | Values: 3119.1 3134.7 3155.8 3163.1 3190.0 5293.7 5329.9 5402.4 5434.1 5451.3 5294.1 5299.0 5374.3 5390.4 5409.0 4826.4 4890.5 4903.3 4911.6 5039.0 4929.2 4947.3 4970.9 4980.7 5000.6 4709.3 4784.3 4832.5 4848.0 4937.2 4858.1 4874.0 4944.7 4945.1 4994.2 4723.1 4892.3 4918.2 4932.0 4967.1 5116.8 5166.6 5170.9 5244.8 5259.4 5602.4 5602.7 5614.4 5626.1 5634.1 5488.9 5620.9 5626.3 5656.5 5658.9 5340.4 5408.9 5428.2 5434.4 5436.5 5910.3 5929.1 5929.9 5933.5 5935.4 5411.2 5518.9 5523.6 5683.8 5689.1 5704.0 5763.3 5765.5 5774.9 5777.0 5681.9 5700.4 5704.4 5704.6 5713.5 5585.6 5639.1 5649.6 5654.9 5676.1 4406.3 4421.7 4425.1 4426.2 4459.6 3938.7 3944.5 3960.6 3999.1 4022.4 5264.1 5317.5 5346.8 5351.7 5357.2 5684.3 5702.6 5708.8 5709.0 5743.3 5405.5 5412.6 5415.9 5417.2 5419.3 4900.9 4912.6 4937.9 4946.6 4999.3 5954.2 5954.8 5957.1 5965.9 5965.9 5671.9 5682.9 5689.2 5690.8 5692.6 5628.5 5902.3 5984.7 6043.6 6121.8 5660.7 5684.7 5685.2 5690.1 5690.9 5534.3 5789.2 5796.0 5798.7 5798.9 5468.6 5511.3 5519.7 5554.6 5565.2 5549.0 5549.3 5555.1 5558.5 5563.2 5327.6 5493.4 5498.3 5498.9 5548.3 5764.6 5771.0 5772.2 5781.2 5781.4 5553.3 5586.0 5586.4 5598.0 5601.7 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#1] ext.html Cycles:180 Average:60934.33 Median:41507.69 stddev:122314.08 (294.7%) stddev-sans-first:122573.28 13:48:54 INFO - PROCESS | 2051 | Values: 586.6 621.7 625.7 629.8 646.6 32069.5 35579.6 35617.5 35645.0 42740.0 40833.0 45758.5 45855.3 45866.0 45925.8 8833.1 9073.9 9080.0 9082.0 9082.3 8845.4 8892.1 8950.6 8956.2 8958.2 8963.9 9007.5 9009.2 9009.3 9012.8 8916.5 8952.5 8959.6 8973.1 8974.1 8858.1 8903.4 8918.9 8928.8 8929.7 41699.0 42122.4 42139.0 42141.2 42143.6 3644.2 3677.4 3817.4 3875.2 4242.2 32755.5 33223.7 33266.3 33576.0 34374.0 4307.3 4318.5 4366.3 4378.8 4551.5 321688.0 321731.0 322071.0 322772.0 323615.0 55760.0 56116.4 56260.0 56294.0 56700.0 36518.5 37505.4 37518.4 39750.6 39787.6 17588.1 17725.6 17757.5 17762.1 17768.9 13624.8 13752.2 13813.5 13821.7 13829.0 19377.3 19533.4 19581.1 19627.3 19777.2 7256.9 7261.5 7311.9 7407.3 7432.6 998.6 1083.6 1145.0 1148.5 1188.5 32003.5 32100.5 32136.8 32535.3 33113.0 1111.2 1115.4 1166.7 1176.8 1195.3 16732.2 17052.7 17151.1 17239.7 17350.1 543323.0 546527.0 547399.0 549028.0 551236.0 58880.0 59642.0 59694.0 59737.0 59754.0 1279.6 1344.3 1353.5 1365.1 1403.8 31178.3 32475.0 32760.3 33053.0 33294.5 49451.0 54036.5 56251.0 56357.7 62187.0 479593.0 480653.0 483115.0 483861.0 486274.0 36989.8 44954.8 45057.3 45558.8 46620.5 48130.4 48196.5 49264.0 49264.8 49712.5 37473.0 40993.4 41340.4 41943.8 42501.0 40072.8 40413.0 40757.4 41378.4 41491.0 40275.4 40790.4 41380.4 41382.6 41524.4 31192.4 33885.5 34480.8 34526.5 34714.5 27541.6 27622.3 27702.0 27882.9 28124.7 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#2] jquery.html Cycles:180 Average:28113.57 Median:12417.32 stddev:76036.18 (612.3%) stddev-sans-first:76221.02 13:48:54 INFO - PROCESS | 2051 | Values: 406.0 410.7 410.8 423.6 429.7 13400.7 17758.6 19481.8 19790.1 19802.0 13917.7 18164.5 18251.4 18709.3 19100.3 5632.9 5877.6 5880.5 5881.4 5913.2 5715.8 5774.5 5821.9 5822.0 5827.9 4133.0 6084.0 6392.6 6396.9 6510.3 6216.8 6442.7 6459.1 6467.4 6496.1 5684.8 5727.0 5727.5 5761.0 5767.9 19087.5 20556.9 22519.9 22572.5 23032.3 2250.5 2262.1 2273.7 2337.9 2379.3 10336.2 10336.5 10910.3 11239.8 14694.6 1800.8 1913.5 1965.2 1995.5 2000.2 78202.6 79211.6 83426.6 85251.7 85490.6 10835.3 11076.8 11196.4 11212.9 11397.9 15510.8 15603.4 15674.5 15692.6 15711.0 7533.7 7686.1 7762.8 7894.6 7976.4 7143.1 7290.7 7297.7 7381.9 7769.7 4361.6 4528.4 4591.7 4647.7 4892.2 2027.9 2034.6 2054.1 2073.9 2104.2 898.5 965.7 989.2 1015.9 1024.1 17164.3 18526.4 18720.5 18835.5 18902.0 1001.0 1018.0 1019.6 1028.0 1030.7 9189.3 10369.2 10499.4 10584.5 10587.4 442615.0 445118.0 464834.0 470811.0 474809.0 65732.4 86485.0 87696.0 99186.5 102213.0 1003.3 1007.2 1041.6 1045.8 1058.3 16964.0 17107.4 17132.4 17326.7 17823.6 33764.5 42629.4 42734.8 43311.6 44431.6 62019.4 62335.0 62785.0 63424.4 64612.7 8930.8 9079.5 9139.7 9169.8 9296.9 9798.4 12321.9 12857.7 13238.0 13560.7 11202.7 11422.0 11422.5 11525.1 11697.4 11125.4 11364.9 11656.0 11678.3 11824.6 11548.4 11621.0 12200.5 12231.1 12238.8 8942.6 8949.9 9012.8 9025.6 9170.0 10973.2 11035.7 11210.7 11568.2 12089.6 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#3] mootools.html Cycles:180 Average:6165.89 Median:2714.83 stddev:3588.77 (132.2%) stddev-sans-first:3580.18 13:48:54 INFO - PROCESS | 2051 | Values: 1297.5 1470.6 1495.5 1595.3 1734.8 8634.4 9007.5 9019.1 9300.6 9326.3 9085.0 9296.1 9306.0 9312.2 9318.2 2464.4 2488.5 2491.3 2492.8 2493.0 2438.5 2517.7 2520.8 2522.4 2536.6 2380.3 2384.1 2421.0 2422.3 2423.6 2401.3 2414.3 2421.7 2422.9 2432.3 2353.0 2358.5 2386.3 2416.2 2419.1 8063.7 8321.6 9380.3 9421.9 9498.1 5445.2 5605.3 5611.9 5693.8 5700.3 3392.2 3436.1 3464.8 3489.2 3489.7 1076.6 1076.9 1082.7 1083.6 1098.3 13032.0 13152.5 13170.1 13187.7 13196.1 5007.0 5033.4 5122.6 5123.8 5150.4 11197.6 11217.6 11223.9 11244.3 11272.3 5706.0 5711.0 5716.0 5718.8 5725.9 4938.8 5108.4 5123.6 5124.1 5179.9 3884.2 4023.7 4026.9 4045.9 4111.3 1165.7 1177.0 1178.0 1187.1 1224.3 920.1 973.9 990.4 1005.1 1014.5 6220.5 6256.7 6325.7 6491.3 6591.6 470.4 477.3 490.1 490.9 497.0 4073.6 4494.3 4523.4 4539.0 4570.5 11402.9 11771.6 11848.2 11964.5 11985.9 11882.6 11884.6 11892.1 11894.5 11900.8 8260.1 8585.1 8674.8 8896.0 8905.9 6338.2 6482.2 6597.4 6611.6 6699.9 10823.5 10922.4 11147.5 11172.4 11177.0 10849.9 10993.3 11224.8 11258.6 11269.9 8393.7 8485.6 8553.9 8556.4 8561.3 8176.5 8460.3 8471.8 8990.5 9067.8 8205.8 8215.4 8241.9 8297.2 8345.3 7765.0 7866.7 8111.9 8170.7 8217.2 7519.9 7555.2 7573.9 7592.2 7597.7 5229.1 5301.5 5337.6 5444.8 5477.8 5269.7 5669.8 5686.1 5800.5 5852.7 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#4] prototype.html Cycles:180 Average:4597.13 Median:5193.45 stddev:1333.12 (25.7%) stddev-sans-first:1297.99 13:48:54 INFO - PROCESS | 2051 | Values: 339.4 346.9 353.0 360.9 361.0 5244.4 5252.9 5270.9 5272.7 5284.8 5190.7 5196.2 5223.0 5223.1 5223.8 4083.8 4136.4 4155.6 4172.9 4173.8 4125.9 4144.8 4152.0 4163.0 4178.6 3913.9 4123.8 4133.8 4142.3 4145.4 3898.1 3902.8 4039.1 4041.9 4054.4 3669.8 3681.4 3684.9 3688.2 3708.3 5024.2 5068.2 5068.3 5077.6 5108.0 4497.9 4529.6 4703.4 4720.1 4722.9 5426.3 5468.4 5469.0 5476.5 5483.2 4043.6 4052.1 4052.3 4058.2 4059.4 5535.2 5541.9 5599.3 5622.9 5707.6 4125.1 4137.6 4139.2 4140.3 4145.9 4163.7 4175.6 4177.1 4177.6 4184.9 4421.6 4698.7 4703.2 4704.9 4714.5 5450.5 5476.2 5480.8 5511.7 5542.4 1411.2 1424.4 1425.2 1428.6 1431.5 889.4 928.4 933.0 935.6 941.0 4710.6 4710.9 4726.6 4728.0 4769.8 5005.7 5006.8 5029.6 5030.7 5041.3 4789.0 4801.9 4811.7 4847.8 4978.6 2960.8 2965.7 2975.5 3003.0 3017.6 5873.1 5903.7 5906.9 5923.1 5925.3 5497.4 5544.3 5635.9 5788.3 5806.8 5708.7 5766.3 5781.8 5782.2 5846.1 5520.8 5532.4 5543.1 5631.9 5643.7 5534.1 5580.7 5668.7 5682.9 5683.0 5816.4 5896.5 5909.2 5925.8 5970.0 4000.2 4074.4 4076.8 4087.3 4113.0 5508.8 5578.3 5621.2 5621.2 5636.7 5459.5 5474.4 5488.4 5492.2 5502.3 5225.8 5450.6 5461.4 5491.0 5512.4 5389.5 5424.9 5465.9 5466.9 5467.8 5482.6 5510.1 5551.2 5567.9 5580.8 5209.9 5351.2 5453.5 5473.8 5477.1 13:48:54 INFO - PROCESS | 2051 | 13:48:54 INFO - PROCESS | 2051 | [#5] yui.html Cycles:180 Average:20012.03 Median:587.88 stddev:29556.46 (5027.7%) stddev-sans-first:29604.13 13:48:54 INFO - PROCESS | 2051 | Values: 788.4 790.8 797.6 806.8 821.9 13649.3 14473.0 14546.2 14566.8 16473.7 14701.2 14719.6 14813.2 14826.3 14852.3 683.0 788.8 803.1 821.6 823.8 814.4 825.6 825.7 826.3 826.7 868.1 871.9 872.2 872.8 872.9 708.3 811.5 831.3 863.6 864.8 617.6 617.8 617.9 618.1 618.8 14625.3 14637.1 14651.3 14666.0 14685.5 13728.4 13801.9 13905.4 13957.1 14298.0 12430.8 12453.7 12472.3 12505.7 12632.4 4489.1 4589.1 4591.7 4593.9 4733.3 71390.0 72599.0 72981.0 72999.3 74273.0 11368.6 11524.5 11545.8 11952.1 12024.3 21477.4 21511.8 21517.0 21520.1 21568.0 8282.2 8420.0 8450.1 8454.6 8557.3 4457.6 4508.4 4644.1 4654.6 4658.2 3459.7 3564.1 3576.6 3576.7 3583.0 618.9 628.1 631.9 640.5 640.6 587.3 588.9 657.3 668.3 672.6 8176.3 8716.4 8750.8 8901.6 8938.0 467.4 500.4 546.8 563.7 588.4 4018.2 4293.5 4295.2 4332.1 4433.5 87627.0 109826.0 111630.4 112283.4 115654.0 97253.5 99345.0 99742.0 99859.5 100178.5 87217.0 88105.6 88509.0 88820.1 88945.6 7792.6 7823.1 7896.1 7991.5 8044.4 51686.7 51709.7 51797.0 54012.0 54255.0 69619.3 76087.0 76695.6 76823.0 76907.2 10625.7 10787.2 10795.3 11044.7 11266.5 11343.6 11673.9 11881.5 12287.9 12411.2 9948.7 9952.5 9971.9 10213.9 10300.3 10917.3 11296.4 11522.7 11649.8 11672.1 9973.9 10232.8 10233.4 10493.9 10567.4 8788.8 8915.1 9015.1 9379.5 9401.4 8075.0 8317.2 8587.9 8819.5 9067.3 13:48:54 INFO - PROCESS | 2051 | -------- Summary: end -------- 13:48:54 INFO - PROCESS | 2051 | 13:48:55 INFO - TEST-INFO | 2051: exit 0 13:48:55 INFO - TEST-OK | dromaeo_css | took 1114189ms 13:48:55 INFO - TEST-START | kraken 13:48:55 INFO - operating with platform_type : linux_ 13:48:55 INFO - Initialising browser for kraken test... 13:48:55 INFO - TEST-INFO | started process 2231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44guIG/profile http://localhost:52446/getInfo.html) 13:48:59 INFO - PROCESS | 2231 | __metrics Screen width/height:1600/1200 13:48:59 INFO - PROCESS | 2231 | colorDepth:24 13:48:59 INFO - PROCESS | 2231 | Browser inner width/height: 1024/697 13:48:59 INFO - PROCESS | 2231 | __metrics 13:49:00 INFO - PROCESS | 2231 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:49:00 INFO - PROCESS | 2231 | console.error: PushService: 13:49:00 INFO - PROCESS | 2231 | stateChangeProcessEnqueue: Error transitioning state 13:49:00 INFO - PROCESS | 2231 | UnknownError 13:49:01 INFO - TEST-INFO | 2231: exit 0 13:49:01 INFO - Browser initialized. 13:49:01 INFO - Running cycle 1/1 for kraken test... 13:49:01 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44guIG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:13 INFO - PROCESS | 2314 | RSS: Main: 173756416 13:49:13 INFO - PROCESS | 2314 | 13:49:15 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-beat-detection) 13:49:16 INFO - PROCESS | 2314 | RSS: Main: 233144320 13:49:16 INFO - PROCESS | 2314 | 13:49:19 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-dft) 13:49:19 INFO - PROCESS | 2314 | RSS: Main: 222081024 13:49:19 INFO - PROCESS | 2314 | 13:49:23 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-fft) 13:49:23 INFO - PROCESS | 2314 | RSS: Main: 286879744 13:49:23 INFO - PROCESS | 2314 | 13:49:25 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52446/tests/kraken/driver.html?testName=audio-oscillator) 13:49:26 INFO - PROCESS | 2314 | RSS: Main: 198246400 13:49:26 INFO - PROCESS | 2314 | 13:49:28 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:49:29 INFO - PROCESS | 2314 | RSS: Main: 201805824 13:49:29 INFO - PROCESS | 2314 | 13:49:32 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-darkroom) 13:49:32 INFO - PROCESS | 2314 | RSS: Main: 238444544 13:49:32 INFO - PROCESS | 2314 | 13:49:36 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52446/tests/kraken/driver.html?testName=imaging-desaturate) 13:49:36 INFO - PROCESS | 2314 | RSS: Main: 238882816 13:49:36 INFO - PROCESS | 2314 | 13:49:39 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52446/tests/kraken/driver.html?testName=json-parse-financial) 13:49:40 INFO - PROCESS | 2314 | RSS: Main: 239144960 13:49:40 INFO - PROCESS | 2314 | 13:49:41 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52446/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:49:42 INFO - PROCESS | 2314 | RSS: Main: 227332096 13:49:42 INFO - PROCESS | 2314 | 13:49:43 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:49:44 INFO - PROCESS | 2314 | RSS: Main: 231817216 13:49:44 INFO - PROCESS | 2314 | 13:49:46 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:49:47 INFO - PROCESS | 2314 | RSS: Main: 237363200 13:49:47 INFO - PROCESS | 2314 | 13:49:49 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:49:50 INFO - PROCESS | 2314 | RSS: Main: 238018560 13:49:50 INFO - PROCESS | 2314 | 13:49:53 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:49:53 INFO - PROCESS | 2314 | RSS: Main: 238452736 13:49:53 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | Cycle 1(1): loaded http://localhost:52446/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52446/tests/kraken/driver.html?testName=ai-astar) 13:49:55 INFO - PROCESS | 2314 | RSS: Main: 281968640 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | __start_tp_report 13:49:55 INFO - PROCESS | 2314 | _x_x_mozilla_page_load 13:49:55 INFO - PROCESS | 2314 | _x_x_mozilla_page_load_details 13:49:55 INFO - PROCESS | 2314 | |i|pagename|runs| 13:49:55 INFO - PROCESS | 2314 | |0;ai-astar;109;105;109;110;111;110;110;111;110;109 13:49:55 INFO - PROCESS | 2314 | |1;audio-beat-detection;153;128;127;179;132;127;153;125;159;126 13:49:55 INFO - PROCESS | 2314 | |2;audio-dft;161;161;161;161;161;162;161;161;162;161 13:49:55 INFO - PROCESS | 2314 | |3;audio-fft;73;74;75;130;77;74;75;74;97;75 13:49:55 INFO - PROCESS | 2314 | |4;audio-oscillator;86;84;114;85;86;86;123;86;86;125 13:49:55 INFO - PROCESS | 2314 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;117 13:49:55 INFO - PROCESS | 2314 | |6;imaging-darkroom;145;146;145;145;145;146;145;145;145;145 13:49:55 INFO - PROCESS | 2314 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 13:49:55 INFO - PROCESS | 2314 | |8;json-parse-financial;55;53;52;53;55;59;53;54;53;53 13:49:55 INFO - PROCESS | 2314 | |9;json-stringify-tinderbox;61;62;63;62;61;61;62;61;61;62 13:49:55 INFO - PROCESS | 2314 | |10;stanford-crypto-aes;81;79;79;79;77;80;84;80;111;83 13:49:55 INFO - PROCESS | 2314 | |11;stanford-crypto-ccm;126;122;121;129;129;129;119;121;133;149 13:49:55 INFO - PROCESS | 2314 | |12;stanford-crypto-pbkdf2;157;158;156;160;158;163;159;159;163;159 13:49:55 INFO - PROCESS | 2314 | |13;stanford-crypto-sha256-iterative;64;66;62;62;65;62;63;62;62;61 13:49:55 INFO - PROCESS | 2314 | __end_tp_report 13:49:55 INFO - PROCESS | 2314 | __start_cc_report 13:49:55 INFO - PROCESS | 2314 | _x_x_mozilla_cycle_collect,1610 13:49:55 INFO - PROCESS | 2314 | __end_cc_report 13:49:55 INFO - PROCESS | 2314 | __startTimestamp1465850995715__endTimestamp 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | ------- Summary: start ------- 13:49:55 INFO - PROCESS | 2314 | Number of tests: 14 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.71 (1.6%) stddev-sans-first:1.81 13:49:55 INFO - PROCESS | 2314 | Values: 109.0 105.0 109.0 110.0 111.0 110.0 110.0 111.0 110.0 109.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:142.50 stddev:18.79 (13.2%) stddev-sans-first:19.42 13:49:55 INFO - PROCESS | 2314 | Values: 153.0 128.0 127.0 179.0 132.0 127.0 153.0 125.0 159.0 126.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:49:55 INFO - PROCESS | 2314 | Values: 161.0 161.0 161.0 161.0 161.0 162.0 161.0 161.0 162.0 161.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:18.17 (24.2%) stddev-sans-first:18.95 13:49:55 INFO - PROCESS | 2314 | Values: 73.0 74.0 75.0 130.0 77.0 74.0 75.0 74.0 97.0 75.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:86.00 stddev:17.19 (20.0%) stddev-sans-first:17.84 13:49:55 INFO - PROCESS | 2314 | Values: 86.0 84.0 114.0 85.0 86.0 86.0 123.0 86.0 86.0 125.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:49:55 INFO - PROCESS | 2314 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:49:55 INFO - PROCESS | 2314 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:49:55 INFO - PROCESS | 2314 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:2.00 (3.7%) stddev-sans-first:2.09 13:49:55 INFO - PROCESS | 2314 | Values: 55.0 53.0 52.0 53.0 55.0 59.0 53.0 54.0 53.0 53.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 13:49:55 INFO - PROCESS | 2314 | Values: 61.0 62.0 63.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:80.00 stddev:9.94 (12.4%) stddev-sans-first:10.51 13:49:55 INFO - PROCESS | 2314 | Values: 81.0 79.0 79.0 79.0 77.0 80.0 84.0 80.0 111.0 83.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:129.00 stddev:8.74 (6.8%) stddev-sans-first:9.25 13:49:55 INFO - PROCESS | 2314 | Values: 126.0 122.0 121.0 129.0 129.0 129.0 119.0 121.0 133.0 149.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.30 (1.4%) stddev-sans-first:2.30 13:49:55 INFO - PROCESS | 2314 | Values: 157.0 158.0 156.0 160.0 158.0 163.0 159.0 159.0 163.0 159.0 13:49:55 INFO - PROCESS | 2314 | 13:49:55 INFO - PROCESS | 2314 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:1.60 (2.6%) stddev-sans-first:1.64 13:49:55 INFO - PROCESS | 2314 | Values: 64.0 66.0 62.0 62.0 65.0 62.0 63.0 62.0 62.0 61.0 13:49:55 INFO - PROCESS | 2314 | -------- Summary: end -------- 13:49:55 INFO - PROCESS | 2314 | 13:49:56 INFO - TEST-INFO | 2314: exit 0 13:49:56 INFO - TEST-OK | kraken | took 61688ms 13:49:56 INFO - SUITE-END | took 1175s 13:49:56 INFO - Completed test suite (00:19:36) 13:49:56 INFO - javascript benchmark 13:49:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.0642807157856, 3134.7335476484513, 3155.7633177511693, 3163.0827060152556, 3189.968100318996, 5293.708846013467, 5329.866753331169, 5402.35171779386, 5434.130539113743, 5451.264079349292, 5294.100002999489, 5299.046171689094, 5374.274472946161, 5390.353157621091, 5409.0, 4826.3725715657, 4890.510948905099, 4903.31353610493, 4911.607071434277, 5038.974805125969, 4929.235968424882, 4947.257911313314, 4970.850874473754, 4980.651354405193, 5000.62495312853, 4709.270063140201, 4784.306275590055, 4832.492588278251, 4847.951520484785, 4937.185364414867, 4858.101251268491, 4874.0251949609865, 4944.728039957801, 4945.109880221558, 4994.2009278515625, 4723.149833030053, 4892.315075889378, 4918.163912134945, 4931.950680493185, 4967.10592093423, 5116.846494605168, 5166.61250406221, 5170.896582068338, 5244.842654720364, 5259.368875734898, 5602.38373778884, 5602.691851948141, 5614.410486898858, 5626.127950167731, 5634.098544232903, 5488.890222195574, 5620.91568626471, 5626.324841019104, 5656.519195868356, 5658.943410565883, 5340.359156901158, 5408.945910540883, 5428.212909128154, 5434.402215756264, 5436.510714035677, 5910.34986151523, 5929.080992446177, 5929.911051334234, 5933.495652869555, 5935.376785437553, 5411.18832175169, 5518.944810551923, 5523.6409633373705, 5683.8010669626365, 5689.061304884648, 5704.030314846403, 5763.279590051244, 5765.452282033284, 5774.913376299359, 5777.0, 5681.886362272731, 5700.401457846866, 5704.401037891044, 5704.629199102045, 5713.457221563945, 5585.636933599303, 5639.097744360883, 5649.632773869767, 5654.943450565442, 5676.148577713376, 4406.33904914259, 4421.712588681726, 4425.137098265872, 4426.15902978433, 4459.620932220732, 3938.724289299779, 3944.546377166605, 3960.603939606074, 3999.060220848098, 4022.3966405039478, 5264.078786212397, 5317.521423071942, 5346.759395827197, 5351.732413379394, 5357.196420536873, 5684.317881854204, 5702.574356410897, 5708.80019199326, 5708.971455142698, 5743.282089738783, 5405.513503784599, 5412.648177868505, 5415.918761218585, 5417.160340147283, 5419.295491586068, 4900.852974410774, 4912.557869791664, 4937.901241975141, 4946.554810067111, 4999.3000979862845, 5954.166416701665, 5954.76180952757, 5957.076653118774, 5965.910511342333, 5965.940340596625, 5671.858203544944, 5682.943170568242, 5689.1750696148, 5690.800821971211, 5692.573057020657, 5628.549716022627, 5902.2622172228475, 5984.730687119003, 6043.607165534227, 6121.8469538260115, 5660.745266462936, 5684.7441865117, 5685.175649530712, 5690.146478028329, 5690.914636280377, 5534.252875861707, 5789.1895134680335, 5796.0436527972415, 5798.6810725410505, 5798.94201057984, 5468.617196796186, 5511.311086114236, 5519.69641669712, 5554.555635549227, 5565.1930470082425, 5549.0, 5549.278593782782, 5555.111182210989, 5558.471945165203, 5563.193336966198, 5327.573794096385, 5493.423190565093, 5498.3127109111365, 5498.945010549844, 5548.278723765885, 5764.567657425626, 5771.0, 5772.1630363596205, 5781.190633311256, 5781.4218578141845, 5553.250311208097, 5585.972070139624, 5586.413426590149, 5597.972010140086, 5601.719914004365], "value": 5280.94787794203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6392168816177, 621.7326549583677, 625.6715224507135, 629.7638385605399, 646.5635695905265, 32069.51895721563, 35579.64420355796, 35617.46573801392, 35645.0, 42740.0, 40833.0, 45758.542414575844, 45855.31217031747, 45866.0, 45925.77037114818, 8833.07252738463, 9073.909260907405, 9079.954600226989, 9082.046385129566, 9082.273418126533, 8845.380823342337, 8892.110788921122, 8950.641974321052, 8956.19394254517, 8958.193762561368, 8963.910360896405, 9007.459552426842, 9009.234215091725, 9009.279257659371, 9012.819743605123, 8916.465012099263, 8952.462852228855, 8959.552022398919, 8973.147550982614, 8974.14745599167, 8858.114188581154, 8903.37676362655, 8918.866217006685, 8928.821423571557, 8929.687460938836, 41699.0, 42122.36816447756, 42139.0, 42141.1571768566, 42143.57856421458, 3644.21649345392, 3677.3564626190578, 3817.408301713239, 3875.1668391296007, 4242.215190189825, 32755.50866737001, 33223.66776332254, 33266.33467330664, 33576.0, 34374.0, 4307.289297265947, 4318.52496225415, 4366.279563871957, 4378.78106094694, 4551.476580193287, 321688.0, 321731.0, 322071.0, 322772.0, 323615.0, 55760.0, 56116.43883561112, 56260.0, 56294.0, 56700.0, 36518.45222321667, 37505.43741843875, 37518.43722344167, 39750.60249397469, 39787.6127432355, 17588.12059397025, 17725.645487090187, 17757.46727598174, 17762.111894405487, 17768.91115544414, 13624.795628065587, 13752.174869507862, 13813.51652692171, 13821.654458638615, 13829.0, 19377.321793737152, 19533.413997580094, 19581.1188496518, 19627.31304404339, 19777.208911643662, 7256.927430725731, 7261.5280006799385, 7311.89032164518, 7407.333349996207, 7432.591207483532, 998.5805961496189, 1083.5936523803573, 1145.0496088246734, 1148.4831825678311, 1188.5127097889824, 32003.51994720081, 32100.518492222636, 32136.83931580327, 32535.349293014006, 33113.0, 1111.2332490581473, 1115.4255558387438, 1166.6966588687003, 1176.7705297466912, 1195.2649120790652, 16732.24704888283, 17052.65894682124, 17151.142442877805, 17239.74140387895, 17350.13249337528, 543323.0, 546527.0, 547399.0, 549028.0, 551236.0, 58880.0, 59642.0, 59694.0, 59737.0, 59754.0, 1279.5649479177125, 1344.287527610368, 1353.5127354152498, 1365.1399618240644, 1403.8315402151602, 31178.296666216873, 32475.0, 32760.344793104483, 33053.0, 33294.50058249177, 49451.0, 54036.459635403146, 56251.0, 56357.71821140868, 62187.0, 479593.0, 480653.0, 483115.0, 483861.0, 486274.0, 36989.815050924575, 44954.77522612366, 45057.324140137265, 45558.772206138754, 46620.53379466297, 48130.35283059465, 48196.518034820605, 49264.0, 49264.75367623139, 49712.502874970785, 37473.0, 40993.385099224135, 41340.37989430221, 41943.7902810484, 42501.0, 40072.7996360028, 40413.0, 40757.38863916984, 41378.379324310765, 41491.0, 40275.3958690614, 40790.38814417727, 41380.37929431121, 41382.586174139076, 41524.37713434362, 31192.37615247637, 33885.491717623765, 34480.82759586186, 34526.48210276798, 34714.479282811284, 27541.586876196474, 27622.309442264104, 27702.0, 27882.860585697752, 28124.71875281221], "value": 20347.154784750226, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.96549293310056, 410.70634496335117, 410.84182589702976, 423.59335038363173, 429.7185343599943, 13400.66498337542, 17758.644827103468, 19481.805181948177, 19790.10944507497, 19802.0, 13917.652058698537, 18164.545886352847, 18251.36120235792, 18709.251629934788, 19100.331488397907, 5632.887342253162, 5877.617954832944, 5880.529557635379, 5881.35305116439, 5913.231279933602, 5715.799947001856, 5774.480296773289, 5821.912671309934, 5821.970890145543, 5827.883442331151, 4132.97933510332, 6084.0, 6392.552521323486, 6396.93603063968, 6510.283868774431, 6216.844578885519, 6442.742290308382, 6459.09572659828, 6467.353264673542, 6496.123023391829, 5684.8010319638615, 5727.0, 5727.541796656257, 5761.0, 5767.855803604902, 19087.522811929673, 20556.897215513975, 22519.887400562893, 22572.54854902893, 23032.309030729106, 2250.5273892482596, 2262.083856038307, 2273.693051438051, 2337.8597284162834, 2379.2862141357523, 10336.17310615149, 10336.5348559315, 10910.290831096032, 11239.775204495945, 14694.55916322512, 1800.7568978187908, 1913.5120544261263, 1965.2040923426036, 1995.4811748945233, 2000.1899230811543, 78202.60898695527, 79211.60394197992, 83426.58286708589, 85251.6961972234, 85490.57254713749, 10835.349879007284, 11076.778464430667, 11196.440177991068, 11212.943935280271, 11397.943010284895, 15510.844891551165, 15603.375864965501, 15674.529764107096, 15692.607684807972, 15711.0, 7533.660985255567, 7686.116096648845, 7762.805929851799, 7894.565798881002, 7976.401769867167, 7143.107111611049, 7290.744823931243, 7297.70809167638, 7381.88927166093, 7769.650365733555, 4361.5856493633055, 4528.43394575678, 4591.655625828076, 4647.697899636512, 4892.241702536113, 2027.8884661343768, 2034.5523984723336, 2054.1167298061678, 2073.896305184765, 2104.168853302937, 898.5148020069089, 965.6620182935916, 989.2382865193761, 1015.9238057145743, 1024.134606257711, 17164.313427462763, 18526.444206673823, 18720.53198670017, 18835.52911177204, 18901.990415780303, 1000.9599616015278, 1018.0, 1019.6431249062917, 1027.9691609251734, 1030.7062487191265, 9189.264858811279, 10369.222308326755, 10499.422531760674, 10584.523696433525, 10587.364758114538, 442615.0, 445118.0, 464834.0, 470811.0, 474809.0, 65732.41274491722, 86485.0, 87696.0, 99186.5040674792, 102213.0, 1003.3377970539555, 1007.2445665750687, 1041.5833666533447, 1045.764702941832, 1058.3226734889677, 16964.0, 17107.401240956508, 17132.40036598713, 17326.653466930842, 17823.643527129127, 33764.49353259654, 42629.36055959225, 42734.78632606817, 43311.56688433075, 44431.55568444274, 62019.37980620136, 62335.0, 62785.0, 63424.365756341846, 64612.67693661502, 8930.821383572422, 9079.500627465553, 9139.680111196076, 9169.816603668023, 9296.860547091934, 9798.412095274307, 12321.93839030799, 12857.742845143232, 13238.0, 13560.660983475493, 11202.66392008241, 11422.0, 11422.48598813072, 11525.077993760648, 11697.415129243675, 11125.44372781374, 11364.886351136383, 11656.0, 11678.299302041905, 11824.586139485076, 11548.364839933884, 11621.0, 12200.51197952072, 12231.082668800054, 12238.816417753918, 8942.642294308154, 8949.910500894908, 9012.774680633036, 9025.638974440948, 9169.954150229472, 10973.177011723992, 11035.668929932115, 11210.719732006764, 11568.24806387582, 12089.637310880687], "value": 9224.04936780514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.5458589493674, 1470.602937206954, 1495.4541592318806, 1595.290095907321, 1734.75713400124, 8634.4387614805, 9007.549622518873, 9019.098090190986, 9300.627974880997, 9326.253899688025, 9084.954575227115, 9296.116868897461, 9306.0, 9312.208462280714, 9318.161365477106, 2464.408541949928, 2488.464980029293, 2491.3397949543387, 2492.7756501914823, 2492.987535062331, 2438.5244877248942, 2517.748225177486, 2520.823542352036, 2522.445062086338, 2536.581464058428, 2380.321608341623, 2384.1297926256966, 2420.987895060522, 2422.321749910028, 2423.6243382275775, 2401.255610760661, 2414.2515820095737, 2421.69728783902, 2422.8909699063584, 2432.3067925641194, 2353.0, 2358.5282943411385, 2386.3198988288254, 2416.190576156972, 2419.068658566447, 8063.717769878085, 8321.625526851245, 9380.296477764196, 9421.858672119924, 9498.14516693501, 5445.210444485528, 5605.271314729059, 5611.859703507404, 5693.77224911003, 5700.287464066992, 3392.1858753899132, 3436.1237884339585, 3464.7574669773126, 3489.2323688788424, 3489.70337521311, 1076.6178006807627, 1076.9138468922545, 1082.6860210538935, 1083.6478144603036, 1098.3080659184743, 13032.0, 13152.473901043946, 13170.078094533386, 13187.670308242275, 13196.14225075367, 5007.0, 5033.395992480852, 5122.615803814729, 5123.795048198105, 5150.356205474316, 11197.552097916156, 11217.55129794799, 11223.943880280547, 11244.325340479434, 11272.267302625303, 5706.0, 5711.029125048752, 5716.0, 5718.771249150071, 5725.885482290414, 4938.777755001033, 5108.438071812097, 5123.641345105807, 5124.052050370693, 5179.922301165486, 3884.1649045455365, 4023.657989070903, 4026.859059932947, 4045.858394956221, 4111.301078816608, 1165.7260543772206, 1177.0, 1177.9764404711857, 1187.091874715843, 1224.253205544617, 920.07992007992, 973.9172170365598, 990.3711143423977, 1005.0799698376744, 1014.4927536231884, 6220.471259942956, 6256.655883926337, 6325.715342809584, 6491.318411566812, 6591.604503729792, 470.37440204527894, 477.25309890022004, 490.0737605924805, 490.88464210910405, 496.9875753106201, 4073.6130067643526, 4494.303382975644, 4523.36672865799, 4538.9546104539195, 4570.451545814523, 11402.885971140182, 11771.587994420153, 11848.229865058744, 11964.521419143137, 11985.880141198477, 11882.584109556125, 11884.584039558575, 11892.108091893142, 11894.464749086312, 11900.821487677691, 8260.091389947102, 8585.141485851489, 8674.826503470022, 8895.955520222358, 8905.931288245323, 6338.207724034496, 6482.157319548429, 6597.406233439014, 6611.603303801788, 6699.899501507579, 10823.458827058457, 10922.399268040333, 11147.498362573866, 11172.385518796544, 11177.049950754277, 10849.945750271198, 10993.340399576051, 11224.7755044897, 11258.605948791754, 11269.943650281695, 8393.706220282262, 8485.618147183268, 8553.914460855312, 8556.443831150955, 8561.272291855013, 8176.503603482721, 8460.280876125598, 8471.788205294917, 8990.505522196341, 9067.818643627223, 8205.79485512867, 8215.424920255764, 8241.917580824114, 8297.170282971654, 8345.33237340999, 7765.0, 7866.724664636939, 8111.918880811352, 8170.673173073011, 8217.219364160395, 7519.887201691869, 7555.168931417649, 7573.9242607575425, 7592.164861865301, 7597.734079307198, 5229.111051121243, 5301.5493683037375, 5337.572994160536, 5444.754986025559, 5477.780888764405, 5269.657472264291, 5669.801556945487, 5686.147077938177, 5800.535957123336, 5852.707364631837], "value": 4793.5407355457055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3586122228988, 346.8664564142805, 352.95235143255667, 360.88451695457434, 361.03063275106325, 5244.351602440762, 5252.947470525299, 5270.893112446382, 5272.657277276974, 5284.762185701643, 5190.662606930547, 5196.246544251091, 5223.0, 5223.112070947938, 5223.764930578123, 4083.816228269735, 4136.420901073837, 4155.628642547952, 4172.853950111747, 4173.791310434482, 4125.876223713293, 4144.792760361985, 4151.979240103795, 4163.0, 4178.623923846853, 3913.902152446183, 4123.773192474413, 4133.793310334487, 4142.295809712341, 4145.419641250227, 3898.1034362096593, 3902.804859757001, 4039.1113954930015, 4041.898952526181, 4054.3715724062818, 3669.8348574313954, 3681.4109742441083, 3684.9263014739554, 3688.2254726507467, 3708.295423869456, 5024.171011783088, 5068.239764035387, 5068.315777370045, 5077.64456488046, 5108.003939231851, 4497.9325310120375, 4529.592336689714, 4703.43558772946, 4720.12677654635, 4722.858314250578, 5426.294581704393, 5468.371137319219, 5468.9726551367385, 5476.534494567966, 5483.232347471358, 4043.6158564936286, 4052.0882801369753, 4052.3111071117983, 4058.2492238935893, 4059.391091336294, 5535.225068490415, 5541.9168712469345, 5599.272094627713, 5622.943770562283, 5707.600467967244, 4125.133721918431, 4137.627613514738, 4139.2135494256, 4140.254754144223, 4145.922060264353, 4163.7293575917465, 4175.62419382257, 4177.143685544456, 4177.561356057631, 4184.895377615523, 4421.579949904753, 4698.694584851974, 4703.2004559225015, 4704.858854234379, 4714.45783734868, 5450.4549545045975, 5476.205950137208, 5480.7533660985355, 5511.724413779295, 5542.39033706292, 1411.2238268952035, 1424.3803945283835, 1425.1805212002932, 1428.5642878921822, 1431.484665520412, 889.3685483306924, 928.382625553999, 932.9580168892417, 935.5743136872707, 940.9811803763887, 4710.586823952801, 4710.882227944328, 4726.550977657117, 4727.95272047282, 4769.76151192439, 5005.724685142352, 5006.823396501819, 5029.5724863386295, 5030.7171671223605, 5041.294218809369, 4789.0, 4801.903961920742, 4811.724892903383, 4847.812285989955, 4978.6017118630425, 2960.8371539565533, 2965.6654505472625, 2975.523916173402, 3002.9549556756665, 3017.562453444238, 5873.119032145127, 5903.675297858573, 5906.940930590725, 5923.111533270044, 5925.34821169671, 5497.367802702661, 5544.251526044013, 5635.859103522363, 5788.27646544182, 5806.825795226066, 5708.7174874447355, 5766.250387449605, 5781.802914892398, 5782.219400380979, 5846.093855452412, 5520.846869720732, 5532.419095994863, 5543.057680194296, 5631.859203519781, 5643.661380317194, 5534.066944519411, 5580.693061881636, 5668.744906479301, 5682.857928551819, 5682.971585142048, 5816.3892791258, 5896.498797602252, 5909.23179986599, 5925.822225333247, 5969.9701501493955, 4000.219957108336, 4074.388841673654, 4076.8381011411607, 4087.325591277406, 4112.98463752765, 5508.779648814003, 5578.30271216098, 5621.213030175697, 5621.241132447068, 5636.718164091697, 5459.454054594509, 5474.425185355481, 5488.4237155098135, 5492.203630473638, 5502.257195278747, 5225.843224703265, 5450.645708028966, 5461.399246083007, 5490.972545137249, 5512.448755124456, 5389.541888939484, 5424.891502170013, 5465.890682186414, 5466.863328416822, 5467.797084641373, 5482.643628164316, 5510.1459273812625, 5551.195861344998, 5567.888642227052, 5580.832575022756, 5209.869753256199, 5351.197320401815, 5453.454654534515, 5473.8357849264585, 5477.068898287221], "value": 4179.863039327229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.3653658804661, 790.7509134622593, 797.6011994002998, 806.8305655812279, 821.909589945106, 13649.31753412329, 14473.0, 14546.199959002251, 14566.781498277522, 16473.67052658946, 14701.1914344711, 14719.632009199775, 14813.18527480988, 14826.258687065658, 14852.257387130654, 682.9590224586541, 788.7673136424739, 803.120582961659, 821.6179476543406, 823.798169448486, 814.3892080939296, 825.6243409248807, 825.6986200036973, 826.277007618334, 826.6528058215564, 868.1145231863495, 871.8910136232971, 872.2193636695154, 872.8297981893534, 872.9127087291283, 708.3023222126227, 811.4887620798918, 831.2601784411878, 863.6243234193115, 864.8054187807725, 617.57387402692, 617.8023032629516, 617.9258488981351, 618.1253526260336, 618.7524990004034, 14625.341859616236, 14637.121772693672, 14651.340689668883, 14666.0, 14685.48600798967, 13728.382222799899, 13801.930990344985, 13905.374258158407, 13957.092788968685, 14298.0, 12430.813537796941, 12453.688657783538, 12472.251664900135, 12505.74988500234, 12632.431540580605, 4489.079738653568, 4589.059242855206, 4591.724496530219, 4593.862184134481, 4733.290006499018, 71390.0, 72599.0, 72981.0, 72999.33506981743, 74273.0, 11368.602098926498, 11524.539018439336, 11545.826812597817, 11952.103592230618, 12024.278543287432, 21477.355679329332, 21511.784882151293, 21517.0, 21520.139194432362, 21568.0, 8282.213189746964, 8420.0, 8450.112738162405, 8454.577271136419, 8557.27263182624, 4457.621102206349, 4508.436445444319, 4644.071185762861, 4654.604358629486, 4658.161530924466, 3459.7232221422228, 3564.091156755063, 3576.5529308836394, 3576.660217279354, 3582.964170358315, 618.9009758438629, 628.0892705576932, 631.8988961766096, 640.503609702475, 640.5644161969905, 587.318710296063, 588.855730346068, 657.3131078023476, 668.2849351194176, 672.6367761408882, 8176.269167783213, 8716.389852710376, 8750.781230469289, 8901.643934242558, 8938.0, 467.39238989313753, 500.4220125754686, 546.7840203119825, 563.6646195513663, 588.4321629627344, 4018.1865315970954, 4293.463317085364, 4295.162443323585, 4332.054723825326, 4433.46798384196, 87627.0, 109826.0, 111630.44184779024, 112283.43858280656, 115654.0, 97253.51373243089, 99345.0, 99742.0, 99859.50070249602, 100178.49910750546, 87217.0, 88105.55947220222, 88508.9999999987, 88820.11179888119, 88945.55527222322, 7792.649330780242, 7823.085135040693, 7896.131425543301, 7991.520508769492, 8044.436889417684, 51686.74156629193, 51709.7414512925, 51797.0, 54012.0, 54255.0, 69619.3038069633, 76087.0, 76695.61652191704, 76823.0, 76907.23092769, 10625.734356641145, 10787.190960677824, 10795.29830561011, 11044.668659940215, 11266.549338026387, 11343.602973896204, 11673.883261167279, 11881.465334060162, 12287.888818648176, 12411.193272437262, 9948.701538953843, 9952.502374881082, 9971.850422243817, 10213.895207310592, 10300.330478518872, 10917.290376125526, 11296.43517824089, 11522.654320370402, 11649.825252621387, 11672.124590655905, 9973.900260997587, 10232.795344092927, 10233.437160956219, 10493.861091261697, 10567.365958042234, 8788.780280492783, 8915.148726018446, 9015.05341939087, 9379.531023448937, 9401.435913845191, 8075.016424774635, 8317.209865062809, 8587.927348292586, 8819.470831750115, 9067.274618030673], "value": 7088.602877657761, "unit": "score"}], "name": "dromaeo_css", "value": 7212.628694788822, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 109.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 127.0, 179.0, 132.0, 127.0, 153.0, 125.0, 159.0, 126.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 130.0, 77.0, 74.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, 84.0, 114.0, 85.0, 86.0, 86.0, 123.0, 86.0, 86.0, 125.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 55.0, 59.0, 53.0, 54.0, 53.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 79.0, 77.0, 80.0, 84.0, 80.0, 111.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 121.0, 129.0, 129.0, 129.0, 119.0, 121.0, 133.0, 149.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 156.0, 160.0, 158.0, 163.0, 159.0, 159.0, 163.0, 159.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 62.0, 62.0, 65.0, 62.0, 63.0, 62.0, 62.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1495.8, "alertThreshold": 2.0}]} 13:49:56 INFO - Return code: 0 13:49:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:49:57 INFO - # TBPL SUCCESS # 13:49:57 INFO - Running post-action listener: _resource_record_post_action 13:49:57 INFO - ##### 13:49:57 INFO - ##### Finished run-tests step (success) 13:49:57 INFO - ##### 13:49:57 INFO - Running post-run listener: _resource_record_post_run 13:49:57 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 416649216; Read time: 8; Write time: 335540 13:49:57 INFO - TinderboxPrint: CPU usage
13.2% 13:49:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:49:57 INFO - TinderboxPrint: I/O write bytes / time
416,649,216 / 335,540 13:49:57 INFO - TinderboxPrint: CPU idle
8,270.7 (86.8%) 13:49:57 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 13:49:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:49:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128040960; Read time: 0; Write time: 108516 13:49:57 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288608256; Read time: 8; Write time: 227024 13:49:57 INFO - Running post-run listener: _upload_blobber_files 13:49:57 INFO - Blob upload gear active. 13:49:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:49:57 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:49:57 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:49:57 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:49:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:49:58 INFO - (blobuploader) - INFO - Done attempting. 13:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:02 INFO - (blobuploader) - INFO - Done attempting. 13:50:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:50:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:50:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:50:03 INFO - (blobuploader) - INFO - Done attempting. 13:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:50:03 INFO - Return code: 0 13:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:50:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1e998f70e2fc5f59516eb5f3fef659677eeb6a613d5cbbc33ece598c436304094b03558158ac97dd8b9b949c4f218a5660977e5f3f9c2fd6d252f4cc7ce2c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e68a446689e81557ba9c747ffadea3408bb8d6b1df46d2a3904c685a31b0ce7e6f926c89cb6ad13b34c0577bab433e47271e8412b12fb311a0d419131ff526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33bb30695b2b633d5973d921fb167e0590a5b3ed28d8d180b1edbd78df868e01f6909ab79638b80a671d818c81bc3d514a244187af3bab30aad1de19e803a351"} 13:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:50:03 INFO - Contents: 13:50:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a1e998f70e2fc5f59516eb5f3fef659677eeb6a613d5cbbc33ece598c436304094b03558158ac97dd8b9b949c4f218a5660977e5f3f9c2fd6d252f4cc7ce2c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e68a446689e81557ba9c747ffadea3408bb8d6b1df46d2a3904c685a31b0ce7e6f926c89cb6ad13b34c0577bab433e47271e8412b12fb311a0d419131ff526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33bb30695b2b633d5973d921fb167e0590a5b3ed28d8d180b1edbd78df868e01f6909ab79638b80a671d818c81bc3d514a244187af3bab30aad1de19e803a351"} 13:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:50:03 INFO - Copying logs to upload dir... 13:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.240144 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-13 13:50:02.129744) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 13:50:02.133690) ========= 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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 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/a1e998f70e2fc5f59516eb5f3fef659677eeb6a613d5cbbc33ece598c436304094b03558158ac97dd8b9b949c4f218a5660977e5f3f9c2fd6d252f4cc7ce2c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e68a446689e81557ba9c747ffadea3408bb8d6b1df46d2a3904c685a31b0ce7e6f926c89cb6ad13b34c0577bab433e47271e8412b12fb311a0d419131ff526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33bb30695b2b633d5973d921fb167e0590a5b3ed28d8d180b1edbd78df868e01f6909ab79638b80a671d818c81bc3d514a244187af3bab30aad1de19e803a351"} build_url:https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/bKEXJ0C0R-C6WbCjYzhc9w/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/a1e998f70e2fc5f59516eb5f3fef659677eeb6a613d5cbbc33ece598c436304094b03558158ac97dd8b9b949c4f218a5660977e5f3f9c2fd6d252f4cc7ce2c50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c4e68a446689e81557ba9c747ffadea3408bb8d6b1df46d2a3904c685a31b0ce7e6f926c89cb6ad13b34c0577bab433e47271e8412b12fb311a0d419131ff526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33bb30695b2b633d5973d921fb167e0590a5b3ed28d8d180b1edbd78df868e01f6909ab79638b80a671d818c81bc3d514a244187af3bab30aad1de19e803a351"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 13:50:02.158849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:50:02.159178) ========= 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=920470bf432669ad7e3a5387000001ca-1465829840.702882-1495654107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 13:50:02.243589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 13:50:02.243962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 13:50:02.244312) ========= ========= Total master_lag: 0.18 =========