builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1465081804.11 results: success (0) buildid: 20160604133054 builduid: 94d820166f8e4f319dfd2436f78ead93 revision: 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.106201) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.106988) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.107509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.124451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.125041) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 16:10:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-04 16:10:04 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133758 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.492977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.493257) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.539896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:04.540233) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 --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 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 --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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 16:10:04,937 truncating revision to first 12 chars 2016-06-04 16:10:04,938 Setting DEBUG logging. 2016-06-04 16:10:04,938 attempt 1/10 2016-06-04 16:10:04,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1f056b981b1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 16:10:05,357 unpacking tar archive at: mozilla-inbound-1f056b981b1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.803541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:05.361148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:05.361964) ========= script_repo_revision: 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:05.363004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:05.363733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 16:10:05.374072) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 16:10:05.374786) ========= /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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:10:05 INFO - MultiFileLogger online at 20160604 16:10:05 in /builds/slave/test 16:10:05 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 16:10:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:05 INFO - {'append_to_log': False, 16:10:05 INFO - 'base_work_dir': '/builds/slave/test', 16:10:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:10:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:05 INFO - 'branch': 'Mozilla-Inbound', 16:10:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:05 INFO - 'config_files': ('talos/linux_config.py',), 16:10:05 INFO - 'default_actions': ('clobber', 16:10:05 INFO - 'read-buildbot-config', 16:10:05 INFO - 'download-and-extract', 16:10:05 INFO - 'populate-webroot', 16:10:05 INFO - 'create-virtualenv', 16:10:05 INFO - 'install', 16:10:05 INFO - 'run-tests'), 16:10:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:05 INFO - 'download_minidump_stackwalk': True, 16:10:05 INFO - 'download_symbols': 'ondemand', 16:10:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:05 INFO - 'installer_path': 'installer.exe', 16:10:05 INFO - 'log_level': 'info', 16:10:05 INFO - 'log_name': 'talos', 16:10:05 INFO - 'log_to_console': True, 16:10:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:10:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:10:05 INFO - 'opt_config_files': (), 16:10:05 INFO - 'pip_index': False, 16:10:05 INFO - 'sps_profile': False, 16:10:05 INFO - 'sps_profile_interval': 0, 16:10:05 INFO - 'suite': 'dromaeojs', 16:10:05 INFO - 'system_bits': '32', 16:10:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:05 INFO - 'title': 'talos-linux64-ix-030', 16:10:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:05 INFO - 'use_talos_json': True, 16:10:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:05 INFO - 'work_dir': 'build'} 16:10:05 INFO - ##### 16:10:05 INFO - ##### Running clobber step. 16:10:05 INFO - ##### 16:10:05 INFO - Running pre-action listener: _resource_record_pre_action 16:10:05 INFO - Running main action method: clobber 16:10:05 INFO - rmtree: /builds/slave/test/build 16:10:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:06 INFO - Running post-action listener: _resource_record_post_action 16:10:06 INFO - ##### 16:10:06 INFO - ##### Finished clobber step (success) 16:10:06 INFO - ##### 16:10:06 INFO - ##### 16:10:06 INFO - ##### Running read-buildbot-config step. 16:10:06 INFO - ##### 16:10:06 INFO - Running pre-action listener: _resource_record_pre_action 16:10:06 INFO - Running main action method: read_buildbot_config 16:10:06 INFO - Using buildbot properties: 16:10:06 INFO - { 16:10:06 INFO - "project": "", 16:10:06 INFO - "product": "firefox", 16:10:06 INFO - "script_repo_revision": "production", 16:10:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:10:06 INFO - "repository": "", 16:10:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:10:06 INFO - "buildid": "20160604133054", 16:10:06 INFO - "pgo_build": "True", 16:10:06 INFO - "basedir": "/builds/slave/test", 16:10:06 INFO - "buildnumber": 1125, 16:10:06 INFO - "slavename": "talos-linux64-ix-030", 16:10:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:10:06 INFO - "platform": "ubuntu64_hw", 16:10:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:10:06 INFO - "branch": "mozilla-inbound", 16:10:06 INFO - "repo_path": "integration/mozilla-inbound", 16:10:06 INFO - "revision": "1f056b981b1f7e6e449cf1e67ee55481e569cdc7", 16:10:06 INFO - "stage_platform": "linux64-pgo", 16:10:06 INFO - "builduid": "94d820166f8e4f319dfd2436f78ead93", 16:10:06 INFO - "slavebuilddir": "test" 16:10:06 INFO - } 16:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:10:06 INFO - Running post-action listener: _resource_record_post_action 16:10:06 INFO - ##### 16:10:06 INFO - ##### Finished read-buildbot-config step (success) 16:10:06 INFO - ##### 16:10:06 INFO - ##### 16:10:06 INFO - ##### Running download-and-extract step. 16:10:06 INFO - ##### 16:10:06 INFO - Running pre-action listener: _resource_record_pre_action 16:10:06 INFO - Running main action method: download_and_extract 16:10:06 INFO - mkdir: /builds/slave/test/build/tests 16:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:06 INFO - https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:10:07 INFO - Downloaded 1361 bytes. 16:10:07 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:10:07 INFO - Using the following test package requirements: 16:10:07 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:07 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:10:07 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:10:07 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'jsshell-linux-x86_64.zip'], 16:10:07 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:10:07 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:10:07 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:10:07 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:10:07 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:10:07 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:10:07 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:10:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:10: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')]} 16:10:07 INFO - https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:08 INFO - Downloaded 24441874 bytes. 16:10:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:10:09 INFO - Return code: 0 16:10:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:09 INFO - https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:10:11 INFO - Downloaded 24441874 bytes. 16:10:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:10:12 INFO - Return code: 0 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:12 INFO - https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:10:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:10:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:10:13 INFO - Downloaded 10833369 bytes. 16:10:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:10:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:10:13 INFO - Return code: 0 16:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:13 INFO - https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:10:15 INFO - Downloaded 59164952 bytes. 16:10:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:15 INFO - mkdir: /builds/slave/test/properties 16:10:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:15 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:15 INFO - Contents: 16:10:15 INFO - build_url:https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:10:16 INFO - Running post-action listener: _resource_record_post_action 16:10:16 INFO - Running post-action listener: set_extra_try_arguments 16:10:16 INFO - ##### 16:10:16 INFO - ##### Finished download-and-extract step (success) 16:10:16 INFO - ##### 16:10:16 INFO - ##### 16:10:16 INFO - ##### Running populate-webroot step. 16:10:16 INFO - ##### 16:10:16 INFO - Running pre-action listener: _resource_record_pre_action 16:10:16 INFO - Running main action method: populate_webroot 16:10:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:16 INFO - '--tppagecycles', 16:10:16 INFO - '7'], 16:10:16 INFO - 'tests': ['tsvgm']}}, 16:10:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['damp', 'tps']}, 16:10:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['damp', 'tps']}, 16:10:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['dromaeo_dom']}, 16:10:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['a11yr', 16:10:16 INFO - 'ts_paint', 16:10:16 INFO - 'tpaint', 16:10:16 INFO - 'sessionrestore', 16:10:16 INFO - 'sessionrestore_no_auto_restore', 16:10:16 INFO - 'tabpaint']}, 16:10:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tsvgx', 16:10:16 INFO - 'tsvgr_opacity', 16:10:16 INFO - 'tart', 16:10:16 INFO - 'tscrollx', 16:10:16 INFO - 'cart']}, 16:10:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:16 INFO - 'tsvgr_opacity', 16:10:16 INFO - 'tart', 16:10:16 INFO - 'tscrollx', 16:10:16 INFO - 'cart']}, 16:10:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s'], 16:10:16 INFO - 'tests': ['tp5o']}, 16:10:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'tests': ['tp5o']}, 16:10:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--disable-e10s', 16:10:16 INFO - '--xperf_path', 16:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:16 INFO - 'tests': ['tp5n']}, 16:10:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:10:16 INFO - 'talos_options': ['--xperf_path', 16:10:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:16 INFO - 'tests': ['tp5n']}}, 16:10:16 INFO - 'talos.zip': {'path': '', 16:10:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:16 INFO - Running post-action listener: _resource_record_post_action 16:10:16 INFO - ##### 16:10:16 INFO - ##### Finished populate-webroot step (success) 16:10:16 INFO - ##### 16:10:16 INFO - ##### 16:10:16 INFO - ##### Running create-virtualenv step. 16:10:16 INFO - ##### 16:10:16 INFO - Running pre-action listener: _resource_record_pre_action 16:10:16 INFO - Running main action method: create_virtualenv 16:10:16 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:16 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 16:10:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:16 INFO - Using real prefix '/usr' 16:10:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:16 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:18 INFO - Installing pip.................done. 16:10:18 INFO - Return code: 0 16:10:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:18 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 16:10:18 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 16:10:18 INFO - Using env: {'DISPLAY': ':0', 16:10:18 INFO - 'HOME': '/home/cltbld', 16:10:18 INFO - 'LANG': 'en_US.UTF-8', 16:10:18 INFO - 'LANGUAGE': 'en_US:en', 16:10:18 INFO - 'LOGNAME': 'cltbld', 16:10:18 INFO - 'MAIL': '/var/mail/cltbld', 16:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:18 INFO - 'MOZ_NO_REMOTE': '1', 16:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:18 INFO - 'NO_EM_RESTART': '1', 16:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:18 INFO - 'PWD': '/builds/slave/test', 16:10:18 INFO - 'SHELL': '/bin/bash', 16:10:18 INFO - 'SHLVL': '1', 16:10:18 INFO - 'TERM': 'linux', 16:10:18 INFO - 'TMOUT': '86400', 16:10:18 INFO - 'USER': 'cltbld', 16:10:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:18 INFO - '_': '/tools/buildbot/bin/python'} 16:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:18 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 16:10:18 INFO - Cleaning up... 16:10:18 INFO - Return code: 0 16:10:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:18 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:18 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 16:10:18 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 16:10:18 INFO - Using env: {'DISPLAY': ':0', 16:10:18 INFO - 'HOME': '/home/cltbld', 16:10:18 INFO - 'LANG': 'en_US.UTF-8', 16:10:18 INFO - 'LANGUAGE': 'en_US:en', 16:10:18 INFO - 'LOGNAME': 'cltbld', 16:10:18 INFO - 'MAIL': '/var/mail/cltbld', 16:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:18 INFO - 'MOZ_NO_REMOTE': '1', 16:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:18 INFO - 'NO_EM_RESTART': '1', 16:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:18 INFO - 'PWD': '/builds/slave/test', 16:10:18 INFO - 'SHELL': '/bin/bash', 16:10:18 INFO - 'SHLVL': '1', 16:10:18 INFO - 'TERM': 'linux', 16:10:18 INFO - 'TMOUT': '86400', 16:10:18 INFO - 'USER': 'cltbld', 16:10:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:18 INFO - '_': '/tools/buildbot/bin/python'} 16:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:19 INFO - Downloading/unpacking psutil>=3.1.1 16:10:19 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 16:10:19 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 16:10:19 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 16:10:19 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 16:10:19 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 16:10:19 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 16:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:21 INFO - Installing collected packages: psutil 16:10:21 INFO - Running setup.py install for psutil 16:10:21 INFO - building 'psutil._psutil_linux' extension 16:10:21 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 16:10:21 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 16:10:21 INFO - building 'psutil._psutil_posix' extension 16:10:21 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 16:10:21 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 16:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:21 INFO - Successfully installed psutil 16:10:21 INFO - Cleaning up... 16:10:21 INFO - Return code: 0 16:10:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:21 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:21 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 16:10:21 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 16:10:21 INFO - Using env: {'DISPLAY': ':0', 16:10:21 INFO - 'HOME': '/home/cltbld', 16:10:21 INFO - 'LANG': 'en_US.UTF-8', 16:10:21 INFO - 'LANGUAGE': 'en_US:en', 16:10:21 INFO - 'LOGNAME': 'cltbld', 16:10:21 INFO - 'MAIL': '/var/mail/cltbld', 16:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:21 INFO - 'MOZ_NO_REMOTE': '1', 16:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:21 INFO - 'NO_EM_RESTART': '1', 16:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:21 INFO - 'PWD': '/builds/slave/test', 16:10:21 INFO - 'SHELL': '/bin/bash', 16:10:21 INFO - 'SHLVL': '1', 16:10:21 INFO - 'TERM': 'linux', 16:10:21 INFO - 'TMOUT': '86400', 16:10:21 INFO - 'USER': 'cltbld', 16:10:21 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:21 INFO - '_': '/tools/buildbot/bin/python'} 16:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:21 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 16:10:21 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 16:10:21 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 16:10:21 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 16:10:21 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 16:10:21 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 16:10:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:23 INFO - Installing collected packages: mozsystemmonitor 16:10:23 INFO - Running setup.py install for mozsystemmonitor 16:10:23 INFO - Successfully installed mozsystemmonitor 16:10:23 INFO - Cleaning up... 16:10:23 INFO - Return code: 0 16:10:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:23 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:23 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 16:10:23 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 16:10:23 INFO - Using env: {'DISPLAY': ':0', 16:10:23 INFO - 'HOME': '/home/cltbld', 16:10:23 INFO - 'LANG': 'en_US.UTF-8', 16:10:23 INFO - 'LANGUAGE': 'en_US:en', 16:10:23 INFO - 'LOGNAME': 'cltbld', 16:10:23 INFO - 'MAIL': '/var/mail/cltbld', 16:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:23 INFO - 'MOZ_NO_REMOTE': '1', 16:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:23 INFO - 'NO_EM_RESTART': '1', 16:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:23 INFO - 'PWD': '/builds/slave/test', 16:10:23 INFO - 'SHELL': '/bin/bash', 16:10:23 INFO - 'SHLVL': '1', 16:10:23 INFO - 'TERM': 'linux', 16:10:23 INFO - 'TMOUT': '86400', 16:10:23 INFO - 'USER': 'cltbld', 16:10:23 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:23 INFO - '_': '/tools/buildbot/bin/python'} 16:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:24 INFO - Downloading/unpacking jsonschema==2.5.1 16:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:26 INFO - warning: no files found matching '*.txt' 16:10:26 INFO - no previously-included directories found matching 'build' 16:10:26 INFO - no previously-included directories found matching 'dist' 16:10:26 INFO - no previously-included directories found matching '.git*' 16:10:26 INFO - Installing collected packages: jsonschema, functools32 16:10:26 INFO - Running setup.py install for functools32 16:10:26 INFO - warning: no files found matching '*.txt' 16:10:26 INFO - no previously-included directories found matching 'build' 16:10:26 INFO - no previously-included directories found matching 'dist' 16:10:26 INFO - no previously-included directories found matching '.git*' 16:10:26 INFO - Successfully installed jsonschema functools32 16:10:26 INFO - Cleaning up... 16:10:26 INFO - Return code: 0 16:10:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10:26 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')]} 16:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 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')]} 16:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:26 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:26 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 16:10:26 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 16:10:26 INFO - Using env: {'DISPLAY': ':0', 16:10:26 INFO - 'HOME': '/home/cltbld', 16:10:26 INFO - 'LANG': 'en_US.UTF-8', 16:10:26 INFO - 'LANGUAGE': 'en_US:en', 16:10:26 INFO - 'LOGNAME': 'cltbld', 16:10:26 INFO - 'MAIL': '/var/mail/cltbld', 16:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:26 INFO - 'MOZ_NO_REMOTE': '1', 16:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:26 INFO - 'NO_EM_RESTART': '1', 16:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:26 INFO - 'PWD': '/builds/slave/test', 16:10:26 INFO - 'SHELL': '/bin/bash', 16:10:26 INFO - 'SHLVL': '1', 16:10:26 INFO - 'TERM': 'linux', 16:10:26 INFO - 'TMOUT': '86400', 16:10:26 INFO - 'USER': 'cltbld', 16:10:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:26 INFO - '_': '/tools/buildbot/bin/python'} 16:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:26 INFO - Downloading/unpacking blobuploader==1.2.4 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:26 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 16:10:28 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:28 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 16:10:28 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 16:10:28 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 16:10:28 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 16:10:28 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 16:10:28 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 16:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:29 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 16:10:29 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 16:10:29 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 16:10:29 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 16:10:29 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 16:10:29 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 16:10:29 INFO - Downloading docopt-0.6.1.tar.gz 16:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:29 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:29 INFO - Running setup.py install for blobuploader 16:10:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:29 INFO - Running setup.py install for requests 16:10:29 INFO - Running setup.py install for docopt 16:10:29 INFO - Successfully installed blobuploader requests docopt 16:10:29 INFO - Cleaning up... 16:10:30 INFO - Return code: 0 16:10:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:30 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')]} 16:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:30 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')]} 16:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:30 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:30 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 16:10:30 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 16:10:30 INFO - Using env: {'DISPLAY': ':0', 16:10:30 INFO - 'HOME': '/home/cltbld', 16:10:30 INFO - 'LANG': 'en_US.UTF-8', 16:10:30 INFO - 'LANGUAGE': 'en_US:en', 16:10:30 INFO - 'LOGNAME': 'cltbld', 16:10:30 INFO - 'MAIL': '/var/mail/cltbld', 16:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:30 INFO - 'MOZ_NO_REMOTE': '1', 16:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:30 INFO - 'NO_EM_RESTART': '1', 16:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:30 INFO - 'PWD': '/builds/slave/test', 16:10:30 INFO - 'SHELL': '/bin/bash', 16:10:30 INFO - 'SHLVL': '1', 16:10:30 INFO - 'TERM': 'linux', 16:10:30 INFO - 'TMOUT': '86400', 16:10:30 INFO - 'USER': 'cltbld', 16:10:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:30 INFO - '_': '/tools/buildbot/bin/python'} 16:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:30 INFO - Running setup.py (path:/tmp/pip-oBinMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:30 INFO - Running setup.py (path:/tmp/pip-6QwWL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:30 INFO - Running setup.py (path:/tmp/pip-vf7Joh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:30 INFO - Running setup.py (path:/tmp/pip-1fxeeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:30 INFO - Running setup.py (path:/tmp/pip-BO0VCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:30 INFO - Running setup.py (path:/tmp/pip-2PB9kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:30 INFO - Running setup.py (path:/tmp/pip-Jq8jrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:30 INFO - Running setup.py (path:/tmp/pip-nMdMAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:30 INFO - Running setup.py (path:/tmp/pip-FNf_M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:30 INFO - Running setup.py (path:/tmp/pip-8RJ874-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:30 INFO - Running setup.py (path:/tmp/pip-B7rDoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:31 INFO - Running setup.py (path:/tmp/pip-oSNLrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:31 INFO - Running setup.py (path:/tmp/pip-cHw7DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:31 INFO - Running setup.py (path:/tmp/pip-7ab82a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:31 INFO - Running setup.py (path:/tmp/pip-4jqLql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:31 INFO - Running setup.py (path:/tmp/pip-gCcPHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:31 INFO - Running setup.py (path:/tmp/pip-2dLpDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:31 INFO - Running setup.py install for manifestparser 16:10:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:31 INFO - Running setup.py install for mozcrash 16:10:31 INFO - Running setup.py install for mozdebug 16:10:31 INFO - Running setup.py install for mozdevice 16:10:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:31 INFO - Running setup.py install for mozfile 16:10:31 INFO - Running setup.py install for mozhttpd 16:10:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozinfo 16:10:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozInstall 16:10:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozleak 16:10:32 INFO - Running setup.py install for mozlog 16:10:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for moznetwork 16:10:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozprocess 16:10:32 INFO - Running setup.py install for mozprofile 16:10:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozrunner 16:10:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:32 INFO - Running setup.py install for mozscreenshot 16:10:33 INFO - Running setup.py install for moztest 16:10:33 INFO - Running setup.py install for mozversion 16:10:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:33 INFO - Cleaning up... 16:10:33 INFO - Return code: 0 16:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:33 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:33 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 16:10:33 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 16:10:33 INFO - Using env: {'DISPLAY': ':0', 16:10:33 INFO - 'HOME': '/home/cltbld', 16:10:33 INFO - 'LANG': 'en_US.UTF-8', 16:10:33 INFO - 'LANGUAGE': 'en_US:en', 16:10:33 INFO - 'LOGNAME': 'cltbld', 16:10:33 INFO - 'MAIL': '/var/mail/cltbld', 16:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:33 INFO - 'MOZ_NO_REMOTE': '1', 16:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:33 INFO - 'NO_EM_RESTART': '1', 16:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:33 INFO - 'PWD': '/builds/slave/test', 16:10:33 INFO - 'SHELL': '/bin/bash', 16:10:33 INFO - 'SHLVL': '1', 16:10:33 INFO - 'TERM': 'linux', 16:10:33 INFO - 'TMOUT': '86400', 16:10:33 INFO - 'USER': 'cltbld', 16:10:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:33 INFO - '_': '/tools/buildbot/bin/python'} 16:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:33 INFO - Running setup.py (path:/tmp/pip-8g92vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:33 INFO - Running setup.py (path:/tmp/pip-YvE3F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:33 INFO - Running setup.py (path:/tmp/pip-RXpmwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:33 INFO - Running setup.py (path:/tmp/pip-Z0bIXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:33 INFO - Running setup.py (path:/tmp/pip-8vDWJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:33 INFO - Running setup.py (path:/tmp/pip-UwthLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:33 INFO - Running setup.py (path:/tmp/pip-x2Zsd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:33 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)) 16:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:33 INFO - Running setup.py (path:/tmp/pip-XyS3_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:34 INFO - Running setup.py (path:/tmp/pip-NJBYvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:34 INFO - Running setup.py (path:/tmp/pip-CFgJa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:34 INFO - Running setup.py (path:/tmp/pip-OPuO7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:34 INFO - Running setup.py (path:/tmp/pip-ZUqXCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:34 INFO - Running setup.py (path:/tmp/pip-bMZ3PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:34 INFO - Running setup.py (path:/tmp/pip-rYSVHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:34 INFO - Running setup.py (path:/tmp/pip-qnuM6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:34 INFO - Running setup.py (path:/tmp/pip-0bOVkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:34 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)) 16:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:34 INFO - Running setup.py (path:/tmp/pip-4bDMJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:34 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 16:10:34 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 16:10:34 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 16:10:34 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 16:10:34 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 16:10:34 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 16:10:36 INFO - Downloading blessings-1.6.tar.gz 16:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:36 INFO - Installing collected packages: blessings 16:10:36 INFO - Running setup.py install for blessings 16:10:36 INFO - Successfully installed blessings 16:10:36 INFO - Cleaning up... 16:10:36 INFO - Return code: 0 16:10:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:37 INFO - Reading from file tmpfile_stdout 16:10:37 INFO - Current package versions: 16:10:37 INFO - argparse == 1.2.1 16:10:37 INFO - blessings == 1.6 16:10:37 INFO - blobuploader == 1.2.4 16:10:37 INFO - docopt == 0.6.1 16:10:37 INFO - functools32 == 3.2.3-2 16:10:37 INFO - jsonschema == 2.5.1 16:10:37 INFO - manifestparser == 1.1 16:10:37 INFO - mozInstall == 1.12 16:10:37 INFO - mozcrash == 0.17 16:10:37 INFO - mozdebug == 0.1 16:10:37 INFO - mozdevice == 0.48 16:10:37 INFO - mozfile == 1.2 16:10:37 INFO - mozhttpd == 0.7 16:10:37 INFO - mozinfo == 0.9 16:10:37 INFO - mozleak == 0.1 16:10:37 INFO - mozlog == 3.2 16:10:37 INFO - moznetwork == 0.27 16:10:37 INFO - mozprocess == 0.22 16:10:37 INFO - mozprofile == 0.28 16:10:37 INFO - mozrunner == 6.11 16:10:37 INFO - mozscreenshot == 0.1 16:10:37 INFO - mozsystemmonitor == 0.3 16:10:37 INFO - moztest == 0.7 16:10:37 INFO - mozversion == 1.4 16:10:37 INFO - psutil == 3.1.1 16:10:37 INFO - requests == 1.2.3 16:10:37 INFO - wsgiref == 0.1.2 16:10:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:37 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 16:10:37 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 16:10:37 INFO - Using env: {'DISPLAY': ':0', 16:10:37 INFO - 'HOME': '/home/cltbld', 16:10:37 INFO - 'LANG': 'en_US.UTF-8', 16:10:37 INFO - 'LANGUAGE': 'en_US:en', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MAIL': '/var/mail/cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SHLVL': '1', 16:10:37 INFO - 'TERM': 'linux', 16:10:37 INFO - 'TMOUT': '86400', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - '_': '/tools/buildbot/bin/python'} 16:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 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)) 16:10:37 INFO - Cleaning up... 16:10:37 INFO - Return code: 0 16:10:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:37 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 16:10:37 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 16:10:37 INFO - Using env: {'DISPLAY': ':0', 16:10:37 INFO - 'HOME': '/home/cltbld', 16:10:37 INFO - 'LANG': 'en_US.UTF-8', 16:10:37 INFO - 'LANGUAGE': 'en_US:en', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MAIL': '/var/mail/cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SHLVL': '1', 16:10:37 INFO - 'TERM': 'linux', 16:10:37 INFO - 'TMOUT': '86400', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - '_': '/tools/buildbot/bin/python'} 16:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:10:37 INFO - Cleaning up... 16:10:37 INFO - Return code: 0 16:10:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:37 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 0x7f942ef4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14f73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, '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': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', '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 16:10:37 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 16:10:37 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 16:10:37 INFO - Using env: {'DISPLAY': ':0', 16:10:37 INFO - 'HOME': '/home/cltbld', 16:10:37 INFO - 'LANG': 'en_US.UTF-8', 16:10:37 INFO - 'LANGUAGE': 'en_US:en', 16:10:37 INFO - 'LOGNAME': 'cltbld', 16:10:37 INFO - 'MAIL': '/var/mail/cltbld', 16:10:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:37 INFO - 'MOZ_NO_REMOTE': '1', 16:10:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:37 INFO - 'NO_EM_RESTART': '1', 16:10:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:37 INFO - 'PWD': '/builds/slave/test', 16:10:37 INFO - 'SHELL': '/bin/bash', 16:10:37 INFO - 'SHLVL': '1', 16:10:37 INFO - 'TERM': 'linux', 16:10:37 INFO - 'TMOUT': '86400', 16:10:37 INFO - 'USER': 'cltbld', 16:10:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:37 INFO - '_': '/tools/buildbot/bin/python'} 16:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:37 INFO - Downloading/unpacking flake8 16:10:37 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 16:10:37 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 16:10:37 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 16:10:37 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 16:10:37 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 16:10:37 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 16:10:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:10:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:10:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:39 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 16:10:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:10:40 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 16:10:40 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 16:10:40 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 16:10:40 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 16:10:40 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 16:10:40 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 16:10:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:40 INFO - no previously-included directories found matching 'docs/_build' 16:10:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:10:40 INFO - Running setup.py install for pep8 16:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:10:40 INFO - no previously-included directories found matching 'docs/_build' 16:10:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:10:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:10:40 INFO - Cleaning up... 16:10:40 INFO - Return code: 0 16:10:40 INFO - Running post-action listener: _resource_record_post_action 16:10:40 INFO - Running post-action listener: _start_resource_monitoring 16:10:40 INFO - Starting resource monitoring. 16:10:40 INFO - ##### 16:10:40 INFO - ##### Finished create-virtualenv step (success) 16:10:40 INFO - ##### 16:10:40 INFO - ##### 16:10:40 INFO - ##### Running install step. 16:10:40 INFO - ##### 16:10:40 INFO - Running pre-action listener: _resource_record_pre_action 16:10:40 INFO - Running main action method: install 16:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:40 INFO - Reading from file tmpfile_stdout 16:10:40 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:40 INFO - Reading from file tmpfile_stdout 16:10:40 INFO - Output received: 16:10:40 INFO - Usage: mozinstall [options] installer 16:10:40 INFO - Options: 16:10:40 INFO - -h, --help show this help message and exit 16:10:40 INFO - -d DEST, --destination=DEST 16:10:40 INFO - Directory to install application into. [default: 16:10:40 INFO - "/builds/slave/test"] 16:10:40 INFO - --app=APP Application being installed. [default: firefox] 16:10:40 INFO - mkdir: /builds/slave/test/build/application 16:10:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:10:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:10:57 INFO - Reading from file tmpfile_stdout 16:10:57 INFO - Output received: 16:10:57 INFO - /builds/slave/test/build/application/firefox/firefox 16:10:57 INFO - Running post-action listener: _resource_record_post_action 16:10:57 INFO - ##### 16:10:57 INFO - ##### Finished install step (success) 16:10:57 INFO - ##### 16:10:57 INFO - ##### 16:10:57 INFO - ##### Running run-tests step. 16:10:57 INFO - ##### 16:10:57 INFO - Running pre-action listener: _resource_record_pre_action 16:10:57 INFO - Running main action method: run_tests 16:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:10:57 INFO - Python 2.7.3 16:10:57 INFO - Return code: 0 16:10:57 INFO - grabbing minidump binary from tooltool 16:10:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:57 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 0x1589990>, '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 0x14f5470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14f5900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:10:57 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 16:10:57 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 16:10:57 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 16:10:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:57 INFO - Return code: 0 16:10:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:10:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:10:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:10:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:10:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:10:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:10:58 INFO - Return code: 0 16:10:58 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/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:10:58 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/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 16:10:58 INFO - Using env: {'DISPLAY': ':0', 16:10:58 INFO - 'HOME': '/home/cltbld', 16:10:58 INFO - 'LANG': 'en_US.UTF-8', 16:10:58 INFO - 'LANGUAGE': 'en_US:en', 16:10:58 INFO - 'LOGNAME': 'cltbld', 16:10:58 INFO - 'MAIL': '/var/mail/cltbld', 16:10:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:58 INFO - 'MOZ_NO_REMOTE': '1', 16:10:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:58 INFO - 'NO_EM_RESTART': '1', 16:10:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:58 INFO - 'PWD': '/builds/slave/test', 16:10:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:58 INFO - 'SHELL': '/bin/bash', 16:10:58 INFO - 'SHLVL': '1', 16:10:58 INFO - 'TERM': 'linux', 16:10:58 INFO - 'TMOUT': '86400', 16:10:58 INFO - 'USER': 'cltbld', 16:10:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192', 16:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:58 INFO - '_': '/tools/buildbot/bin/python'} 16:10:58 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/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:10:58 INFO - mozversion application_buildid: 20160604133054 16:10:58 INFO - mozversion application_changeset: 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 16:10:58 INFO - mozversion application_display_name: Nightly 16:10:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:58 INFO - mozversion application_name: Firefox 16:10:58 INFO - mozversion application_remotingname: firefox 16:10:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:10:58 INFO - mozversion application_vendor: Mozilla 16:10:58 INFO - mozversion application_version: 49.0a1 16:10:58 INFO - mozversion platform_buildid: 20160604133054 16:10:58 INFO - mozversion platform_changeset: 1f056b981b1f7e6e449cf1e67ee55481e569cdc7 16:10:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:10:58 INFO - mozversion platform_version: 49.0a1 16:10:58 INFO - using testdate: 1465081858 16:10:58 INFO - actual date: 1465081858 16:10:58 INFO - starting webserver on 'localhost:52990' 16:10:58 INFO - SUITE-START | Running 2 tests 16:10:58 INFO - TEST-START | dromaeo_css 16:10:58 INFO - operating with platform_type : linux_ 16:10:58 INFO - Initialising browser for dromaeo_css test... 16:10:58 INFO - TEST-INFO | started process 32031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfpyQI/profile http://localhost:52990/getInfo.html) 16:11:02 INFO - PROCESS | 32031 | __metrics Screen width/height:1600/1200 16:11:02 INFO - PROCESS | 32031 | colorDepth:24 16:11:02 INFO - PROCESS | 32031 | Browser inner width/height: 1024/697 16:11:02 INFO - PROCESS | 32031 | __metrics 16:11:04 ERROR - PROCESS | 32031 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:11:04 INFO - TEST-INFO | 32031: exit 0 16:11:04 INFO - Browser initialized. 16:11:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:11:04 INFO - TEST-INFO | started process 32113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJfpyQI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:16 INFO - PROCESS | 32113 | RSS: Main: 156196864 16:11:16 INFO - PROCESS | 32113 | 16:12:08 INFO - PROCESS | 32113 | 1465081928543 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] 16:14:16 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52990/tests/dromaeo/cssquery-ext.html) 16:14:17 INFO - PROCESS | 32113 | RSS: Main: 285061120 16:14:17 INFO - PROCESS | 32113 | 16:17:19 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-ext.html (next: http://localhost:52990/tests/dromaeo/cssquery-jquery.html) 16:17:20 INFO - PROCESS | 32113 | RSS: Main: 241139712 16:17:20 INFO - PROCESS | 32113 | 16:20:22 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52990/tests/dromaeo/cssquery-mootools.html) 16:20:23 INFO - PROCESS | 32113 | RSS: Main: 246534144 16:20:23 INFO - PROCESS | 32113 | 16:23:25 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52990/tests/dromaeo/cssquery-prototype.html) 16:23:25 INFO - PROCESS | 32113 | RSS: Main: 241549312 16:23:25 INFO - PROCESS | 32113 | 16:26:28 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52990/tests/dromaeo/cssquery-yui.html) 16:26:29 INFO - PROCESS | 32113 | RSS: Main: 227414016 16:26:29 INFO - PROCESS | 32113 | 16:29:31 INFO - PROCESS | 32113 | Cycle 1(1): loaded http://localhost:52990/tests/dromaeo/cssquery-yui.html (next: http://localhost:52990/tests/dromaeo/cssquery-dojo.html) 16:29:32 INFO - PROCESS | 32113 | RSS: Main: 260452352 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | __start_tp_report 16:29:32 INFO - PROCESS | 32113 | _x_x_mozilla_page_load 16:29:32 INFO - PROCESS | 32113 | _x_x_mozilla_page_load_details 16:29:32 INFO - PROCESS | 32113 | |i|pagename|runs| 16:29:32 INFO - PROCESS | 32113 | |0;dojo.html;3091.2735507155817;3122.0009596928976;3139.68603139686;3157;3178.809271443712;5293.814716484924;5305.549028332596;5391;5418.512333889949;5441.156620723789;5406.513413792758;5417.322834645669;5456.890862182764;5477.863053423666;5553.055980483317;4857.854264372066;4917.975410122945;4936.30891675164;4941.901161976758;4968.428630707461;5028.7988480460735;5045.596352291808;5050.116229659813;5097.184450487923;5102.464241254671;4844.636652251078;4887.633427492934;4889.486603906575;4899.363082799231;4900.926486102711;4935.728534930578;4942.036302920932;4949.158643030693;4949.381327334083;4954.9009019819405;4922.187839006559;4929.605631549467;4932.457429682732;4938.481459446778;4945.851624451272;5216.139337009389;5258.6318957672975;5278.656887302313;5298.284731561228;5363.6245462817615;5705.486506214461;5743.971280143573;5763.538916886639;5776.306843178845;5847.064469684872;5850.6489610623075;5854.882902341972;5859.794907178229;5860.853478663025;5867.354590994987;5140.177571588565;5346.866328341784;5384.300040994645;5456.83629491112;5459.727013649342;5983.790567330123;5998.940010599926;6002.63984160943;6013.879722405527;6016.278046634432;5733.369329373765;5742.253507044057;5743.684097374685;5747;5756.079027355603;5674.858128546737;5720.68536230503;5745.626534275259;5763.567732420085;5844.795432159939;5750.712464376848;5767.163761254595;5771.30744310677;5806.187133801272;5814.186013958049;5749.453801888814;5754.482096611325;5762.510186634183;5767.913481297784;5769.336526299446;4335.544767799399;4338.219120558267;4373.453318335208;4409.470863496401;4450.532694067141;3881.4565960765517;3897.142628621699;3898.8245528951265;3934.1738234970976;3953.1698343347643;5428.972855135699;5467.45325467458;5471.699056551928;5484.698341591251;5491.560675145979;5645.774169033192;5752.3097228332035;5798.59409841307;5856.121581762684;5857.7656893724625;5486.91769623456;5498.422665620053;5521.199426083195;5521.3926468088475;5555.138953462219;4966.751662416865;5024.371953505812;5028.5977121830165;5029.396472423259;5073.949260507421;5800.825975220666;5921.14143449206;5934.6142500737315;5943.58394912352;6015.39846015395;5800.796972105956;5809.738561764646;5812.564057695774;5813.215215945962;5816.883662326814;5988.850278743066;5996.5502587307;6003.669798161143;6004.42957918997;6004.459598636144;5511.3937466879415;5613.46672066153;5641.492265696107;5652.802151924663;5714.628549144292;5773.3072031356505;5782.797602083907;5784.739686714024;5789.334226563999;5795.681237531808;5508.173773933942;5667.574931880043;5673.631213971079;5682.005649011489;5685.545156387397;5593;5593.993081245415;5648.406917273792;5668.603197776281;5680.602357834912;5546.140348246028;5548.528375088002;5548.611597188158;5574.219609254788;5592.86017849557;5601.915971260353;5659.264295641705;5706.172604972173;5725.914111288251;5785.681787501728;5387.568994480511;5417.4040855506655;5524.281843360337;5558.194061861089;5627.296587926509 16:29:32 INFO - PROCESS | 32113 | |1;ext.html;574.104397140461;611.9602225855319;616.223558316521;632.7722020072773;638.2086213095763;31073.533896991536;31621.68378316216;43217.78391108048;44205.55794442054;44275.77862110693;39735.80132099343;45265.547344526545;45464.09071818562;45532.544674553246;45554.54445455544;8734.606942687562;8907.109289071106;8925.285977121815;8929.553522323858;8932.55337233139;8736.956315218447;8885.777855553599;8886.155815197546;8889.111088891092;8890;8952.507612081365;9021.413608115485;9025.097490250955;9025.95487022564;9028.68399606014;8898.332625053146;8911.821763564725;8970.237529809941;8972.10278972104;8986.910130898672;8721.084286149926;8842.115788421172;8844.955775221082;8847.159519845605;8850.114988501162;40904.38643420351;41344.586554134374;41367.379489307685;41405.792971035255;41419.37870931938;3530.064532898784;3550.573931128281;3608.079939615381;3633.454981752732;4048.9979501263665;32193;32203.19492012695;32550.511742323884;32607;33773.6622633773;4218.451601291843;4315.158544083905;4316.82732690692;4419.911601767979;4441.955580444219;337723.35936484457;338802;338934;341339;343548;53008;53107;53260.73369633127;53264.46735532673;53428.73285633547;34296.48555271673;35208.11979700528;35225.119372015906;37851.43222851659;37875.81062094672;16396.426125085563;16594.66810663804;16594.75107873383;16609.41867034648;16611.50165495037;12940.547080852126;12984.15602985803;13012.154209976321;13015.674608134872;13053.673658158623;19907.502312442015;20036.39890803278;20138.39584812458;20201.797982020285;20207.191712331634;7183.820404489929;7343.77968660941;7494.475386722877;7534.246575342422;7557.206493318123;1010.8736407949007;1040.661784919904;1156.0809156720427;1161.848959635242;1169.0997931592626;31936.520952185736;32321.676783231866;32783.180420489676;32798.50802237968;32893.67106328954;1124.1063354633086;1137.9374134422687;1155.416514660108;1163.33689796815;1186.1163433242118;16948.915255423643;16975.236114374882;17036.91481542609;17200.569985750208;17206.827931720523;610365;614231;618345;624031;625744;57445.425545744845;58984.41015589875;59192.40807591955;59346.703266484255;59405.70297148487;1221.4198255828587;1292.7156025674337;1303.3418123847396;1328.2296268164635;1353.6345186799706;31318.530222047142;32754;32905.341893162484;32923.17692057622;33375.332493350485;50391.49608503868;50487;50934.23598645949;50951.49048509468;51081.23378149405;391203;394086;394224;394230;394332;24793.876030620453;26166.73833261719;27256;27264.182074537795;27290.590641140003;45875.77062114802;45882.77058614686;46043.76978115088;46546.76726616345;47158.76420618012;38937.6106238934;40146.79926600348;40335;40637.59362406456;41415.7929210352;38161.42757858579;41803.79098104611;42590.36114458224;42644.360334594385;43059.138817222854;41729.58270417379;41771.7911410441;42619.57380426156;42913;42942.35586466143;34512.65487345094;36382.8180859094;36908.2000517851;37014.814925925195;37321;25378.87310563509;25550.872245638653;26181.476370472865;28200.29499262535;28233.294167645974 16:29:32 INFO - PROCESS | 32113 | |2;jquery.html;386.09460814390246;390.9061825161962;394.9861754838581;401.5021373496864;409.9549049604543;17788.555286117855;18391.72412413815;19219;19357.032148392576;19423.320183793552;18461;18474;18730.344437944674;19412.805871941277;19431.31990380337;5437.293151890249;5476.479734425223;5646.407127251641;5652.9152062719095;5704.34400043994;5540.141278101881;5544.306961629796;5552.4169962154;5557.3331200256025;5607.943920560803;5275.788968441258;5557.749901254453;5567.053600887839;5586.190002449643;5600.131979543177;5435.864103397407;5526.613137080406;5571.916421253664;5622.100463925773;5875.236219291465;5664.745086471119;5677.063284558043;5696.060150075233;5705.6006079574445;5710.628809127394;13460.394282257323;16661.750073748903;20040.997950102435;23117.537649246922;23147.305580832603;2202.9008694608783;2261.1746712450004;2318.8492747971327;2427.9393015174587;2452.619843924195;10000.799984000352;10004.699859004242;10069.748256293578;10204.336718113373;10413.271071025032;1899.2972600137898;1913.7085957328;1937.6027914277681;1991.980080199194;2081.115525901486;77591;78504;78617.60691196565;83568.58215708882;86867;10205.489725513695;10440.37357758537;11013.614523491638;11150.386728729836;11156.665300041012;15631.452899148475;15721.292541835644;15732.764008539882;15733.292001859943;15757.44848930282;7865.370770338359;8125.471844330218;8241.79395515117;8301.335893128535;8323.66705331792;7840.482613759677;8007.759767206993;8185.058718247358;8214.917850821415;8319.334453243726;4678.532146785362;4681.250999840077;4756.191447453941;4804.25534042224;4839.661223714306;1879.7650293713286;1891.3191251149576;1920.4430715092747;1946.8442524598;1950.7171460138484;933.3653115881131;947.0624082158613;981.6760469045198;992.8808542974889;1020.9795804083876;19157.329493467663;19561.1197496113;19569.412917612495;19681.507962301057;20076.59846803056;959.8944116147218;964.4647220792388;997.4165113408592;1000.6747806962766;1008.9406123570222;10622.150227981743;10925.289856159325;10936.453177341102;10944.288621239593;10988.560457581767;456568;462130;465663;467299;473476;92594;97184;97822;98121;98153.50923245338;972.6304004478253;994.8756405449319;998.4708104704519;1022.2384323678907;1030.4950574218728;17184.70864777929;17266.65466690684;17501.124943752508;17592.912035439742;17720.468385948443;28722.569161462176;36304.45543316905;42319.57680423156;42398.01546301723;42974.355384668626;54337;56458.43541564696;56654;56784.14823777564;57091;8299.709510167115;8480.787980300542;8534.957325213583;8593.570321483776;8800.779980500283;8754.25588824957;11743.647690569296;12537;13320.733585328046;13463.865361346261;11869;12026.579069732517;12095.637130886087;12126.696832578904;12209.023278137905;11672.824907626562;11856.17006809515;12003.699907502383;12264.141510094209;12309.692257693629;12221.083418743452;12322.81515777282;12364.134510584532;12370;12604.180728252633;8672.78318042054;8823.69117080899;8838.292936565187;8937.240334571634;9003.54982250898;11429.714257143305;12156.1490695654;12352.567660131852;12365.876341236473;12370.257784532956 16:29:32 INFO - PROCESS | 32113 | |3;mootools.html;1314.7501974624815;1500.722366362223;1526.9847301526984;1683.6043529770502;1852.4257480181145;8129.309008734257;8489.490630562163;8494.108118647546;8670.566471676422;8693.261072808804;8580.141985801416;8778.604962776675;8780.868286975685;8790.384673072887;8799.780005499866;1949.8245157935783;2016.4656366063004;2020.171729590868;2310.919117830876;2337.6610391493223;2254.695616091831;2329.8835058247105;2332.276994131816;2334.6498025296173;2335.077644330497;2262.5248697773486;2263.196565219348;2280.703508543887;2283.7716228377194;2312.4912519245822;1965.852561057912;2236.575050740354;2254.301166638339;2283.748787633359;2284.668723035159;2322.2336628912417;2351.729551101611;2357.2456813819585;2357.811375089989;2362;8499;8544.957275213646;8554.05905350411;8557.657693692245;8576.571171441403;5040.269160971675;5163.922541161885;5173.430922598511;5173.8189163379475;5180.1452760294505;3034.135271447649;3050.496668049769;3216.8391580420885;3222.081706713599;3232.288896442779;1061.6602687140119;1070.7483741320784;1077.3589714120087;1098.1708809848512;1126.645106791358;12176.939115304367;12183.390830458442;12219.450124744408;12226.14416990811;12228.327441990776;4438.112377524508;4562.726236425825;4573.153966516205;4586.4266966629175;4643.2802915548145;10039.096481316716;10046.397216167054;10049.59801607942;10059.195264378832;10059.446730429896;5149.124648809711;5195.220716892496;5197.0125676121415;5198.766055527511;5202.03762303975;4174.4364510791265;4627.097715945426;4721.858344249678;4726.598239149711;4790.473047964721;3977.801109944491;3995.5205375355144;4062.106336606001;4095.4266402703647;4131.35963925592;1236.8824961628632;1252.0797214047668;1263.2420547671506;1282.2755143343982;1306.6733316670832;1010.8433192855119;1021.371856308365;1040.6201736366172;1047.4239168457318;1049.2497864027257;5985.880282394328;6069.3020302665755;6105.978125156106;6147.692615369214;6163.7842675506145;419.38141241668296;426.0222788699941;429.1781238927419;432.93938848561226;991.7718924647371;4165.625093741578;4246.129543443587;4267.146570685875;4348.195583816941;4356.673249506236;10132.290739648153;10310.484475776182;10329.793404131875;10373.118284945864;10378.740531486623;10195.949020255;10245.436500992517;10581.788364232672;10639.89360106389;10927.398993055458;8062.677492900219;8170.346372290202;8205.95897020523;8207.097219305871;8223.21879421454;6053.515718742578;6276.937230627818;6293.150424692608;6320.146780184617;6349.6507692077375;10061.39631622105;10096.444695541815;10183.898161018295;10200.38797672142;10207.999999999704;9730.318877678777;10044.899551004397;10058.798824023625;10061.39631622105;10071.748206294607;7422.220666829905;7975.441719079608;8052.194780521901;8161.877571836546;8203.917960820316;8453.112423195722;8608.741737747878;8689.17452841979;8699.391042626956;8705.608247629;7467.439942004263;7523.360514356341;7536.773896783106;7793;7848.411369147451;7472.14070381913;7550.848983020419;7595.848083038419;7600.239976002576;7830.060392752906;6956.026156338015;7054.188768291712;7097.219305876452;7099.503034787515;7101.396381307647;4818.060478206716;5043.193089105725;5188.714620695747;5188.988147311238;5271;5362.812301569583;5403.5136837684795;5437.646552974044;5495.807646732345;5514.724263786875 16:29:32 INFO - PROCESS | 32113 | |4;prototype.html;329.69009131416465;330.7899483827769;334.5216340632895;334.75562839127423;337.3893253211687;5239.8428047158595;5320.574354051676;5326.946730532693;5335.759890804913;5351.277577527033;5227.660202086871;5245.560814221386;5275.525202731754;5290.312259406282;5291.841244762653;3988.720789544733;3999.7800120993334;4096.221717873595;4127.8968025799295;4187.267228235062;4108.383742438628;4145.3781932710035;4157.482518880602;4161.791910404483;4164.937525937114;3923.3134201514763;4115.436134268974;4122.216778812016;4125.525564560069;4128.195001974616;4016.4778578784717;4107.240160570304;4151.97924010381;4153.691587150069;4156.314208155651;3674.393725035366;3690.151265209017;3691.907702307437;3691.907702307437;3700.481932529448;5033.798648054073;5053.797848086072;5058.671186372911;5123.38519377677;5148.819791307286;4509.603136941489;4693.671442998992;4697.13103075932;4715.646326525524;4719;5386.218998245233;5388.568914486871;5393.5728921985265;5425.6202065855405;5426.403095659474;4020.2562525932794;4024.8993775155855;4025.939610905839;4029.6977726670616;4043.3732771420478;5647.696097782802;5681.147827825818;5685;5690.406686127891;5692.886142277172;4099.446574712435;4103.507579090528;4108.548059713429;4115.42384066231;4121.608447197512;4210.473690788652;4219.177260434247;4219.649712092162;4219.847877582393;4229.196452673982;4472.849811598791;4631.58315751584;4697;4731.52684731531;4745.952540474551;5473.698946557977;5486.890262194814;5514.503694667499;5523.6409633373705;5544.77820887168;1380.4892189889604;1401.663600735816;1402.0956483068364;1404.4873621128215;1410.969991905894;905.1627244798535;911.7902882337099;929.6978481993244;957.1337939165066;957.2533423929347;5301.814436494704;5328.333958255218;5345.572354211731;5395.379531353866;5397.865053373697;5570.582206334541;5594.664320140804;5639.210510528529;5655.745491452894;5683.374828768832;5017.4731653175895;5241.6068794839775;5296.761645725952;5313.628046036741;5338.8665283367445;2984.6269216347955;3012.4426981008583;3022.5466180073163;3023.410434965205;3029.106413607991;5640.915386269209;5797.36229014808;5804.65172089676;5809.244798176294;5868.207791948118;5745.827625171251;5753.510951569164;5768.0006396674335;5843.970780146157;5867.562447200377;5852.531797456193;5854.419306787144;5854.795082172103;5870.238928321401;5909.527237820878;5590.161475778666;5725.198472213977;5754.482096611325;5798.768049277982;5805.419458054161;5663.603547751783;5701.344345400166;5731.799387021434;5742.339630942495;5745.913811292918;5797.565182611237;5942.227510423617;5956.897973874847;5964.940350596438;5983.820485385445;4073.938890916698;4082.3876418537457;4091;4097.364908439196;4120.320147175682;5808.128780682931;5837.67892765902;5846.590738648254;5854.619449735754;5869.589128760946;5529.502344788988;5569.637973531708;5600.523955463831;5721.22763426932;5731.254936858182;5548.195511650869;5549.417311182267;5569.66582005081;5570.832875013756;5588.888222235451;5203.531682148473;5326.2809520715755;5445.53712934405;5476.616636835383;5496.615236933376;5574.693391863324;5584.357798853021;5587.664740115606;5609.411011843861;5621.831345059655;5431.797072511666;5468.26178465902;5508.834734957958;5530.751116199861;5561.860953476195 16:29:32 INFO - PROCESS | 32113 | |5;yui.html;652.3085529338898;666.796627028756;729.4966473133537;825.607836277768;863.1929146248258;15824.92087539562;16418.589535261624;16445.91777041116;16448.34206631735;16538.09040502775;13985.58043258704;14194.006419550635;14221;14239.644008899782;14260.71478570428;684.1311534351371;792.6591565626778;818.8116733151379;826.8925039744825;829.6639860856363;804.2600807257337;807.2129673568253;810.1007881251805;829.2163905109674;831.5426515416527;847.6905929335779;847.766864112371;848.2577744473585;848.2832006954114;849.2569002123142;699.2064007351667;718.4683334332583;720.88465845465;821.5686764448652;834.0408530190269;624.0763669768768;631.3560168627973;631.6525910749116;631.958922670025;632.0613888375758;15438.305276262596;15443.613909652237;15478.61303467411;15483.458078967182;15546.067235965878;14295.49965751204;14407.495737649237;14469.855301447062;14690.338934747962;14794.704105917928;13134;13201.40593673287;13232.73534529304;13374.33128343579;13628.318584070856;4506.752128632957;4611.976940115312;4643.88390290242;4736.455307639631;4758.428988521365;82828.58585707094;83655.5817220916;84763.57618211869;84826.57586712089;84934.99999999939;11977.880221197851;12013.159078864395;12037.375784841974;12098.402607009457;12344.75310493785;22782.20262290812;22881.542369152525;22912.541749164924;22995.770042299362;23138.074477021066;8004.839903201903;8068.798280043045;8138.593070346459;8443.704470343508;8753.343499237582;4711.717296962193;4780.11567859947;4845.49122342149;4923.223994742182;5090.9236361454605;3358.7648864579246;3495.580530336325;3500.387432199406;3503.2292895562937;3503.964960350415;597.1788790413182;597.2146627185238;600.0309500157215;600.9278886533644;602.9276486821609;578.5776383240258;705.5131958948309;721.1814590439889;726.1902978179291;735.2941176470648;9367.250619950388;9594.568244429018;9644.90355096454;9676.177524910461;9709.36889102206;571.654149239704;642.1876326447049;661.6460193796296;682.443808296237;684.6234570986037;4115.691323150776;4294.098239369768;4305.289627211538;4313.547077556874;4320.481542214954;71782;74271.62864185644;74599;110205;126342;65829;67055.66472167608;81178.59410702909;105925;109064;93508.53245733728;93627;93915.53042234745;95248.52375738077;97933;7887.723929662434;7936.960315198387;8031.437799354223;8084.151164127682;8189.717632127125;54104.72947635237;54108.72945635246;55602.44397556134;55726.16410753761;56963;79951.60024200074;81239.93800309843;81918;82300.17699822925;86254.56872715596;10363.533640986023;10477;10491.527881245209;10609.992050755165;10980.780384392427;11463.140264480031;12025.579104731292;12389;12399.628011159679;12695.55565555201;11460.541578336773;11868.465919033491;12019.158658893793;12104.09219308573;12370.567030153901;11387.601433949772;11466.541338346373;11808.76382472363;11845.940770296438;12023.45894434735;10745.409002504937;10782.08352290064;10820.67537973862;10827.945860270649;11483.885161148282;9851.014898510091;9856.21150307988;10008.299419040888;10219.7445063874;10362.79775572546;9584.281896466506;10154.759169156032;10165.695029149138;10238.12975897057;10426.218033647356 16:29:32 INFO - PROCESS | 32113 | __end_tp_report 16:29:32 INFO - PROCESS | 32113 | __start_cc_report 16:29:32 INFO - PROCESS | 32113 | _x_x_mozilla_cycle_collect,1030 16:29:32 INFO - PROCESS | 32113 | __end_cc_report 16:29:32 INFO - PROCESS | 32113 | __startTimestamp1465082972103__endTimestamp 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | ------- Summary: start ------- 16:29:32 INFO - PROCESS | 32113 | Number of tests: 6 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#0] dojo.html Cycles:165 Average:5372.84 Median:5555.14 stddev:610.71 (11.0%) stddev-sans-first:585.77 16:29:32 INFO - PROCESS | 32113 | Values: 3091.3 3122.0 3139.7 3157.0 3178.8 5293.8 5305.5 5391.0 5418.5 5441.2 5406.5 5417.3 5456.9 5477.9 5553.1 4857.9 4918.0 4936.3 4941.9 4968.4 5028.8 5045.6 5050.1 5097.2 5102.5 4844.6 4887.6 4889.5 4899.4 4900.9 4935.7 4942.0 4949.2 4949.4 4954.9 4922.2 4929.6 4932.5 4938.5 4945.9 5216.1 5258.6 5278.7 5298.3 5363.6 5705.5 5744.0 5763.5 5776.3 5847.1 5850.6 5854.9 5859.8 5860.9 5867.4 5140.2 5346.9 5384.3 5456.8 5459.7 5983.8 5998.9 6002.6 6013.9 6016.3 5733.4 5742.3 5743.7 5747.0 5756.1 5674.9 5720.7 5745.6 5763.6 5844.8 5750.7 5767.2 5771.3 5806.2 5814.2 5749.5 5754.5 5762.5 5767.9 5769.3 4335.5 4338.2 4373.5 4409.5 4450.5 3881.5 3897.1 3898.8 3934.2 3953.2 5429.0 5467.5 5471.7 5484.7 5491.6 5645.8 5752.3 5798.6 5856.1 5857.8 5486.9 5498.4 5521.2 5521.4 5555.1 4966.8 5024.4 5028.6 5029.4 5073.9 5800.8 5921.1 5934.6 5943.6 6015.4 5800.8 5809.7 5812.6 5813.2 5816.9 5988.9 5996.6 6003.7 6004.4 6004.5 5511.4 5613.5 5641.5 5652.8 5714.6 5773.3 5782.8 5784.7 5789.3 5795.7 5508.2 5667.6 5673.6 5682.0 5685.5 5593.0 5594.0 5648.4 5668.6 5680.6 5546.1 5548.5 5548.6 5574.2 5592.9 5601.9 5659.3 5706.2 5725.9 5785.7 5387.6 5417.4 5524.3 5558.2 5627.3 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#1] ext.html Cycles:180 Average:60131.36 Median:22192.00 stddev:124322.18 (560.2%) stddev-sans-first:124590.52 16:29:32 INFO - PROCESS | 32113 | Values: 574.1 612.0 616.2 632.8 638.2 31073.5 31621.7 43217.8 44205.6 44275.8 39735.8 45265.5 45464.1 45532.5 45554.5 8734.6 8907.1 8925.3 8929.6 8932.6 8737.0 8885.8 8886.2 8889.1 8890.0 8952.5 9021.4 9025.1 9026.0 9028.7 8898.3 8911.8 8970.2 8972.1 8986.9 8721.1 8842.1 8845.0 8847.2 8850.1 40904.4 41344.6 41367.4 41405.8 41419.4 3530.1 3550.6 3608.1 3633.5 4049.0 32193.0 32203.2 32550.5 32607.0 33773.7 4218.5 4315.2 4316.8 4419.9 4442.0 337723.4 338802.0 338934.0 341339.0 343548.0 53008.0 53107.0 53260.7 53264.5 53428.7 34296.5 35208.1 35225.1 37851.4 37875.8 16396.4 16594.7 16594.8 16609.4 16611.5 12940.5 12984.2 13012.2 13015.7 13053.7 19907.5 20036.4 20138.4 20201.8 20207.2 7183.8 7343.8 7494.5 7534.2 7557.2 1010.9 1040.7 1156.1 1161.8 1169.1 31936.5 32321.7 32783.2 32798.5 32893.7 1124.1 1137.9 1155.4 1163.3 1186.1 16948.9 16975.2 17036.9 17200.6 17206.8 610365.0 614231.0 618345.0 624031.0 625744.0 57445.4 58984.4 59192.4 59346.7 59405.7 1221.4 1292.7 1303.3 1328.2 1353.6 31318.5 32754.0 32905.3 32923.2 33375.3 50391.5 50487.0 50934.2 50951.5 51081.2 391203.0 394086.0 394224.0 394230.0 394332.0 24793.9 26166.7 27256.0 27264.2 27290.6 45875.8 45882.8 46043.8 46546.8 47158.8 38937.6 40146.8 40335.0 40637.6 41415.8 38161.4 41803.8 42590.4 42644.4 43059.1 41729.6 41771.8 42619.6 42913.0 42942.4 34512.7 36382.8 36908.2 37014.8 37321.0 25378.9 25550.9 26181.5 28200.3 28233.3 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#2] jquery.html Cycles:180 Average:28216.34 Median:18345.28 stddev:76924.06 (419.3%) stddev-sans-first:77111.47 16:29:32 INFO - PROCESS | 32113 | Values: 386.1 390.9 395.0 401.5 410.0 17788.6 18391.7 19219.0 19357.0 19423.3 18461.0 18474.0 18730.3 19412.8 19431.3 5437.3 5476.5 5646.4 5652.9 5704.3 5540.1 5544.3 5552.4 5557.3 5607.9 5275.8 5557.7 5567.1 5586.2 5600.1 5435.9 5526.6 5571.9 5622.1 5875.2 5664.7 5677.1 5696.1 5705.6 5710.6 13460.4 16661.8 20041.0 23117.5 23147.3 2202.9 2261.2 2318.8 2427.9 2452.6 10000.8 10004.7 10069.7 10204.3 10413.3 1899.3 1913.7 1937.6 1992.0 2081.1 77591.0 78504.0 78617.6 83568.6 86867.0 10205.5 10440.4 11013.6 11150.4 11156.7 15631.5 15721.3 15732.8 15733.3 15757.4 7865.4 8125.5 8241.8 8301.3 8323.7 7840.5 8007.8 8185.1 8214.9 8319.3 4678.5 4681.3 4756.2 4804.3 4839.7 1879.8 1891.3 1920.4 1946.8 1950.7 933.4 947.1 981.7 992.9 1021.0 19157.3 19561.1 19569.4 19681.5 20076.6 959.9 964.5 997.4 1000.7 1008.9 10622.2 10925.3 10936.5 10944.3 10988.6 456568.0 462130.0 465663.0 467299.0 473476.0 92594.0 97184.0 97822.0 98121.0 98153.5 972.6 994.9 998.5 1022.2 1030.5 17184.7 17266.7 17501.1 17592.9 17720.5 28722.6 36304.5 42319.6 42398.0 42974.4 54337.0 56458.4 56654.0 56784.1 57091.0 8299.7 8480.8 8535.0 8593.6 8800.8 8754.3 11743.6 12537.0 13320.7 13463.9 11869.0 12026.6 12095.6 12126.7 12209.0 11672.8 11856.2 12003.7 12264.1 12309.7 12221.1 12322.8 12364.1 12370.0 12604.2 8672.8 8823.7 8838.3 8937.2 9003.5 11429.7 12156.1 12352.6 12365.9 12370.3 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#3] mootools.html Cycles:180 Average:5743.11 Median:431.06 stddev:3255.89 (755.3%) stddev-sans-first:3248.02 16:29:32 INFO - PROCESS | 32113 | Values: 1314.8 1500.7 1527.0 1683.6 1852.4 8129.3 8489.5 8494.1 8670.6 8693.3 8580.1 8778.6 8780.9 8790.4 8799.8 1949.8 2016.5 2020.2 2310.9 2337.7 2254.7 2329.9 2332.3 2334.6 2335.1 2262.5 2263.2 2280.7 2283.8 2312.5 1965.9 2236.6 2254.3 2283.7 2284.7 2322.2 2351.7 2357.2 2357.8 2362.0 8499.0 8545.0 8554.1 8557.7 8576.6 5040.3 5163.9 5173.4 5173.8 5180.1 3034.1 3050.5 3216.8 3222.1 3232.3 1061.7 1070.7 1077.4 1098.2 1126.6 12176.9 12183.4 12219.5 12226.1 12228.3 4438.1 4562.7 4573.2 4586.4 4643.3 10039.1 10046.4 10049.6 10059.2 10059.4 5149.1 5195.2 5197.0 5198.8 5202.0 4174.4 4627.1 4721.9 4726.6 4790.5 3977.8 3995.5 4062.1 4095.4 4131.4 1236.9 1252.1 1263.2 1282.3 1306.7 1010.8 1021.4 1040.6 1047.4 1049.2 5985.9 6069.3 6106.0 6147.7 6163.8 419.4 426.0 429.2 432.9 991.8 4165.6 4246.1 4267.1 4348.2 4356.7 10132.3 10310.5 10329.8 10373.1 10378.7 10195.9 10245.4 10581.8 10639.9 10927.4 8062.7 8170.3 8206.0 8207.1 8223.2 6053.5 6276.9 6293.2 6320.1 6349.7 10061.4 10096.4 10183.9 10200.4 10208.0 9730.3 10044.9 10058.8 10061.4 10071.7 7422.2 7975.4 8052.2 8161.9 8203.9 8453.1 8608.7 8689.2 8699.4 8705.6 7467.4 7523.4 7536.8 7793.0 7848.4 7472.1 7550.8 7595.8 7600.2 7830.1 6956.0 7054.2 7097.2 7099.5 7101.4 4818.1 5043.2 5188.7 5189.0 5271.0 5362.8 5403.5 5437.6 5495.8 5514.7 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#4] prototype.html Cycles:180 Average:4677.95 Median:5332.05 stddev:1374.56 (25.8%) stddev-sans-first:1339.11 16:29:32 INFO - PROCESS | 32113 | Values: 329.7 330.8 334.5 334.8 337.4 5239.8 5320.6 5326.9 5335.8 5351.3 5227.7 5245.6 5275.5 5290.3 5291.8 3988.7 3999.8 4096.2 4127.9 4187.3 4108.4 4145.4 4157.5 4161.8 4164.9 3923.3 4115.4 4122.2 4125.5 4128.2 4016.5 4107.2 4152.0 4153.7 4156.3 3674.4 3690.2 3691.9 3691.9 3700.5 5033.8 5053.8 5058.7 5123.4 5148.8 4509.6 4693.7 4697.1 4715.6 4719.0 5386.2 5388.6 5393.6 5425.6 5426.4 4020.3 4024.9 4025.9 4029.7 4043.4 5647.7 5681.1 5685.0 5690.4 5692.9 4099.4 4103.5 4108.5 4115.4 4121.6 4210.5 4219.2 4219.6 4219.8 4229.2 4472.8 4631.6 4697.0 4731.5 4746.0 5473.7 5486.9 5514.5 5523.6 5544.8 1380.5 1401.7 1402.1 1404.5 1411.0 905.2 911.8 929.7 957.1 957.3 5301.8 5328.3 5345.6 5395.4 5397.9 5570.6 5594.7 5639.2 5655.7 5683.4 5017.5 5241.6 5296.8 5313.6 5338.9 2984.6 3012.4 3022.5 3023.4 3029.1 5640.9 5797.4 5804.7 5809.2 5868.2 5745.8 5753.5 5768.0 5844.0 5867.6 5852.5 5854.4 5854.8 5870.2 5909.5 5590.2 5725.2 5754.5 5798.8 5805.4 5663.6 5701.3 5731.8 5742.3 5745.9 5797.6 5942.2 5956.9 5964.9 5983.8 4073.9 4082.4 4091.0 4097.4 4120.3 5808.1 5837.7 5846.6 5854.6 5869.6 5529.5 5569.6 5600.5 5721.2 5731.3 5548.2 5549.4 5569.7 5570.8 5588.9 5203.5 5326.3 5445.5 5476.6 5496.6 5574.7 5584.4 5587.7 5609.4 5621.8 5431.8 5468.3 5508.8 5530.8 5561.9 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - PROCESS | 32113 | [#5] yui.html Cycles:180 Average:20279.64 Median:29597.83 stddev:29255.44 (98.8%) stddev-sans-first:29300.39 16:29:32 INFO - PROCESS | 32113 | Values: 652.3 666.8 729.5 825.6 863.2 15824.9 16418.6 16445.9 16448.3 16538.1 13985.6 14194.0 14221.0 14239.6 14260.7 684.1 792.7 818.8 826.9 829.7 804.3 807.2 810.1 829.2 831.5 847.7 847.8 848.3 848.3 849.3 699.2 718.5 720.9 821.6 834.0 624.1 631.4 631.7 632.0 632.1 15438.3 15443.6 15478.6 15483.5 15546.1 14295.5 14407.5 14469.9 14690.3 14794.7 13134.0 13201.4 13232.7 13374.3 13628.3 4506.8 4612.0 4643.9 4736.5 4758.4 82828.6 83655.6 84763.6 84826.6 84935.0 11977.9 12013.2 12037.4 12098.4 12344.8 22782.2 22881.5 22912.5 22995.8 23138.1 8004.8 8068.8 8138.6 8443.7 8753.3 4711.7 4780.1 4845.5 4923.2 5090.9 3358.8 3495.6 3500.4 3503.2 3504.0 597.2 597.2 600.0 600.9 602.9 578.6 705.5 721.2 726.2 735.3 9367.3 9594.6 9644.9 9676.2 9709.4 571.7 642.2 661.6 682.4 684.6 4115.7 4294.1 4305.3 4313.5 4320.5 71782.0 74271.6 74599.0 110205.0 126342.0 65829.0 67055.7 81178.6 105925.0 109064.0 93508.5 93627.0 93915.5 95248.5 97933.0 7887.7 7937.0 8031.4 8084.2 8189.7 54104.7 54108.7 55602.4 55726.2 56963.0 79951.6 81239.9 81918.0 82300.2 86254.6 10363.5 10477.0 10491.5 10610.0 10980.8 11463.1 12025.6 12389.0 12399.6 12695.6 11460.5 11868.5 12019.2 12104.1 12370.6 11387.6 11466.5 11808.8 11845.9 12023.5 10745.4 10782.1 10820.7 10827.9 11483.9 9851.0 9856.2 10008.3 10219.7 10362.8 9584.3 10154.8 10165.7 10238.1 10426.2 16:29:32 INFO - PROCESS | 32113 | -------- Summary: end -------- 16:29:32 INFO - PROCESS | 32113 | 16:29:32 INFO - TEST-INFO | 32113: exit 0 16:29:32 INFO - TEST-OK | dromaeo_css | took 1113749ms 16:29:32 INFO - TEST-START | kraken 16:29:32 INFO - operating with platform_type : linux_ 16:29:32 INFO - Initialising browser for kraken test... 16:29:32 INFO - TEST-INFO | started process 32299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1fe5Ex/profile http://localhost:52990/getInfo.html) 16:29:36 INFO - PROCESS | 32299 | __metrics Screen width/height:1600/1200 16:29:36 INFO - PROCESS | 32299 | colorDepth:24 16:29:36 INFO - PROCESS | 32299 | Browser inner width/height: 1024/697 16:29:36 INFO - PROCESS | 32299 | __metrics 16:29:37 ERROR - PROCESS | 32299 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:29:38 INFO - TEST-INFO | 32299: exit 0 16:29:38 INFO - Browser initialized. 16:29:38 INFO - Running cycle 1/1 for kraken test... 16:29:38 INFO - TEST-INFO | started process 32381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1fe5Ex/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:50 INFO - PROCESS | 32381 | RSS: Main: 156418048 16:29:50 INFO - PROCESS | 32381 | 16:29:52 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52990/tests/kraken/driver.html?testName=audio-beat-detection) 16:29:53 INFO - PROCESS | 32381 | RSS: Main: 214454272 16:29:53 INFO - PROCESS | 32381 | 16:29:56 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52990/tests/kraken/driver.html?testName=audio-dft) 16:29:57 INFO - PROCESS | 32381 | RSS: Main: 201969664 16:29:57 INFO - PROCESS | 32381 | 16:30:00 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52990/tests/kraken/driver.html?testName=audio-fft) 16:30:00 INFO - PROCESS | 32381 | RSS: Main: 268824576 16:30:00 INFO - PROCESS | 32381 | 16:30:02 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52990/tests/kraken/driver.html?testName=audio-oscillator) 16:30:03 INFO - PROCESS | 32381 | RSS: Main: 179322880 16:30:03 INFO - PROCESS | 32381 | 16:30:05 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:06 INFO - PROCESS | 32381 | RSS: Main: 183394304 16:30:06 INFO - PROCESS | 32381 | 16:30:09 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52990/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:09 INFO - PROCESS | 32381 | RSS: Main: 218005504 16:30:09 INFO - PROCESS | 32381 | 16:30:13 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52990/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:13 INFO - PROCESS | 32381 | RSS: Main: 219955200 16:30:13 INFO - PROCESS | 32381 | 16:30:16 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52990/tests/kraken/driver.html?testName=json-parse-financial) 16:30:17 INFO - PROCESS | 32381 | RSS: Main: 220192768 16:30:17 INFO - PROCESS | 32381 | 16:30:18 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:19 INFO - PROCESS | 32381 | RSS: Main: 206839808 16:30:19 INFO - PROCESS | 32381 | 16:30:21 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:21 INFO - PROCESS | 32381 | RSS: Main: 211812352 16:30:21 INFO - PROCESS | 32381 | 16:30:23 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:24 INFO - PROCESS | 32381 | RSS: Main: 217952256 16:30:24 INFO - PROCESS | 32381 | 16:30:27 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:27 INFO - PROCESS | 32381 | RSS: Main: 223166464 16:30:27 INFO - PROCESS | 32381 | 16:30:30 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:31 INFO - PROCESS | 32381 | RSS: Main: 221220864 16:30:31 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | Cycle 1(1): loaded http://localhost:52990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52990/tests/kraken/driver.html?testName=ai-astar) 16:30:32 INFO - PROCESS | 32381 | RSS: Main: 263364608 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | __start_tp_report 16:30:32 INFO - PROCESS | 32381 | _x_x_mozilla_page_load 16:30:32 INFO - PROCESS | 32381 | _x_x_mozilla_page_load_details 16:30:32 INFO - PROCESS | 32381 | |i|pagename|runs| 16:30:32 INFO - PROCESS | 32381 | |0;ai-astar;110;103;109;110;109;109;109;108;109;110 16:30:32 INFO - PROCESS | 32381 | |1;audio-beat-detection;160;130;127;173;129;126;157;126;210;124 16:30:32 INFO - PROCESS | 32381 | |2;audio-dft;161;161;160;160;160;160;163;160;160;161 16:30:32 INFO - PROCESS | 32381 | |3;audio-fft;74;76;75;129;76;74;75;74;97;74 16:30:32 INFO - PROCESS | 32381 | |4;audio-oscillator;83;84;107;84;85;85;112;84;84;134 16:30:32 INFO - PROCESS | 32381 | |5;imaging-gaussian-blur;118;117;117;117;117;116;116;117;117;117 16:30:32 INFO - PROCESS | 32381 | |6;imaging-darkroom;146;145;145;146;145;147;146;145;145;146 16:30:32 INFO - PROCESS | 32381 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 16:30:32 INFO - PROCESS | 32381 | |8;json-parse-financial;52;52;59;51;52;52;51;53;51;53 16:30:32 INFO - PROCESS | 32381 | |9;json-stringify-tinderbox;61;62;62;61;62;62;63;62;63;62 16:30:32 INFO - PROCESS | 32381 | |10;stanford-crypto-aes;85;82;85;80;85;83;81;87;136;87 16:30:32 INFO - PROCESS | 32381 | |11;stanford-crypto-ccm;122;120;119;119;125;124;128;123;143;122 16:30:32 INFO - PROCESS | 32381 | |12;stanford-crypto-pbkdf2;163;165;159;160;160;159;165;157;161;164 16:30:32 INFO - PROCESS | 32381 | |13;stanford-crypto-sha256-iterative;64;64;62;61;62;64;69;61;62;64 16:30:32 INFO - PROCESS | 32381 | __end_tp_report 16:30:32 INFO - PROCESS | 32381 | __start_cc_report 16:30:32 INFO - PROCESS | 32381 | _x_x_mozilla_cycle_collect,1628 16:30:32 INFO - PROCESS | 32381 | __end_cc_report 16:30:32 INFO - PROCESS | 32381 | __startTimestamp1465083032933__endTimestamp 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | ------- Summary: start ------- 16:30:32 INFO - PROCESS | 32381 | Number of tests: 14 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#0] ai-astar Cycles:10 Average:108.60 Median:109.00 stddev:2.07 (1.9%) stddev-sans-first:2.13 16:30:32 INFO - PROCESS | 32381 | Values: 110.0 103.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 110.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:143.50 stddev:28.54 (19.9%) stddev-sans-first:29.83 16:30:32 INFO - PROCESS | 32381 | Values: 160.0 130.0 127.0 173.0 129.0 126.0 157.0 126.0 210.0 124.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 16:30:32 INFO - PROCESS | 32381 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 163.0 160.0 160.0 161.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:17.82 (23.8%) stddev-sans-first:18.64 16:30:32 INFO - PROCESS | 32381 | Values: 74.0 76.0 75.0 129.0 76.0 74.0 75.0 74.0 97.0 74.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:17.56 (20.9%) stddev-sans-first:18.15 16:30:32 INFO - PROCESS | 32381 | Values: 83.0 84.0 107.0 84.0 85.0 85.0 112.0 84.0 84.0 134.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 16:30:32 INFO - PROCESS | 32381 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:30:32 INFO - PROCESS | 32381 | Values: 146.0 145.0 145.0 146.0 145.0 147.0 146.0 145.0 145.0 146.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:30:32 INFO - PROCESS | 32381 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:2.37 (4.6%) stddev-sans-first:2.50 16:30:32 INFO - PROCESS | 32381 | Values: 52.0 52.0 59.0 51.0 52.0 52.0 51.0 53.0 51.0 53.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 16:30:32 INFO - PROCESS | 32381 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 63.0 62.0 63.0 62.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:85.00 stddev:16.65 (19.6%) stddev-sans-first:17.59 16:30:32 INFO - PROCESS | 32381 | Values: 85.0 82.0 85.0 80.0 85.0 83.0 81.0 87.0 136.0 87.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:123.50 stddev:7.07 (5.7%) stddev-sans-first:7.45 16:30:32 INFO - PROCESS | 32381 | Values: 122.0 120.0 119.0 119.0 125.0 124.0 128.0 123.0 143.0 122.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:2.79 (1.7%) stddev-sans-first:2.89 16:30:32 INFO - PROCESS | 32381 | Values: 163.0 165.0 159.0 160.0 160.0 159.0 165.0 157.0 161.0 164.0 16:30:32 INFO - PROCESS | 32381 | 16:30:32 INFO - PROCESS | 32381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:2.36 (3.7%) stddev-sans-first:2.49 16:30:32 INFO - PROCESS | 32381 | Values: 64.0 64.0 62.0 61.0 62.0 64.0 69.0 61.0 62.0 64.0 16:30:32 INFO - PROCESS | 32381 | -------- Summary: end -------- 16:30:32 INFO - PROCESS | 32381 | 16:30:33 INFO - TEST-INFO | 32381: exit 0 16:30:33 INFO - TEST-OK | kraken | took 61165ms 16:30:33 INFO - SUITE-END | took 1174s 16:30:34 INFO - Completed test suite (00:19:35) 16:30:34 INFO - javascript benchmark 16:30:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.2735507155817, 3122.0009596928976, 3139.68603139686, 3157.0, 3178.809271443712, 5293.814716484924, 5305.549028332596, 5391.0, 5418.512333889949, 5441.156620723789, 5406.513413792758, 5417.322834645669, 5456.890862182764, 5477.863053423666, 5553.055980483317, 4857.854264372066, 4917.975410122945, 4936.30891675164, 4941.901161976758, 4968.428630707461, 5028.7988480460735, 5045.596352291808, 5050.116229659813, 5097.184450487923, 5102.464241254671, 4844.636652251078, 4887.633427492934, 4889.486603906575, 4899.363082799231, 4900.926486102711, 4935.728534930578, 4942.036302920932, 4949.158643030693, 4949.381327334083, 4954.9009019819405, 4922.187839006559, 4929.605631549467, 4932.457429682732, 4938.481459446778, 4945.851624451272, 5216.139337009389, 5258.6318957672975, 5278.656887302313, 5298.284731561228, 5363.6245462817615, 5705.486506214461, 5743.971280143573, 5763.538916886639, 5776.306843178845, 5847.064469684872, 5850.6489610623075, 5854.882902341972, 5859.794907178229, 5860.853478663025, 5867.354590994987, 5140.177571588565, 5346.866328341784, 5384.300040994645, 5456.83629491112, 5459.727013649342, 5983.790567330123, 5998.940010599926, 6002.63984160943, 6013.879722405527, 6016.278046634432, 5733.369329373765, 5742.253507044057, 5743.684097374685, 5747.0, 5756.079027355603, 5674.858128546737, 5720.68536230503, 5745.626534275259, 5763.567732420085, 5844.795432159939, 5750.712464376848, 5767.163761254595, 5771.30744310677, 5806.187133801272, 5814.186013958049, 5749.453801888814, 5754.482096611325, 5762.510186634183, 5767.913481297784, 5769.336526299446, 4335.544767799399, 4338.219120558267, 4373.453318335208, 4409.470863496401, 4450.532694067141, 3881.4565960765517, 3897.142628621699, 3898.8245528951265, 3934.1738234970976, 3953.1698343347643, 5428.972855135699, 5467.45325467458, 5471.699056551928, 5484.698341591251, 5491.560675145979, 5645.774169033192, 5752.3097228332035, 5798.59409841307, 5856.121581762684, 5857.7656893724625, 5486.91769623456, 5498.422665620053, 5521.199426083195, 5521.3926468088475, 5555.138953462219, 4966.751662416865, 5024.371953505812, 5028.5977121830165, 5029.396472423259, 5073.949260507421, 5800.825975220666, 5921.14143449206, 5934.6142500737315, 5943.58394912352, 6015.39846015395, 5800.796972105956, 5809.738561764646, 5812.564057695774, 5813.215215945962, 5816.883662326814, 5988.850278743066, 5996.5502587307, 6003.669798161143, 6004.42957918997, 6004.459598636144, 5511.3937466879415, 5613.46672066153, 5641.492265696107, 5652.802151924663, 5714.628549144292, 5773.3072031356505, 5782.797602083907, 5784.739686714024, 5789.334226563999, 5795.681237531808, 5508.173773933942, 5667.574931880043, 5673.631213971079, 5682.005649011489, 5685.545156387397, 5593.0, 5593.993081245415, 5648.406917273792, 5668.603197776281, 5680.602357834912, 5546.140348246028, 5548.528375088002, 5548.611597188158, 5574.219609254788, 5592.86017849557, 5601.915971260353, 5659.264295641705, 5706.172604972173, 5725.914111288251, 5785.681787501728, 5387.568994480511, 5417.4040855506655, 5524.281843360337, 5558.194061861089, 5627.296587926509], "value": 5331.477260413097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.104397140461, 611.9602225855319, 616.223558316521, 632.7722020072773, 638.2086213095763, 31073.533896991536, 31621.68378316216, 43217.78391108048, 44205.55794442054, 44275.77862110693, 39735.80132099343, 45265.547344526545, 45464.09071818562, 45532.544674553246, 45554.54445455544, 8734.606942687562, 8907.109289071106, 8925.285977121815, 8929.553522323858, 8932.55337233139, 8736.956315218447, 8885.777855553599, 8886.155815197546, 8889.111088891092, 8890.0, 8952.507612081365, 9021.413608115485, 9025.097490250955, 9025.95487022564, 9028.68399606014, 8898.332625053146, 8911.821763564725, 8970.237529809941, 8972.10278972104, 8986.910130898672, 8721.084286149926, 8842.115788421172, 8844.955775221082, 8847.159519845605, 8850.114988501162, 40904.38643420351, 41344.586554134374, 41367.379489307685, 41405.792971035255, 41419.37870931938, 3530.064532898784, 3550.573931128281, 3608.079939615381, 3633.454981752732, 4048.9979501263665, 32193.0, 32203.19492012695, 32550.511742323884, 32607.0, 33773.6622633773, 4218.451601291843, 4315.158544083905, 4316.82732690692, 4419.911601767979, 4441.955580444219, 337723.35936484457, 338802.0, 338934.0, 341339.0, 343548.0, 53008.0, 53107.0, 53260.73369633127, 53264.46735532673, 53428.73285633547, 34296.48555271673, 35208.11979700528, 35225.119372015906, 37851.43222851659, 37875.81062094672, 16396.426125085563, 16594.66810663804, 16594.75107873383, 16609.41867034648, 16611.50165495037, 12940.547080852126, 12984.15602985803, 13012.154209976321, 13015.674608134872, 13053.673658158623, 19907.502312442015, 20036.39890803278, 20138.39584812458, 20201.797982020285, 20207.191712331634, 7183.820404489929, 7343.77968660941, 7494.475386722877, 7534.246575342422, 7557.206493318123, 1010.8736407949007, 1040.661784919904, 1156.0809156720427, 1161.848959635242, 1169.0997931592626, 31936.520952185736, 32321.676783231866, 32783.180420489676, 32798.50802237968, 32893.67106328954, 1124.1063354633086, 1137.9374134422687, 1155.416514660108, 1163.33689796815, 1186.1163433242118, 16948.915255423643, 16975.236114374882, 17036.91481542609, 17200.569985750208, 17206.827931720523, 610365.0, 614231.0, 618345.0, 624031.0, 625744.0, 57445.425545744845, 58984.41015589875, 59192.40807591955, 59346.703266484255, 59405.70297148487, 1221.4198255828587, 1292.7156025674337, 1303.3418123847396, 1328.2296268164635, 1353.6345186799706, 31318.530222047142, 32754.0, 32905.341893162484, 32923.17692057622, 33375.332493350485, 50391.49608503868, 50487.0, 50934.23598645949, 50951.49048509468, 51081.23378149405, 391203.0, 394086.0, 394224.0, 394230.0, 394332.0, 24793.876030620453, 26166.73833261719, 27256.0, 27264.182074537795, 27290.590641140003, 45875.77062114802, 45882.77058614686, 46043.76978115088, 46546.76726616345, 47158.76420618012, 38937.6106238934, 40146.79926600348, 40335.0, 40637.59362406456, 41415.7929210352, 38161.42757858579, 41803.79098104611, 42590.36114458224, 42644.360334594385, 43059.138817222854, 41729.58270417379, 41771.7911410441, 42619.57380426156, 42913.0, 42942.35586466143, 34512.65487345094, 36382.8180859094, 36908.2000517851, 37014.814925925195, 37321.0, 25378.87310563509, 25550.872245638653, 26181.476370472865, 28200.29499262535, 28233.294167645974], "value": 19825.92360899627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.09460814390246, 390.9061825161962, 394.9861754838581, 401.5021373496864, 409.9549049604543, 17788.555286117855, 18391.72412413815, 19219.0, 19357.032148392576, 19423.320183793552, 18461.0, 18474.0, 18730.344437944674, 19412.805871941277, 19431.31990380337, 5437.293151890249, 5476.479734425223, 5646.407127251641, 5652.9152062719095, 5704.34400043994, 5540.141278101881, 5544.306961629796, 5552.4169962154, 5557.3331200256025, 5607.943920560803, 5275.788968441258, 5557.749901254453, 5567.053600887839, 5586.190002449643, 5600.131979543177, 5435.864103397407, 5526.613137080406, 5571.916421253664, 5622.100463925773, 5875.236219291465, 5664.745086471119, 5677.063284558043, 5696.060150075233, 5705.6006079574445, 5710.628809127394, 13460.394282257323, 16661.750073748903, 20040.997950102435, 23117.537649246922, 23147.305580832603, 2202.9008694608783, 2261.1746712450004, 2318.8492747971327, 2427.9393015174587, 2452.619843924195, 10000.799984000352, 10004.699859004242, 10069.748256293578, 10204.336718113373, 10413.271071025032, 1899.2972600137898, 1913.7085957328, 1937.6027914277681, 1991.980080199194, 2081.115525901486, 77591.0, 78504.0, 78617.60691196565, 83568.58215708882, 86867.0, 10205.489725513695, 10440.37357758537, 11013.614523491638, 11150.386728729836, 11156.665300041012, 15631.452899148475, 15721.292541835644, 15732.764008539882, 15733.292001859943, 15757.44848930282, 7865.370770338359, 8125.471844330218, 8241.79395515117, 8301.335893128535, 8323.66705331792, 7840.482613759677, 8007.759767206993, 8185.058718247358, 8214.917850821415, 8319.334453243726, 4678.532146785362, 4681.250999840077, 4756.191447453941, 4804.25534042224, 4839.661223714306, 1879.7650293713286, 1891.3191251149576, 1920.4430715092747, 1946.8442524598, 1950.7171460138484, 933.3653115881131, 947.0624082158613, 981.6760469045198, 992.8808542974889, 1020.9795804083876, 19157.329493467663, 19561.1197496113, 19569.412917612495, 19681.507962301057, 20076.59846803056, 959.8944116147218, 964.4647220792388, 997.4165113408592, 1000.6747806962766, 1008.9406123570222, 10622.150227981743, 10925.289856159325, 10936.453177341102, 10944.288621239593, 10988.560457581767, 456568.0, 462130.0, 465663.0, 467299.0, 473476.0, 92594.0, 97184.0, 97822.0, 98121.0, 98153.50923245338, 972.6304004478253, 994.8756405449319, 998.4708104704519, 1022.2384323678907, 1030.4950574218728, 17184.70864777929, 17266.65466690684, 17501.124943752508, 17592.912035439742, 17720.468385948443, 28722.569161462176, 36304.45543316905, 42319.57680423156, 42398.01546301723, 42974.355384668626, 54337.0, 56458.43541564696, 56654.0, 56784.14823777564, 57091.0, 8299.709510167115, 8480.787980300542, 8534.957325213583, 8593.570321483776, 8800.779980500283, 8754.25588824957, 11743.647690569296, 12537.0, 13320.733585328046, 13463.865361346261, 11869.0, 12026.579069732517, 12095.637130886087, 12126.696832578904, 12209.023278137905, 11672.824907626562, 11856.17006809515, 12003.699907502383, 12264.141510094209, 12309.692257693629, 12221.083418743452, 12322.81515777282, 12364.134510584532, 12370.0, 12604.180728252633, 8672.78318042054, 8823.69117080899, 8838.292936565187, 8937.240334571634, 9003.54982250898, 11429.714257143305, 12156.1490695654, 12352.567660131852, 12365.876341236473, 12370.257784532956], "value": 9144.476890085036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.7501974624815, 1500.722366362223, 1526.9847301526984, 1683.6043529770502, 1852.4257480181145, 8129.309008734257, 8489.490630562163, 8494.108118647546, 8670.566471676422, 8693.261072808804, 8580.141985801416, 8778.604962776675, 8780.868286975685, 8790.384673072887, 8799.780005499866, 1949.8245157935783, 2016.4656366063004, 2020.171729590868, 2310.919117830876, 2337.6610391493223, 2254.695616091831, 2329.8835058247105, 2332.276994131816, 2334.6498025296173, 2335.077644330497, 2262.5248697773486, 2263.196565219348, 2280.703508543887, 2283.7716228377194, 2312.4912519245822, 1965.852561057912, 2236.575050740354, 2254.301166638339, 2283.748787633359, 2284.668723035159, 2322.2336628912417, 2351.729551101611, 2357.2456813819585, 2357.811375089989, 2362.0, 8499.0, 8544.957275213646, 8554.05905350411, 8557.657693692245, 8576.571171441403, 5040.269160971675, 5163.922541161885, 5173.430922598511, 5173.8189163379475, 5180.1452760294505, 3034.135271447649, 3050.496668049769, 3216.8391580420885, 3222.081706713599, 3232.288896442779, 1061.6602687140119, 1070.7483741320784, 1077.3589714120087, 1098.1708809848512, 1126.645106791358, 12176.939115304367, 12183.390830458442, 12219.450124744408, 12226.14416990811, 12228.327441990776, 4438.112377524508, 4562.726236425825, 4573.153966516205, 4586.4266966629175, 4643.2802915548145, 10039.096481316716, 10046.397216167054, 10049.59801607942, 10059.195264378832, 10059.446730429896, 5149.124648809711, 5195.220716892496, 5197.0125676121415, 5198.766055527511, 5202.03762303975, 4174.4364510791265, 4627.097715945426, 4721.858344249678, 4726.598239149711, 4790.473047964721, 3977.801109944491, 3995.5205375355144, 4062.106336606001, 4095.4266402703647, 4131.35963925592, 1236.8824961628632, 1252.0797214047668, 1263.2420547671506, 1282.2755143343982, 1306.6733316670832, 1010.8433192855119, 1021.371856308365, 1040.6201736366172, 1047.4239168457318, 1049.2497864027257, 5985.880282394328, 6069.3020302665755, 6105.978125156106, 6147.692615369214, 6163.7842675506145, 419.38141241668296, 426.0222788699941, 429.1781238927419, 432.93938848561226, 991.7718924647371, 4165.625093741578, 4246.129543443587, 4267.146570685875, 4348.195583816941, 4356.673249506236, 10132.290739648153, 10310.484475776182, 10329.793404131875, 10373.118284945864, 10378.740531486623, 10195.949020255, 10245.436500992517, 10581.788364232672, 10639.89360106389, 10927.398993055458, 8062.677492900219, 8170.346372290202, 8205.95897020523, 8207.097219305871, 8223.21879421454, 6053.515718742578, 6276.937230627818, 6293.150424692608, 6320.146780184617, 6349.6507692077375, 10061.39631622105, 10096.444695541815, 10183.898161018295, 10200.38797672142, 10207.999999999704, 9730.318877678777, 10044.899551004397, 10058.798824023625, 10061.39631622105, 10071.748206294607, 7422.220666829905, 7975.441719079608, 8052.194780521901, 8161.877571836546, 8203.917960820316, 8453.112423195722, 8608.741737747878, 8689.17452841979, 8699.391042626956, 8705.608247629, 7467.439942004263, 7523.360514356341, 7536.773896783106, 7793.0, 7848.411369147451, 7472.14070381913, 7550.848983020419, 7595.848083038419, 7600.239976002576, 7830.060392752906, 6956.026156338015, 7054.188768291712, 7097.219305876452, 7099.503034787515, 7101.396381307647, 4818.060478206716, 5043.193089105725, 5188.714620695747, 5188.988147311238, 5271.0, 5362.812301569583, 5403.5136837684795, 5437.646552974044, 5495.807646732345, 5514.724263786875], "value": 4540.917868674903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.69009131416465, 330.7899483827769, 334.5216340632895, 334.75562839127423, 337.3893253211687, 5239.8428047158595, 5320.574354051676, 5326.946730532693, 5335.759890804913, 5351.277577527033, 5227.660202086871, 5245.560814221386, 5275.525202731754, 5290.312259406282, 5291.841244762653, 3988.720789544733, 3999.7800120993334, 4096.221717873595, 4127.8968025799295, 4187.267228235062, 4108.383742438628, 4145.3781932710035, 4157.482518880602, 4161.791910404483, 4164.937525937114, 3923.3134201514763, 4115.436134268974, 4122.216778812016, 4125.525564560069, 4128.195001974616, 4016.4778578784717, 4107.240160570304, 4151.97924010381, 4153.691587150069, 4156.314208155651, 3674.393725035366, 3690.151265209017, 3691.907702307437, 3691.907702307437, 3700.481932529448, 5033.798648054073, 5053.797848086072, 5058.671186372911, 5123.38519377677, 5148.819791307286, 4509.603136941489, 4693.671442998992, 4697.13103075932, 4715.646326525524, 4719.0, 5386.218998245233, 5388.568914486871, 5393.5728921985265, 5425.6202065855405, 5426.403095659474, 4020.2562525932794, 4024.8993775155855, 4025.939610905839, 4029.6977726670616, 4043.3732771420478, 5647.696097782802, 5681.147827825818, 5685.0, 5690.406686127891, 5692.886142277172, 4099.446574712435, 4103.507579090528, 4108.548059713429, 4115.42384066231, 4121.608447197512, 4210.473690788652, 4219.177260434247, 4219.649712092162, 4219.847877582393, 4229.196452673982, 4472.849811598791, 4631.58315751584, 4697.0, 4731.52684731531, 4745.952540474551, 5473.698946557977, 5486.890262194814, 5514.503694667499, 5523.6409633373705, 5544.77820887168, 1380.4892189889604, 1401.663600735816, 1402.0956483068364, 1404.4873621128215, 1410.969991905894, 905.1627244798535, 911.7902882337099, 929.6978481993244, 957.1337939165066, 957.2533423929347, 5301.814436494704, 5328.333958255218, 5345.572354211731, 5395.379531353866, 5397.865053373697, 5570.582206334541, 5594.664320140804, 5639.210510528529, 5655.745491452894, 5683.374828768832, 5017.4731653175895, 5241.6068794839775, 5296.761645725952, 5313.628046036741, 5338.8665283367445, 2984.6269216347955, 3012.4426981008583, 3022.5466180073163, 3023.410434965205, 3029.106413607991, 5640.915386269209, 5797.36229014808, 5804.65172089676, 5809.244798176294, 5868.207791948118, 5745.827625171251, 5753.510951569164, 5768.0006396674335, 5843.970780146157, 5867.562447200377, 5852.531797456193, 5854.419306787144, 5854.795082172103, 5870.238928321401, 5909.527237820878, 5590.161475778666, 5725.198472213977, 5754.482096611325, 5798.768049277982, 5805.419458054161, 5663.603547751783, 5701.344345400166, 5731.799387021434, 5742.339630942495, 5745.913811292918, 5797.565182611237, 5942.227510423617, 5956.897973874847, 5964.940350596438, 5983.820485385445, 4073.938890916698, 4082.3876418537457, 4091.0, 4097.364908439196, 4120.320147175682, 5808.128780682931, 5837.67892765902, 5846.590738648254, 5854.619449735754, 5869.589128760946, 5529.502344788988, 5569.637973531708, 5600.523955463831, 5721.22763426932, 5731.254936858182, 5548.195511650869, 5549.417311182267, 5569.66582005081, 5570.832875013756, 5588.888222235451, 5203.531682148473, 5326.2809520715755, 5445.53712934405, 5476.616636835383, 5496.615236933376, 5574.693391863324, 5584.357798853021, 5587.664740115606, 5609.411011843861, 5621.831345059655, 5431.797072511666, 5468.26178465902, 5508.834734957958, 5530.751116199861, 5561.860953476195], "value": 4238.145463177354, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.3085529338898, 666.796627028756, 729.4966473133537, 825.607836277768, 863.1929146248258, 15824.92087539562, 16418.589535261624, 16445.91777041116, 16448.34206631735, 16538.09040502775, 13985.58043258704, 14194.006419550635, 14221.0, 14239.644008899782, 14260.71478570428, 684.1311534351371, 792.6591565626778, 818.8116733151379, 826.8925039744825, 829.6639860856363, 804.2600807257337, 807.2129673568253, 810.1007881251805, 829.2163905109674, 831.5426515416527, 847.6905929335779, 847.766864112371, 848.2577744473585, 848.2832006954114, 849.2569002123142, 699.2064007351667, 718.4683334332583, 720.88465845465, 821.5686764448652, 834.0408530190269, 624.0763669768768, 631.3560168627973, 631.6525910749116, 631.958922670025, 632.0613888375758, 15438.305276262596, 15443.613909652237, 15478.61303467411, 15483.458078967182, 15546.067235965878, 14295.49965751204, 14407.495737649237, 14469.855301447062, 14690.338934747962, 14794.704105917928, 13134.0, 13201.40593673287, 13232.73534529304, 13374.33128343579, 13628.318584070856, 4506.752128632957, 4611.976940115312, 4643.88390290242, 4736.455307639631, 4758.428988521365, 82828.58585707094, 83655.5817220916, 84763.57618211869, 84826.57586712089, 84934.99999999939, 11977.880221197851, 12013.159078864395, 12037.375784841974, 12098.402607009457, 12344.75310493785, 22782.20262290812, 22881.542369152525, 22912.541749164924, 22995.770042299362, 23138.074477021066, 8004.839903201903, 8068.798280043045, 8138.593070346459, 8443.704470343508, 8753.343499237582, 4711.717296962193, 4780.11567859947, 4845.49122342149, 4923.223994742182, 5090.9236361454605, 3358.7648864579246, 3495.580530336325, 3500.387432199406, 3503.2292895562937, 3503.964960350415, 597.1788790413182, 597.2146627185238, 600.0309500157215, 600.9278886533644, 602.9276486821609, 578.5776383240258, 705.5131958948309, 721.1814590439889, 726.1902978179291, 735.2941176470648, 9367.250619950388, 9594.568244429018, 9644.90355096454, 9676.177524910461, 9709.36889102206, 571.654149239704, 642.1876326447049, 661.6460193796296, 682.443808296237, 684.6234570986037, 4115.691323150776, 4294.098239369768, 4305.289627211538, 4313.547077556874, 4320.481542214954, 71782.0, 74271.62864185644, 74599.0, 110205.0, 126342.0, 65829.0, 67055.66472167608, 81178.59410702909, 105925.0, 109064.0, 93508.53245733728, 93627.0, 93915.53042234745, 95248.52375738077, 97933.0, 7887.723929662434, 7936.960315198387, 8031.437799354223, 8084.151164127682, 8189.717632127125, 54104.72947635237, 54108.72945635246, 55602.44397556134, 55726.16410753761, 56963.0, 79951.60024200074, 81239.93800309843, 81918.0, 82300.17699822925, 86254.56872715596, 10363.533640986023, 10477.0, 10491.527881245209, 10609.992050755165, 10980.780384392427, 11463.140264480031, 12025.579104731292, 12389.0, 12399.628011159679, 12695.55565555201, 11460.541578336773, 11868.465919033491, 12019.158658893793, 12104.09219308573, 12370.567030153901, 11387.601433949772, 11466.541338346373, 11808.76382472363, 11845.940770296438, 12023.45894434735, 10745.409002504937, 10782.08352290064, 10820.67537973862, 10827.945860270649, 11483.885161148282, 9851.014898510091, 9856.21150307988, 10008.299419040888, 10219.7445063874, 10362.79775572546, 9584.281896466506, 10154.759169156032, 10165.695029149138, 10238.12975897057, 10426.218033647356], "value": 7309.886805675696, "unit": "score"}], "name": "dromaeo_css", "value": 7171.100936458339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 103.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 110.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 127.0, 173.0, 129.0, 126.0, 157.0, 126.0, 210.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 163.0, 160.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 129.0, 76.0, 74.0, 75.0, 74.0, 97.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 107.0, 84.0, 85.0, 85.0, 112.0, 84.0, 84.0, 134.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 59.0, 51.0, 52.0, 52.0, 51.0, 53.0, 51.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 80.0, 85.0, 83.0, 81.0, 87.0, 136.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 119.0, 119.0, 125.0, 124.0, 128.0, 123.0, 143.0, 122.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 159.0, 160.0, 160.0, 159.0, 165.0, 157.0, 161.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 61.0, 62.0, 64.0, 69.0, 61.0, 62.0, 64.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1502.1999999999998, "alertThreshold": 2.0}]} 16:30:34 INFO - Return code: 0 16:30:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:30:34 ERROR - # TBPL SUCCESS # 16:30:34 INFO - Running post-action listener: _resource_record_post_action 16:30:34 INFO - ##### 16:30:34 INFO - ##### Finished run-tests step (success) 16:30:34 INFO - ##### 16:30:34 INFO - Running post-run listener: _resource_record_post_run 16:30:34 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 542294016; Read time: 0; Write time: 551956 16:30:34 INFO - TinderboxPrint: CPU usage
13.1% 16:30:34 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:30:34 INFO - TinderboxPrint: I/O write bytes / time
542,294,016 / 551,956 16:30:34 INFO - TinderboxPrint: CPU idle
8,269.6 (86.8%) 16:30:34 INFO - TinderboxPrint: CPU user
1,207.3 (12.7%) 16:30:34 INFO - TinderboxPrint: Swap in / out
0 / 0 16:30:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247971840; Read time: 0; Write time: 298912 16:30:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 287686656; Read time: 0; Write time: 250564 16:30:34 INFO - Running post-run listener: _upload_blobber_files 16:30:34 INFO - Blob upload gear active. 16:30:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:34 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 16:30:34 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'] 16:30:34 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 16:30:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:36 INFO - (blobuploader) - INFO - Done attempting. 16:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:36 INFO - (blobuploader) - INFO - Done attempting. 16:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:41 INFO - (blobuploader) - INFO - Done attempting. 16:30:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:30:41 INFO - Return code: 0 16:30:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:30:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:30:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8584f5506f716eb03a58bc8f1d4a9484aa4b0c101072a9e2b65fb33e62066e628526faa09d4eb172a9d5b374601385b74477f8b7e24bfe055ddff3ee4a69980a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/906ea19cd1e68b80c495ed28510867647518e340a97c13f5669fbca2fd3506c3532e97a9313f5ae854a67113846b381da0a45d5c54f1f78454db4a2c1d7b9d1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43fc2b289973e80e02e910df2da390b9cbc1ea7d292b83de87bbbfaee677b17e7dfe6c846396d228ce441ff2d1f8554f15febd8c050a96e525ec86e2a83af59"} 16:30:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:30:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:30:41 INFO - Contents: 16:30:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8584f5506f716eb03a58bc8f1d4a9484aa4b0c101072a9e2b65fb33e62066e628526faa09d4eb172a9d5b374601385b74477f8b7e24bfe055ddff3ee4a69980a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/906ea19cd1e68b80c495ed28510867647518e340a97c13f5669fbca2fd3506c3532e97a9313f5ae854a67113846b381da0a45d5c54f1f78454db4a2c1d7b9d1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43fc2b289973e80e02e910df2da390b9cbc1ea7d292b83de87bbbfaee677b17e7dfe6c846396d228ce441ff2d1f8554f15febd8c050a96e525ec86e2a83af59"} 16:30:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:30:41 INFO - Copying logs to upload dir... 16:30:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:30:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.537213 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-04 16:30:40.943089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 16:30:40.946930) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 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/8584f5506f716eb03a58bc8f1d4a9484aa4b0c101072a9e2b65fb33e62066e628526faa09d4eb172a9d5b374601385b74477f8b7e24bfe055ddff3ee4a69980a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/906ea19cd1e68b80c495ed28510867647518e340a97c13f5669fbca2fd3506c3532e97a9313f5ae854a67113846b381da0a45d5c54f1f78454db4a2c1d7b9d1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43fc2b289973e80e02e910df2da390b9cbc1ea7d292b83de87bbbfaee677b17e7dfe6c846396d228ce441ff2d1f8554f15febd8c050a96e525ec86e2a83af59"} build_url:https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/F83TpGPVQNai0xUTmjr_VQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8584f5506f716eb03a58bc8f1d4a9484aa4b0c101072a9e2b65fb33e62066e628526faa09d4eb172a9d5b374601385b74477f8b7e24bfe055ddff3ee4a69980a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/906ea19cd1e68b80c495ed28510867647518e340a97c13f5669fbca2fd3506c3532e97a9313f5ae854a67113846b381da0a45d5c54f1f78454db4a2c1d7b9d1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e43fc2b289973e80e02e910df2da390b9cbc1ea7d292b83de87bbbfaee677b17e7dfe6c846396d228ce441ff2d1f8554f15febd8c050a96e525ec86e2a83af59"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 16:30:40.973146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:30:40.973509) ========= 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=4ac8d263c7293b36a1be1aed000001be-1465081790.25371-158756192 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 16:30:41.060494) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 16:30:41.060861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 16:30:41.061193) ========= ========= Total master_lag: 0.41 =========