builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1471046829.78 results: success (0) buildid: 20160812143816 builduid: b9c41b9e406445899e4fd8d1e1611a07 revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.782172) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.782684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.782955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.807297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.807669) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-12 17:07:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to 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% 18.2M=0.001s 2016-08-12 17:07:09 (18.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.961950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:09.962295) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.037337 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:10.020367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:07:10.020727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2ed7e61b988d2466a61528f66050596ef272ebda --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2ed7e61b988d2466a61528f66050596ef272ebda --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-12 17:07:10,106 truncating revision to first 12 chars 2016-08-12 17:07:10,106 Setting DEBUG logging. 2016-08-12 17:07:10,106 attempt 1/10 2016-08-12 17:07:10,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2ed7e61b988d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 17:07:11,553 unpacking tar archive at: mozilla-central-2ed7e61b988d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.731892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-12 17:07:11.775090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:11.775409) ========= script_repo_revision: 2ed7e61b988d2466a61528f66050596ef272ebda ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:11.775808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:11.776069) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 17:07:11.795046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-12 17:07:11.795419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:07:11 INFO - MultiFileLogger online at 20160812 17:07:11 in /builds/slave/test 17:07:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:07:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:07:12 INFO - {'append_to_log': False, 17:07:12 INFO - 'base_work_dir': '/builds/slave/test', 17:07:12 INFO - 'blob_upload_branch': 'Firefox', 17:07:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:07:12 INFO - 'branch': 'Firefox', 17:07:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:07:12 INFO - 'config_files': ('talos/mac_config.py',), 17:07:12 INFO - 'default_actions': ('clobber', 17:07:12 INFO - 'read-buildbot-config', 17:07:12 INFO - 'download-and-extract', 17:07:12 INFO - 'populate-webroot', 17:07:12 INFO - 'create-virtualenv', 17:07:12 INFO - 'install', 17:07:12 INFO - 'run-tests'), 17:07:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:07:12 INFO - 'download_minidump_stackwalk': True, 17:07:12 INFO - 'download_symbols': 'ondemand', 17:07:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:07:12 INFO - 'tooltool.py': '/tools/tooltool.py', 17:07:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:07:12 INFO - '/tools/misc-python/virtualenv.py')}, 17:07:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:07:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:07:12 INFO - 'installer_path': 'installer.exe', 17:07:12 INFO - 'log_level': 'info', 17:07:12 INFO - 'log_name': 'talos', 17:07:12 INFO - 'log_to_console': True, 17:07:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:07:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:07:12 INFO - 'opt_config_files': (), 17:07:12 INFO - 'pip_index': False, 17:07:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:07:12 INFO - 'cmd': ('bash', 17:07:12 INFO - '-c', 17:07:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:07:12 INFO - 'enabled': True, 17:07:12 INFO - 'halt_on_failure': False, 17:07:12 INFO - 'name': 'check_screen_resolution'},), 17:07:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:07:12 INFO - 'cmd': ('bash', 17:07:12 INFO - '-c', 17:07:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:07:12 INFO - 'enabled': True, 17:07:12 INFO - 'halt_on_failure': False, 17:07:12 INFO - 'name': 'check_screen_resolution'},), 17:07:12 INFO - 'run_cmd_checks_enabled': True, 17:07:12 INFO - 'sps_profile': False, 17:07:12 INFO - 'sps_profile_interval': 0, 17:07:12 INFO - 'suite': 'dromaeojs-e10s', 17:07:12 INFO - 'system_bits': '32', 17:07:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:07:12 INFO - 'title': 't-yosemite-r7-0312', 17:07:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:07:12 INFO - 'use_talos_json': True, 17:07:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:07:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:07:12 INFO - 'work_dir': 'build'} 17:07:12 INFO - [mozharness: 2016-08-13 00:07:12.008149Z] Running clobber step. 17:07:12 INFO - Running pre-action listener: _resource_record_pre_action 17:07:12 INFO - Running main action method: clobber 17:07:12 INFO - rmtree: /builds/slave/test/build 17:07:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:07:14 INFO - Running post-action listener: _resource_record_post_action 17:07:14 INFO - [mozharness: 2016-08-13 00:07:14.028181Z] Finished clobber step (success) 17:07:14 INFO - [mozharness: 2016-08-13 00:07:14.028461Z] Running read-buildbot-config step. 17:07:14 INFO - Running pre-action listener: _resource_record_pre_action 17:07:14 INFO - Running main action method: read_buildbot_config 17:07:14 INFO - Using buildbot properties: 17:07:14 INFO - { 17:07:14 INFO - "project": "", 17:07:14 INFO - "product": "firefox", 17:07:14 INFO - "script_repo_revision": "production", 17:07:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:07:14 INFO - "repository": "", 17:07:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:07:14 INFO - "buildid": "20160812143816", 17:07:14 INFO - "pgo_build": "False", 17:07:14 INFO - "basedir": "/builds/slave/test", 17:07:14 INFO - "buildnumber": 41, 17:07:14 INFO - "slavename": "t-yosemite-r7-0312", 17:07:14 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:07:14 INFO - "platform": "yosemite_r7", 17:07:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:07:14 INFO - "branch": "mozilla-central", 17:07:14 INFO - "repo_path": "mozilla-central", 17:07:14 INFO - "revision": "2ed7e61b988d2466a61528f66050596ef272ebda", 17:07:14 INFO - "stage_platform": "macosx64", 17:07:14 INFO - "builduid": "b9c41b9e406445899e4fd8d1e1611a07", 17:07:14 INFO - "slavebuilddir": "test" 17:07:14 INFO - } 17:07:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:07:14 INFO - Running post-action listener: _resource_record_post_action 17:07:14 INFO - [mozharness: 2016-08-13 00:07:14.032837Z] Finished read-buildbot-config step (success) 17:07:14 INFO - [mozharness: 2016-08-13 00:07:14.032984Z] Running download-and-extract step. 17:07:14 INFO - Running pre-action listener: _resource_record_pre_action 17:07:14 INFO - Running main action method: download_and_extract 17:07:14 INFO - mkdir: /builds/slave/test/build/tests 17:07:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:14 INFO - trying https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:07:14 INFO - Downloading https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:07:15 INFO - Downloaded 1199 bytes. 17:07:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:07:15 INFO - Using the following test package requirements: 17:07:15 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:07:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:07:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:07:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'jsshell-mac.zip'], 17:07:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:07:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:07:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:07:15 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:07:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:07:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:07:15 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:07:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:07:15 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:15 INFO - trying https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:07:15 INFO - Downloading https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:07:15 INFO - Downloaded 16330516 bytes. 17:07:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:07:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:22 INFO - trying https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:07:22 INFO - Downloading https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:07:23 INFO - Downloaded 16330516 bytes. 17:07:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:30 INFO - trying https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:07:30 INFO - Downloading https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:07:33 INFO - Downloaded 14413719 bytes. 17:07:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:07: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:33 INFO - trying https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:07:33 INFO - Downloading https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:07:39 INFO - Downloaded 111050743 bytes. 17:07:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:07:39 INFO - mkdir: /builds/slave/test/properties 17:07:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:07:39 INFO - Writing to file /builds/slave/test/properties/build_url 17:07:39 INFO - Contents: 17:07:39 INFO - build_url:https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:07:40 INFO - Running post-action listener: _resource_record_post_action 17:07:40 INFO - Running post-action listener: set_extra_try_arguments 17:07:40 INFO - [mozharness: 2016-08-13 00:07:40.095021Z] Finished download-and-extract step (success) 17:07:40 INFO - [mozharness: 2016-08-13 00:07:40.095161Z] Running populate-webroot step. 17:07:40 INFO - Running pre-action listener: _resource_record_pre_action 17:07:40 INFO - Running main action method: populate_webroot 17:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:07:40 INFO - '--tppagecycles', 17:07:40 INFO - '7'], 17:07:40 INFO - 'tests': ['tsvgm']}}, 17:07:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:07:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:07:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:07:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['damp', 'tps']}, 17:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'tests': ['damp', 'tps']}, 17:07:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['dromaeo_dom']}, 17:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:07:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['basic_compositor_video']}, 17:07:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:07:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'other-e10s': {'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['a11yr', 17:07:40 INFO - 'ts_paint', 17:07:40 INFO - 'tpaint', 17:07:40 INFO - 'sessionrestore', 17:07:40 INFO - 'sessionrestore_no_auto_restore', 17:07:40 INFO - 'tabpaint']}, 17:07:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['tsvgx', 17:07:40 INFO - 'tsvgr_opacity', 17:07:40 INFO - 'tart', 17:07:40 INFO - 'tscrollx', 17:07:40 INFO - 'cart']}, 17:07:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:07:40 INFO - 'tsvgr_opacity', 17:07:40 INFO - 'tart', 17:07:40 INFO - 'tscrollx', 17:07:40 INFO - 'cart']}, 17:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'talos_options': ['--disable-e10s'], 17:07:40 INFO - 'tests': ['tp5o']}, 17:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'tests': ['tp5o']}, 17:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'talos_options': ['--disable-e10s', 17:07:40 INFO - '--xperf_path', 17:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:40 INFO - 'tests': ['tp5n']}, 17:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:07:40 INFO - 'talos_options': ['--xperf_path', 17:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:07:40 INFO - 'tests': ['tp5n']}}, 17:07:40 INFO - 'talos.zip': {'path': '', 17:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:07:40 INFO - Running post-action listener: _resource_record_post_action 17:07:40 INFO - [mozharness: 2016-08-13 00:07:40.113734Z] Finished populate-webroot step (success) 17:07:40 INFO - [mozharness: 2016-08-13 00:07:40.113858Z] Running create-virtualenv step. 17:07:40 INFO - Running pre-action listener: _resource_record_pre_action 17:07:40 INFO - Running main action method: create_virtualenv 17:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 17:07:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:07:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:07:40 INFO - Using real prefix '/tools/python27' 17:07:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:07:40 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:43 INFO - Installing pip.................done. 17:07:43 INFO - Return code: 0 17:07:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:07:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:43 INFO - 'HOME': '/Users/cltbld', 17:07:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:43 INFO - 'LOGNAME': 'cltbld', 17:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:43 INFO - 'MOZ_NO_REMOTE': '1', 17:07:43 INFO - 'NO_EM_RESTART': '1', 17:07:43 INFO - 'PAGER': '/bin/cat', 17:07:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:43 INFO - 'PWD': '/builds/slave/test', 17:07:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:43 INFO - 'SHELL': '/bin/bash', 17:07:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:43 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:43 INFO - 'USER': 'cltbld', 17:07:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:43 INFO - 'XPC_FLAGS': '0x0', 17:07:43 INFO - 'XPC_SERVICE_NAME': '0', 17:07:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:44 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 17:07:44 INFO - Cleaning up... 17:07:44 INFO - Return code: 0 17:07:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:07:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:44 INFO - 'HOME': '/Users/cltbld', 17:07:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:44 INFO - 'LOGNAME': 'cltbld', 17:07:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:44 INFO - 'MOZ_NO_REMOTE': '1', 17:07:44 INFO - 'NO_EM_RESTART': '1', 17:07:44 INFO - 'PAGER': '/bin/cat', 17:07:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:44 INFO - 'PWD': '/builds/slave/test', 17:07:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:44 INFO - 'SHELL': '/bin/bash', 17:07:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:44 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:44 INFO - 'USER': 'cltbld', 17:07:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:44 INFO - 'XPC_FLAGS': '0x0', 17:07:44 INFO - 'XPC_SERVICE_NAME': '0', 17:07:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:44 INFO - Downloading/unpacking psutil>=3.1.1 17:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:07:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:47 INFO - Installing collected packages: psutil 17:07:47 INFO - Running setup.py install for psutil 17:07:47 INFO - building 'psutil._psutil_osx' extension 17:07:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:07:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:07:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:07:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:07:48 INFO - building 'psutil._psutil_posix' extension 17:07:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:07:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:07:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:07:48 INFO - ^ 17:07:48 INFO - 1 warning generated. 17:07:48 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:48 INFO - Successfully installed psutil 17:07:48 INFO - Cleaning up... 17:07:48 INFO - Return code: 0 17:07:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:48 INFO - 'HOME': '/Users/cltbld', 17:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:48 INFO - 'LOGNAME': 'cltbld', 17:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:48 INFO - 'MOZ_NO_REMOTE': '1', 17:07:48 INFO - 'NO_EM_RESTART': '1', 17:07:48 INFO - 'PAGER': '/bin/cat', 17:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:48 INFO - 'PWD': '/builds/slave/test', 17:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:48 INFO - 'SHELL': '/bin/bash', 17:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:48 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:48 INFO - 'USER': 'cltbld', 17:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:48 INFO - 'XPC_FLAGS': '0x0', 17:07:48 INFO - 'XPC_SERVICE_NAME': '0', 17:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:07:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:07:51 INFO - Installing collected packages: mozsystemmonitor 17:07:51 INFO - Running setup.py install for mozsystemmonitor 17:07:51 INFO - Successfully installed mozsystemmonitor 17:07:51 INFO - Cleaning up... 17:07:51 INFO - Return code: 0 17:07:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:07:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:51 INFO - 'HOME': '/Users/cltbld', 17:07:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:51 INFO - 'LOGNAME': 'cltbld', 17:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:51 INFO - 'MOZ_NO_REMOTE': '1', 17:07:51 INFO - 'NO_EM_RESTART': '1', 17:07:51 INFO - 'PAGER': '/bin/cat', 17:07:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:51 INFO - 'PWD': '/builds/slave/test', 17:07:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:51 INFO - 'SHELL': '/bin/bash', 17:07:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:51 INFO - 'USER': 'cltbld', 17:07:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:51 INFO - 'XPC_FLAGS': '0x0', 17:07:51 INFO - 'XPC_SERVICE_NAME': '0', 17:07:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:51 INFO - Downloading/unpacking jsonschema==2.5.1 17:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 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 17:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:54 INFO - warning: no files found matching '*.txt' 17:07:54 INFO - no previously-included directories found matching 'build' 17:07:54 INFO - no previously-included directories found matching 'dist' 17:07:54 INFO - no previously-included directories found matching '.git*' 17:07:54 INFO - Installing collected packages: jsonschema, functools32 17:07:55 INFO - Running setup.py install for functools32 17:07:55 INFO - warning: no files found matching '*.txt' 17:07:55 INFO - no previously-included directories found matching 'build' 17:07:55 INFO - no previously-included directories found matching 'dist' 17:07:55 INFO - no previously-included directories found matching '.git*' 17:07:55 INFO - Successfully installed jsonschema functools32 17:07:55 INFO - Cleaning up... 17:07:55 INFO - Return code: 0 17:07:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:55 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:55 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:07:55 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 functools32==3.2.3-2 17:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:55 INFO - 'HOME': '/Users/cltbld', 17:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:55 INFO - 'LOGNAME': 'cltbld', 17:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:55 INFO - 'MOZ_NO_REMOTE': '1', 17:07:55 INFO - 'NO_EM_RESTART': '1', 17:07:55 INFO - 'PAGER': '/bin/cat', 17:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:55 INFO - 'PWD': '/builds/slave/test', 17:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:55 INFO - 'SHELL': '/bin/bash', 17:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:55 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:55 INFO - 'USER': 'cltbld', 17:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:55 INFO - 'XPC_FLAGS': '0x0', 17:07:55 INFO - 'XPC_SERVICE_NAME': '0', 17:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:07:55 INFO - Cleaning up... 17:07:55 INFO - Return code: 0 17:07:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:55 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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:07:55 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 17:07:55 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 17:07:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:07:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:55 INFO - 'HOME': '/Users/cltbld', 17:07:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:55 INFO - 'LOGNAME': 'cltbld', 17:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:55 INFO - 'MOZ_NO_REMOTE': '1', 17:07:55 INFO - 'NO_EM_RESTART': '1', 17:07:55 INFO - 'PAGER': '/bin/cat', 17:07:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:55 INFO - 'PWD': '/builds/slave/test', 17:07:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:55 INFO - 'SHELL': '/bin/bash', 17:07:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:07:55 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:07:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:55 INFO - 'USER': 'cltbld', 17:07:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:55 INFO - 'XPC_FLAGS': '0x0', 17:07:55 INFO - 'XPC_SERVICE_NAME': '0', 17:07:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:07:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:07:58 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 17:07:58 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 17:07:58 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 17:07:58 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 17:07:58 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 17:07:58 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 17:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:07:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:59 INFO - Downloading docopt-0.6.1.tar.gz 17:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:07:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:07:59 INFO - Running setup.py install for blobuploader 17:07:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:07:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:07:59 INFO - Running setup.py install for requests 17:08:00 INFO - Running setup.py install for docopt 17:08:00 INFO - Successfully installed blobuploader requests docopt 17:08:00 INFO - Cleaning up... 17:08:00 INFO - Return code: 0 17:08:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:00 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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:08:00 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 17:08:00 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 17:08:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:00 INFO - 'HOME': '/Users/cltbld', 17:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:00 INFO - 'LOGNAME': 'cltbld', 17:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:00 INFO - 'MOZ_NO_REMOTE': '1', 17:08:00 INFO - 'NO_EM_RESTART': '1', 17:08:00 INFO - 'PAGER': '/bin/cat', 17:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:00 INFO - 'PWD': '/builds/slave/test', 17:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:00 INFO - 'SHELL': '/bin/bash', 17:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:08:00 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:00 INFO - 'USER': 'cltbld', 17:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:00 INFO - 'XPC_FLAGS': '0x0', 17:08:00 INFO - 'XPC_SERVICE_NAME': '0', 17:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yIBVfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tRKbYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Kwb8zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xkFXVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EvpozH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jc_A_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TLDNK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-s8vY8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Wz3YKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-kxb2cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NmYKY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-278ZIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TgpMca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-12PmwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GrjiJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5VlwdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-25ATBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:02 INFO - Running setup.py install for manifestparser 17:08:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:02 INFO - Running setup.py install for mozcrash 17:08:02 INFO - Running setup.py install for mozdebug 17:08:02 INFO - Running setup.py install for mozdevice 17:08:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Running setup.py install for mozfile 17:08:03 INFO - Running setup.py install for mozhttpd 17:08:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Running setup.py install for mozinfo 17:08:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Running setup.py install for mozInstall 17:08:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Running setup.py install for mozleak 17:08:03 INFO - Running setup.py install for mozlog 17:08:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:03 INFO - Running setup.py install for moznetwork 17:08:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:04 INFO - Running setup.py install for mozprocess 17:08:04 INFO - Running setup.py install for mozprofile 17:08:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:04 INFO - Running setup.py install for mozrunner 17:08:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:04 INFO - Running setup.py install for mozscreenshot 17:08:04 INFO - Running setup.py install for moztest 17:08:04 INFO - Running setup.py install for mozversion 17:08:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:05 INFO - Cleaning up... 17:08:05 INFO - Return code: 0 17:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:05 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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:08:05 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 17:08:05 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 17:08:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:08:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:05 INFO - 'HOME': '/Users/cltbld', 17:08:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:05 INFO - 'LOGNAME': 'cltbld', 17:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:05 INFO - 'MOZ_NO_REMOTE': '1', 17:08:05 INFO - 'NO_EM_RESTART': '1', 17:08:05 INFO - 'PAGER': '/bin/cat', 17:08:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:05 INFO - 'PWD': '/builds/slave/test', 17:08:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:05 INFO - 'SHELL': '/bin/bash', 17:08:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:08:05 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:08:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:05 INFO - 'USER': 'cltbld', 17:08:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:05 INFO - 'XPC_FLAGS': '0x0', 17:08:05 INFO - 'XPC_SERVICE_NAME': '0', 17:08:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JBsC9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PEvhfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-WLKRLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-qu8wLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Lf3sjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wDR65B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:05 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)) 17:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZSbQey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bKMkDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Cz6AEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-rj43ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-976265-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-rOX5tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lbj7vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-LeOlxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6oupFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:06 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)) 17:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VHyKRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:07 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)) 17:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:07 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5dy3sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:07 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)) 17:08:07 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)) 17:08:07 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)) 17:08:07 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)) 17:08:07 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)) 17:08:07 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)) 17:08:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:09 INFO - Downloading blessings-1.6.tar.gz 17:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:10 INFO - Installing collected packages: blessings 17:08:10 INFO - Running setup.py install for blessings 17:08:10 INFO - Successfully installed blessings 17:08:10 INFO - Cleaning up... 17:08:10 INFO - Return code: 0 17:08:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:10 INFO - Reading from file tmpfile_stdout 17:08:10 INFO - Current package versions: 17:08:10 INFO - blessings == 1.6 17:08:10 INFO - blobuploader == 1.2.4 17:08:10 INFO - docopt == 0.6.1 17:08:10 INFO - functools32 == 3.2.3-2 17:08:10 INFO - jsonschema == 2.5.1 17:08:10 INFO - manifestparser == 1.1 17:08:10 INFO - mozInstall == 1.12 17:08:10 INFO - mozcrash == 0.17 17:08:10 INFO - mozdebug == 0.1 17:08:10 INFO - mozdevice == 0.48 17:08:10 INFO - mozfile == 1.2 17:08:10 INFO - mozhttpd == 0.7 17:08:10 INFO - mozinfo == 0.9 17:08:10 INFO - mozleak == 0.1 17:08:10 INFO - mozlog == 3.3 17:08:10 INFO - moznetwork == 0.27 17:08:10 INFO - mozprocess == 0.23 17:08:10 INFO - mozprofile == 0.28 17:08:10 INFO - mozrunner == 6.12 17:08:10 INFO - mozscreenshot == 0.1 17:08:10 INFO - mozsystemmonitor == 0.3 17:08:10 INFO - moztest == 0.7 17:08:10 INFO - mozversion == 1.4 17:08:10 INFO - psutil == 3.1.1 17:08:10 INFO - requests == 1.2.3 17:08:10 INFO - wsgiref == 0.1.2 17:08:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:10 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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:08:10 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 17:08:10 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 17:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:10 INFO - 'HOME': '/Users/cltbld', 17:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:10 INFO - 'LOGNAME': 'cltbld', 17:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:10 INFO - 'MOZ_NO_REMOTE': '1', 17:08:10 INFO - 'NO_EM_RESTART': '1', 17:08:10 INFO - 'PAGER': '/bin/cat', 17:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:10 INFO - 'PWD': '/builds/slave/test', 17:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:10 INFO - 'SHELL': '/bin/bash', 17:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:08:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:10 INFO - 'USER': 'cltbld', 17:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:10 INFO - 'XPC_FLAGS': '0x0', 17:08:10 INFO - 'XPC_SERVICE_NAME': '0', 17:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 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)) 17:08:11 INFO - Cleaning up... 17:08:11 INFO - Return code: 0 17:08:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:11 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:11 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 0x1034f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd9ef20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:08:11 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 17:08:11 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 17:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:11 INFO - 'HOME': '/Users/cltbld', 17:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:11 INFO - 'LOGNAME': 'cltbld', 17:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:11 INFO - 'MOZ_NO_REMOTE': '1', 17:08:11 INFO - 'NO_EM_RESTART': '1', 17:08:11 INFO - 'PAGER': '/bin/cat', 17:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:11 INFO - 'PWD': '/builds/slave/test', 17:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:11 INFO - 'SHELL': '/bin/bash', 17:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:08:11 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:11 INFO - 'USER': 'cltbld', 17:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:11 INFO - 'XPC_FLAGS': '0x0', 17:08:11 INFO - 'XPC_SERVICE_NAME': '0', 17:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:08:11 INFO - Cleaning up... 17:08:11 INFO - Return code: 0 17:08:11 INFO - Running post-action listener: _resource_record_post_action 17:08:11 INFO - Running post-action listener: _start_resource_monitoring 17:08:11 INFO - Starting resource monitoring. 17:08:11 INFO - [mozharness: 2016-08-13 00:08:11.514142Z] Finished create-virtualenv step (success) 17:08:11 INFO - [mozharness: 2016-08-13 00:08:11.515158Z] Running install step. 17:08:11 INFO - Running pre-action listener: _resource_record_pre_action 17:08:11 INFO - Running main action method: install 17:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:11 INFO - Reading from file tmpfile_stdout 17:08:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:11 INFO - Reading from file tmpfile_stdout 17:08:11 INFO - Output received: 17:08:11 INFO - Usage: mozinstall [options] installer 17:08:11 INFO - Options: 17:08:11 INFO - -h, --help show this help message and exit 17:08:11 INFO - -d DEST, --destination=DEST 17:08:11 INFO - Directory to install application into. [default: 17:08:11 INFO - "/builds/slave/test"] 17:08:11 INFO - --app=APP Application being installed. [default: firefox] 17:08:11 INFO - mkdir: /builds/slave/test/build/application 17:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:08:45 INFO - Reading from file tmpfile_stdout 17:08:45 INFO - Output received: 17:08:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:08:45 INFO - Running post-action listener: _resource_record_post_action 17:08:45 INFO - [mozharness: 2016-08-13 00:08:45.989774Z] Finished install step (success) 17:08:45 INFO - [mozharness: 2016-08-13 00:08:45.989929Z] Running run-tests step. 17:08:45 INFO - Running pre-action listener: _resource_record_pre_action 17:08:45 INFO - Running main action method: run_tests 17:08:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:08:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:08:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:08:46 INFO - 2016-08-12 17:08:46.004 screenresolution[1640:7659] starting screenresolution argv=screenresolution get 17:08:46 INFO - 2016-08-12 17:08:46.007 screenresolution[1640:7659] Display 0: 1600x1200x32@60 17:08:46 INFO - 2016-08-12 17:08:46.012 screenresolution[1641:7661] starting screenresolution argv=screenresolution list 17:08:46 INFO - Available Modes on Display 0 17:08:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:08:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:08:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:08:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:08:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:08:46 INFO - Intel Iris: 17:08:46 INFO - Chipset Model: Intel Iris 17:08:46 INFO - Type: GPU 17:08:46 INFO - Bus: Built-In 17:08:46 INFO - VRAM (Dynamic, Max): 1536 MB 17:08:46 INFO - Vendor: Intel (0x8086) 17:08:46 INFO - Device ID: 0x0a2e 17:08:46 INFO - Revision ID: 0x0009 17:08:46 INFO - Displays: 17:08:46 INFO - Display: 17:08:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:08:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:08:46 INFO - Display Serial Number: 1600x1200 60 17:08:46 INFO - Main Display: Yes 17:08:46 INFO - Mirror: Off 17:08:46 INFO - Online: Yes 17:08:46 INFO - Rotation: Supported 17:08:46 INFO - Return code: 0 17:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:08:46 INFO - Python 2.7.3 17:08:46 INFO - Return code: 0 17:08:46 INFO - grabbing minidump binary from tooltool 17:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:08:46 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/macosx64/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 0x10345dd30>, '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 0x1031c2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103455b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:08:46 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:08:46 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:08:46 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:08:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:08:46 INFO - Return code: 0 17:08:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:08:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:08:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:08:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:08:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.evDl12ZbZ6/Render', 17:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:46 INFO - 'HOME': '/Users/cltbld', 17:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:46 INFO - 'LOGNAME': 'cltbld', 17:08:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:08:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:46 INFO - 'MOZ_NO_REMOTE': '1', 17:08:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:08:46 INFO - 'NO_EM_RESTART': '1', 17:08:46 INFO - 'PAGER': '/bin/cat', 17:08:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:46 INFO - 'PWD': '/builds/slave/test', 17:08:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:46 INFO - 'SHELL': '/bin/bash', 17:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners', 17:08:46 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 17:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:46 INFO - 'USER': 'cltbld', 17:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:46 INFO - 'XPC_FLAGS': '0x0', 17:08:46 INFO - 'XPC_SERVICE_NAME': '0', 17:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:08:46 INFO - mozversion application_buildid: 20160812143816 17:08:46 INFO - mozversion application_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 17:08:46 INFO - mozversion application_display_name: Nightly 17:08:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:08:46 INFO - mozversion application_name: Firefox 17:08:46 INFO - mozversion application_remotingname: firefox 17:08:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:08:46 INFO - mozversion application_vendor: Mozilla 17:08:46 INFO - mozversion application_version: 51.0a1 17:08:46 INFO - mozversion platform_buildid: 20160812143816 17:08:46 INFO - mozversion platform_changeset: 2ed7e61b988d2466a61528f66050596ef272ebda 17:08:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:08:46 INFO - mozversion platform_version: 51.0a1 17:08:46 INFO - using testdate: 1471046926 17:08:46 INFO - actual date: 1471046926 17:08:46 INFO - starting webserver on 'localhost:49267' 17:08:46 INFO - SUITE-START | Running 2 tests 17:08:46 INFO - TEST-START | dromaeo_css 17:08:46 INFO - operating with platform_type : mac_ 17:08:46 INFO - Initialising browser for dromaeo_css test... 17:08:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpBdOjIT/profile http://localhost:49267/getInfo.html) 17:08:49 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:08:49 INFO - PROCESS | 1651 | colorDepth:24 17:08:49 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:08:49 INFO - PROCESS | 1651 | __metrics 17:08:49 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:08:50 INFO - TEST-INFO | 1651: exit 0 17:08:50 INFO - Browser initialized. 17:08:50 INFO - Running cycle 1/1 for dromaeo_css test... 17:08:50 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpBdOjIT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:02 INFO - PROCESS | 1654 | RSS: Main: 239616000 17:09:02 INFO - PROCESS | 1654 | 17:09:51 INFO - PROCESS | 1654 | 1471046991736 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] 17:12:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 17:12:04 INFO - PROCESS | 1654 | RSS: Main: 254570496 17:12:04 INFO - PROCESS | 1654 | 17:15:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 17:15:07 INFO - PROCESS | 1654 | RSS: Main: 267235328 17:15:07 INFO - PROCESS | 1654 | 17:18:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 17:18:09 INFO - PROCESS | 1654 | RSS: Main: 271384576 17:18:09 INFO - PROCESS | 1654 | 17:21:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 17:21:12 INFO - PROCESS | 1654 | RSS: Main: 270884864 17:21:12 INFO - PROCESS | 1654 | 17:24:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 17:24:15 INFO - PROCESS | 1654 | RSS: Main: 276180992 17:24:15 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 17:27:18 INFO - PROCESS | 1654 | RSS: Main: 278716416 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | __start_tp_report 17:27:18 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 17:27:18 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 17:27:18 INFO - PROCESS | 1654 | |i|pagename|runs| 17:27:18 INFO - PROCESS | 1654 | |0;dojo.html;2940.323725543125;3410.471376936574;3425.554677891877;3427.228873503462;3442.60410052844;4436.112777444512;5704;5736.110902810071;5757.596968212221;5815.360310365862;5817.301923769153;5827.271591051119;5853.7365818538165;5856.502197313233;5868.61853979491;5233.188855727369;5266.657667251617;5326.520613144816;5363.275957745713;5398.946010539903;5169.302144210521;5203.843884683447;5218.139007063849;5297.268238292452;5370.865728356803;4251.447311849471;5207.3490813648295;5209.1404918188455;5225.399079105894;5269.077911365495;4305.827766889321;5290.947090529084;5291.1534154535475;5317.574594032507;5325.866853328698;5221.973890130563;5241.082810508184;5260.842174734764;5276.2085687146855;5315.7873685052555;4803.678988278217;5384.73076346185;5636.915446268309;5654;5875.970620146914;5041.949580504222;5324.281222035014;6099.085137229406;6135.87728245437;6259.812205633838;5564.360098588673;6045.395460453963;6181.6600086995195;6218.253809542839;6238.87522249557;5755.3381361143165;5896.525868532867;5930.258717660293;5943.138244954457;5959.910601340984;6209.037599172136;6217.222847144107;6225.470834979077;6301.590396624205;6305.684715764193;6185.938140618626;6215.285242197115;6232.532560058014;6236.064590311399;6243.469305109116;6135.814547850547;6218.22272215973;6237.719302631393;6239.594426362272;6267.717952692049;6122.672617327995;6163.784267550704;6202.627842329474;6239;6271.184745982993;6168.167297414881;6201;6235.657038862906;6256.593321434092;6261.906071408933;4678.578927896506;4865.245886887538;4908.239222920453;4948.430930443045;4949.851504454872;3738.5700644425697;4405.140997505519;4437.64498840092;4448.043670610834;4496.235639941217;5814.447627475468;5815.924054050014;5907.822765317047;5916.171735956969;5946.078357854453;5334.653247538898;6184.103305020837;6195.411435913581;6270.153529273581;6279.717412716439;5892.057270836645;5937.168796368512;5947.762089516457;5997.96069336419;5999.940000600025;4965.602751779849;5196.870078248074;5464.28964234647;5468.644538105011;5479.178123281539;6207.689615519296;6249.156363890998;6344.6827658616885;6351.777687780906;6361.936380636227;5069.847904562869;6235.127082208585;6241.906371404341;6244.250689917239;6278.780242691484;6287.71705273273;6329.050642403492;6336.366363363627;6357.237131544244;6357.586756860789;6088.117223002729;6130.63216207029;6176.66028368426;6182.536309776695;6185.350538193605;6091.360407157184;6156;6206.348333424925;6228.719707613078;6233.875322493615;6098.9390106100145;6170.845728856814;6222.471089957223;6233.158523599256;6251.78118765841;6074.574779765374;6111.37903775109;6193.876122477615;6221.844453888689;6227.532935029982;5939;5972.193753843349;6111.7740652348275;6118.938810611837;6138.051223665275;6149.661768602769;6184.6212143875855;6223.439890409885;6233.75064997395;6251.562390632612;6006.939930600813;6008.279006519246;6103.969480152571;6104.26748790148;6122.571420000735 17:27:18 INFO - PROCESS | 1654 | |1;ext.html;519.470140456734;532.7336331834083;537.8628449745314;539.9595030372723;543.2204786131898;31265.687343126563;31904.36191276173;31914.68085319146;31968.36063278733;32171.356572868528;41645.16709665805;42232.78883605578;42273.57726422735;42311.153776924446;42401.15197696044;8203.26170644642;8854.690085846996;9671.61313547459;9868.950655246714;9880.654177103803;9046.86429703555;9083.546632538795;9774.755631109208;9782.070703283176;9801.362911410772;9683;9794.706158815246;9836.655717049905;9846.064623860722;9869.407835529892;9802.852957205612;9807.901920980841;9843.360181588174;9848.31061825669;9864.506774661239;8472.576371181478;9682.370645908064;9707.854382184272;9743.928167901526;9795.02049795022;39486.80256598699;39823;39830.20339593221;39996.20007599861;40048.39927401091;2676.2907829425217;3311.817850018248;3355.39602871483;3417.5044618530424;3539.345221134098;28654.283642908886;30325.545116823265;30703;31119.22201944947;31479.898203562996;3140.764442666786;3153.353562519678;3158.952615710766;3236.78620517306;3255.6744325567493;424519;429491;429787;432360;432518;33539;33561.160970975434;33579.83210083934;33616;33820.83089584586;34698.653013470044;35072.89562626251;35708;36209.45685814715;36645.63354366476;13573.049886508046;16561.585960351087;16565.006099633818;16593.419230327123;16594.336226551044;12644.557440489538;12674.493020279086;12750.872491274968;12794.040446966515;12817;18854;18918.81081189198;18935.526611834815;18970.81029189718;18988.43034708961;7981.201879812089;8083;8089.797755056171;8094.109647938722;8097.473664211808;870.5125129927261;935.3826474526779;986.8174387738292;1011.4993078426079;1017.8524114003576;29716.405671886874;30847;30874.845625771726;31168.064958051295;31298.530522042187;993.562832353762;1042.4318746283293;1043.5199808088212;1062.123747907979;1064.808334499782;13796.724065518634;14639.121652700873;14833.70332593342;15615.3753849847;15857;592491;661179;665814.6709266423;678016;680453;48723.5127648719;57342.42657573454;57496.71251643798;57968;58394.708026460445;1337.531863847665;1347.238810072306;1398.4615922869566;1401.3833913078213;1407.9225642589552;27762;28536.286592835346;29114.854425727735;29665.25836854096;30127.397452050398;50063.749681251364;51038.489615103375;51043;51111.2333315008;51156.74421627868;537770;629905.8504707447;631841;632016;636745;26355.86822065954;26806.329841754112;26837.597436038865;26845.731542685106;26956.865215673795;46766.53233467758;47374;47506.76246618745;48601.75699121482;48904;39086.02284942899;39472;39556.80221598873;39742;41047;38388.80805595954;38578.421323679606;39312;39748.80125599354;40026.79986600048;38721.4191787129;38736;38748.80625596854;40227;40285.39571906365;33411.498827518095;35376.11559711028;35620.64379356277;35877;36174.457383138746;25842.870785646704;26308.473830523664;26611.86694066517;26943.32641683895;26946.86526567433 17:27:18 INFO - PROCESS | 1654 | |2;jquery.html;351.4412084785193;374.9831257593409;380.26988182689234;383.6585438959325;398.61334505529646;17091.31634734609;17233;19884.90057549712;20951.68572471414;21147.47131321718;19435.31976380827;20746.33274417586;21284;21481.46296342588;21722.565548689017;5534.225208470817;6056.394360563952;6224.502039836825;6253.28087269963;6261.87476250477;5643.012472817261;6043.335233124375;6202.3487533808975;6249.843753906166;6269.937300627003;6023.578349515536;6102.511799056065;6107.358727333611;6173.166622505949;6187.412195841411;4973.403191617029;6110.725017374229;6168.136460895478;6169.167162433059;6171.567990240685;5823.767049318022;5930.644161350333;5938.168656388109;5939.613925094855;5954.315253745832;18532.81467185338;22447.551048979094;24997.87501062501;25755.48489030209;25987.74012259891;2279.3048120323297;2439.353571303606;2729.6997330293652;2793.9022134225406;3014.261505931039;9697.951510242403;10021.649242276559;10306.484675766256;10619.78760424795;16432.589185270343;1918.24229429376;1921.1738952250528;1925.5378709109852;1977.713231581427;2016.5059560407647;106445.46777266065;115604;132763.67236327706;139250.30374848162;141457;18328.725069123975;19310.613787724447;20523.563350565317;21589.352319430443;21601.459963500725;34788.652113479046;35048.12379690528;35144.297114057576;35232.823835880656;35244.29511409809;9037.457752534869;10466.424346660855;10512.684619461428;10697.946510267555;10978.451077446096;7772.106207786064;8150.184981501921;8850;8880.955595221982;9006.189442950166;8158.347332213409;8165.959170204111;9606.615735370646;9985.051420115078;10014.499275036365;3342.3983682937305;3606.404943184398;3874.1283211277237;3883.650471457582;3899.4150877368056;830.1864173110265;854.594067817794;882.571952602987;894.9550277615617;1000.3697670467559;17274.740878886827;21609.459763506038;21789.23737669174;21921;22121.115155393927;927.3184209605935;942.6700654770913;965.3821554205314;973.7711637765119;1028.5114570579065;10504.369737815756;10729.141668666489;11325.60360387399;11387.37369444672;11415.315081095161;595567;599695;604551;609089;626666.8666656638;92598;136465;138748.6125138756;138916;140703;983.9950800246096;996.6960077176531;1030;1030.340582027503;1032.1639472027682;16012.439564615182;18689.53276168107;18925.621487570446;19338.4198474046;19380.57742782152;49880.75298117576;52442.21336680029;53625.46374536361;55737.44262557485;56261;77723.611381945;78040.60979695065;80129;80335.19664803277;80556;7935.920640793749;8126.674933002614;8134.593270336578;8157.653987092301;8275.131111233233;12064.638060858188;12581.811272831097;12842.587315395485;13216.537421190213;13929.512467063603;10011.54948027326;10704.501369808077;10896.61861834832;11215.66353009411;11665.825012624988;11407.144464165387;11453.599124030952;11568.595099171489;11701.590444334408;11723.296602203895;11602.47788849487;11746.823797642872;11855.17013809025;11893.286402815858;11909.52361905514;8207.261346478606;8300.252977232078;8354.58227088631;8355.289800366794;8416.2004609562;9395.718128456158;11433.942830286129;11509.712257193638;11514.654560363202;11531.769364612828 17:27:18 INFO - PROCESS | 1654 | |3;mootools.html;1332.8134061231428;1443.3360654099115;1547.5976246175992;1817.291256410001;1832.9725054124199;7998.92001079989;8592.226699597035;8626.396152269344;9107.134822191898;9139.405938613985;8754.6935857245;8891.95554022229;8910.064443233448;8912.331575131875;8922.375433719642;2353.8352315337934;2393.8803059847023;2396.5446565152565;2399.796017338528;2401.075585899424;2337.731160916491;2388.283514945518;2397.3407312988893;2407.614781634939;2418.2745176447083;2024.5748392837522;2392.4975755091364;2401.1955994741784;2405.7113146422453;2409.795167410772;2374.643803429482;2377.785999260066;2388.940276493093;2394.7006624171977;2402.483466054789;2362.751911049332;2380.6548050532747;2383.225451728178;2384.5588566115325;2399.076355603088;9017.053209412983;9108.271338292921;9114.635414583408;9121.31590130743;9121.771955701095;5313.123334649778;5374.247605335257;5396.163594642837;5431.755570999275;5460.918086228709;3566.5898421681577;3683.521142251517;3712.3874560697454;3720.4560107555603;3740.5511338639267;1125.1224045244721;1131.8415421840948;1139.5555733264034;1144.862616486027;1796.1827368547279;11596.942015289955;11788.764224715544;11840.822387664191;11869.169158158933;11908.761824763544;4359.782010899442;4637.373954516097;4680.3447517347595;4709.576138147515;4721.15019296523;9153.908460915438;9269.675561355454;9282.489463079595;9299.67451139207;9300.34897557178;5242.292290540804;5257.658252213594;5264.92102618461;5273.419923808378;5277.788888444419;4446.82212711488;4721.7403042832975;4883.926741098886;4925.655204135748;4934.407871055496;3737.1965027519213;3760.5487341519192;3791.563970143414;3886.4170374443493;3887.5140607424073;1192.9105317101253;1198.053537705203;1200.0699457920182;1208.3354155214597;1208.8065909454444;823.5305875650942;874.7375787263923;905.9728208153766;930.8696782450462;941.1999800169801;5683.4884860361935;5755.3381361144;5991.670458124845;6034.366391528914;6067.423594758491;431.5878336188932;441.31816343748983;445.792706391523;908.8273228086642;957.5875583514261;3894.357431023849;3991.381335892941;4020.718549701551;4022.5374081980362;4106.589341065869;8598.882145321193;10131.696049118538;10660.307080039773;11003.669889903316;11031.338119712844;9670.613175472903;10508.42203678805;10813.729656758487;10981.725456863482;11009.83485247722;7190.8202294942;7416.7404140854815;8029.755387914883;8314.459560128693;8352.66589336432;5920.3783602722815;5971.373005834324;6058.787942421994;6059.848503787441;6129.601575897553;8201.630926608197;9741.318107732674;9971.950140249251;10044.748881278027;10158.593656253666;10062.496875156066;10100.393976361442;10464.895351046696;10466.424346661006;10471.476426178508;6913.792586222421;7393.260673932778;7422.777316680508;7638.923610763822;7676.117246516499;8478.279346255636;8484.939382577179;8492.660293588187;8535.402521823413;8574.699885503978;7534.962325188559;7683.577403242875;7724.382049436144;7800.4149688774705;7831.334336581454;7431.591262480615;7503.88744168827;7560.243975602396;7606.847863042597;7652.04349456318;6956.513044087068;7086.39765619928;7096.964515177598;7117.9678946553495;7121.537100088478;4892.363992681071;5046.212843725184;5063.822766203165;5079.16193828029;5114.846554603368;4943.3573635427165;4954.9752251238515;5010.398752149766;5073.898522029613;5188.169892817131 17:27:18 INFO - PROCESS | 1654 | |4;prototype.html;301.38818199055925;307.852230929154;314.16902293433867;314.3163619128395;315.3094722557599;4139.855105071323;4504.527024662412;5361.839144825652;5517.724113794309;5603.383627800944;5082.822101226458;5214.165733482643;5566.972165139179;5577.274954255941;5606.719664016803;3588.7667301625443;3743.727132774849;4104.9121982674615;4268.97865510672;4278.957210427887;3903.7657740535515;4028.2346354192755;4278.935815962763;4286.542575524321;4295.52749197588;3467;3520.3135388599108;3605.4952306677087;4083.3262511685684;4156.210320039198;3739.719521035933;4102.384642303648;4181.477315335583;4184.7070705050655;4199.370094485821;3316.436205845012;3402.4726167444087;3613.8373773180006;3621.94567081494;3630.546181727284;4452.79774460897;4935.629827762897;5030.346055012825;5180.715060671661;5499.780008799643;3913.5108111486065;4175.895602609929;4450.020995381044;4851.539103785135;4858.202465087905;5339.519443250126;5789.565782566325;5922.437368449991;5935.52515798735;5984.581079324449;3805.086779173006;3854.768713877176;3930.390789427643;3972.940405893914;3989.4614227079264;5592.6085174037835;6201.441870231656;6224.782132625336;6231.719572619198;6241.87516249677;3533.8056406897867;3697.630236976335;4015.8393664253103;4031.649397451828;4078.225137223977;2960.378320552665;3372.8482218299746;3991.6207960243732;4045.199886050738;4073.1446396256524;4205.810738516774;4761.785719642625;4767.831881189131;4775.498572649891;4777.522247775264;5215.6609820361555;5360.713428777065;5691.573132015115;5937.4359435854385;6024.638521688713;1303.89568834493;1401.6005438449993;1422.3741553716332;1425.4939496478808;1441.942322307117;935.5135329628555;938.8263171313329;956.9043095690514;964.5322018820866;986.2652324018652;4137.689673274516;4343.1747967886;4633.652476064309;4663.720176789336;4682.508336624674;4654.138984287918;5111.977604479045;5112.488751124858;5120.974395128075;5149.266781583322;3884.6309600587897;4158.6465150461945;4654.650901182425;4675.381786199739;4717.716936983792;2306.2850516339654;3190;3225.177579717157;3233.757468189848;3246.204679853451;6333.841653958596;6335.497478495969;6381.074744162071;6385.96807015962;6427.871442571216;6085.421884920926;6246.750129994749;6262.436380725757;6292.370762923671;6317.46301564363;5150.665206761549;6360.109584658151;6376.075469056961;6380.968095159587;6390.7443702251385;5787.681677507778;5838.678872661874;5840.269966254218;6064.848378790565;6165.3526379731275;5133.820316288912;6002.069679199731;6022.759089636365;6073.210482637229;6165.722542485689;5037.974810125926;5544.7227638618715;5824.359320474659;6356.713947872265;6380.266269379081;3295.7857739246874;3728.2357116791536;3978.701597380266;4014.417909403179;4039.2325458162854;5915.526757859275;6128.448439640454;6163.322034576283;6186.8863604549815;6187.474064704551;5797.884042319214;5816.127580862735;5865.530757539302;5990.610610310316;5991.554855957755;5511.382093505553;5993.760249589967;5995.1906492624685;6047.334793172836;6050.9394906050375;5603.187537807076;5876.676782776988;5905.822825315247;5928.466438020599;5944.47359872044;5267.5522580579545;6006.309274433496;6029.1559181715475;6056.818295451144;6087.847803804941;5072.1123803335;5757.5681823864215;5786.276715410574;5861.853453663693;5914.8946802927085 17:27:18 INFO - PROCESS | 1654 | |5;yui.html;745.4930647159931;756.9053868266467;769.699817071342;801.430984001359;812.9918700812991;15364.462243821468;15940.282687279072;15971.281292341844;17210.311587536515;17897.10514474274;15977.201139943014;16215.27031283592;16221.675566488693;16265.83734162658;16268.186590670479;687.4775170870149;854.7649396415973;883.5184824270756;883.7437143228456;886.1138861138861;853.4111463090479;867.3364875869964;881.9559022048904;884.6107712606465;887.0464250930244;899.3749344205747;922.3220932614523;924.7549399409162;925.4632313258328;925.6806401791371;905.8912930448322;917.9082091790767;920.1764420843341;922.349743430883;922.5663937949187;665.7836203233968;675.9290274521154;680.1837794646444;680.3128839871715;681.4548361310981;15047.548573542812;15312;15386.769198462032;15428.537143885702;15464.149471779048;11441.942790286079;14348.713025739531;14411.135331880016;14424.78362824548;14524.927375363055;11920;11949.701257468545;11985.460654270579;12016.63950081499;12111.939440302831;3779.4141908004303;3837.2325534893134;3861.4593956846065;3886.300465916134;3896.980515097435;119104;121133;122617;123565.38217308855;124099;10893.400862952614;11020.669379918616;11164.162687798447;11167.106631469464;11427.971482566609;22820.885895570416;22824.201152959566;22832.65751013736;22840.200592979167;22903.885480572822;8035.437519373705;8078.313343365762;8130.75607731769;8234.876476852853;8368.953880764904;4533.637309015271;4556.430446194226;4587.61005314552;4597.42532183477;4624.653151013687;2947.852607369623;3585.6414358564457;3625.093726568358;3629.020164555608;3687.668109870071;619.6831732568293;659.6713600988518;662.4071456046811;666.0874601795474;669.1735706402588;574.7528562717988;676.7766637009873;690.7271627707128;691.3259571917441;693.7467824244114;9645.324827262164;9658.806823863484;9660.516974151264;9837.311388202757;9846.212303015742;645.6771614192903;679.911611490513;686.1080595226186;691.9550229235084;694.8922916947881;4740.28895665646;4764.666473346832;4784.928226076611;4810.63920205986;4815.30178124177;154864.67702984464;159449;160701;169039;170278;110871.44564277127;137619;140439;141114.2944285272;148108;116493;124317.37841310736;124554;127608;131184;7707.075150981918;8190.64854299034;8873.73378798637;9049;9239.214666753402;46527;46540;50986;61376.38623613707;63122.36877631165;77792.61103694445;78526.82209766743;87647;100078.4996075044;100920.49539752254;13254.53609123676;13292.86707132955;13334.399952002377;13796.586102416944;13876.23680697531;14972.948535147343;15036.849631503545;15047.172405517802;15064.32210550506;15572.766408503654;13929;13955.511557095453;14272.072315299472;14379.42482300738;14564.781528276872;13926.51257205993;14123.858761412665;14125;14424.855751442352;14595.416183352547;13443.798343024668;13755.38100785487;13869.445222191;13945.860541394457;14301;11474.483648235682;11496.252743571642;11583;11883.940580297043;11899.82150267764;7676.577788221478;8815.691450799191;10493.16269983647;11654.064178048879;11770.17608767378 17:27:18 INFO - PROCESS | 1654 | __end_tp_report 17:27:18 INFO - PROCESS | 1654 | __start_cc_report 17:27:18 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,417 17:27:18 INFO - PROCESS | 1654 | __end_cc_report 17:27:18 INFO - PROCESS | 1654 | __startTimestamp1471048038565__endTimestamp 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | ------- Summary: start ------- 17:27:18 INFO - PROCESS | 1654 | Number of tests: 6 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5727.39 Median:6006.94 stddev:687.27 (11.4%) stddev-sans-first:653.67 17:27:18 INFO - PROCESS | 1654 | Values: 2940.3 3410.5 3425.6 3427.2 3442.6 4436.1 5704.0 5736.1 5757.6 5815.4 5817.3 5827.3 5853.7 5856.5 5868.6 5233.2 5266.7 5326.5 5363.3 5398.9 5169.3 5203.8 5218.1 5297.3 5370.9 4251.4 5207.3 5209.1 5225.4 5269.1 4305.8 5290.9 5291.2 5317.6 5325.9 5222.0 5241.1 5260.8 5276.2 5315.8 4803.7 5384.7 5636.9 5654.0 5876.0 5041.9 5324.3 6099.1 6135.9 6259.8 5564.4 6045.4 6181.7 6218.3 6238.9 5755.3 5896.5 5930.3 5943.1 5959.9 6209.0 6217.2 6225.5 6301.6 6305.7 6185.9 6215.3 6232.5 6236.1 6243.5 6135.8 6218.2 6237.7 6239.6 6267.7 6122.7 6163.8 6202.6 6239.0 6271.2 6168.2 6201.0 6235.7 6256.6 6261.9 4678.6 4865.2 4908.2 4948.4 4949.9 3738.6 4405.1 4437.6 4448.0 4496.2 5814.4 5815.9 5907.8 5916.2 5946.1 5334.7 6184.1 6195.4 6270.2 6279.7 5892.1 5937.2 5947.8 5998.0 5999.9 4965.6 5196.9 5464.3 5468.6 5479.2 6207.7 6249.2 6344.7 6351.8 6361.9 5069.8 6235.1 6241.9 6244.3 6278.8 6287.7 6329.1 6336.4 6357.2 6357.6 6088.1 6130.6 6176.7 6182.5 6185.4 6091.4 6156.0 6206.3 6228.7 6233.9 6098.9 6170.8 6222.5 6233.2 6251.8 6074.6 6111.4 6193.9 6221.8 6227.5 5939.0 5972.2 6111.8 6118.9 6138.1 6149.7 6184.6 6223.4 6233.8 6251.6 6006.9 6008.3 6104.0 6104.3 6122.6 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:68415.77 Median:38917.41 stddev:154219.61 (396.3%) stddev-sans-first:154567.98 17:27:18 INFO - PROCESS | 1654 | Values: 519.5 532.7 537.9 540.0 543.2 31265.7 31904.4 31914.7 31968.4 32171.4 41645.2 42232.8 42273.6 42311.2 42401.2 8203.3 8854.7 9671.6 9869.0 9880.7 9046.9 9083.5 9774.8 9782.1 9801.4 9683.0 9794.7 9836.7 9846.1 9869.4 9802.9 9807.9 9843.4 9848.3 9864.5 8472.6 9682.4 9707.9 9743.9 9795.0 39486.8 39823.0 39830.2 39996.2 40048.4 2676.3 3311.8 3355.4 3417.5 3539.3 28654.3 30325.5 30703.0 31119.2 31479.9 3140.8 3153.4 3159.0 3236.8 3255.7 424519.0 429491.0 429787.0 432360.0 432518.0 33539.0 33561.2 33579.8 33616.0 33820.8 34698.7 35072.9 35708.0 36209.5 36645.6 13573.0 16561.6 16565.0 16593.4 16594.3 12644.6 12674.5 12750.9 12794.0 12817.0 18854.0 18918.8 18935.5 18970.8 18988.4 7981.2 8083.0 8089.8 8094.1 8097.5 870.5 935.4 986.8 1011.5 1017.9 29716.4 30847.0 30874.8 31168.1 31298.5 993.6 1042.4 1043.5 1062.1 1064.8 13796.7 14639.1 14833.7 15615.4 15857.0 592491.0 661179.0 665814.7 678016.0 680453.0 48723.5 57342.4 57496.7 57968.0 58394.7 1337.5 1347.2 1398.5 1401.4 1407.9 27762.0 28536.3 29114.9 29665.3 30127.4 50063.7 51038.5 51043.0 51111.2 51156.7 537770.0 629905.9 631841.0 632016.0 636745.0 26355.9 26806.3 26837.6 26845.7 26956.9 46766.5 47374.0 47506.8 48601.8 48904.0 39086.0 39472.0 39556.8 39742.0 41047.0 38388.8 38578.4 39312.0 39748.8 40026.8 38721.4 38736.0 38748.8 40227.0 40285.4 33411.5 35376.1 35620.6 35877.0 36174.5 25842.9 26308.5 26611.9 26943.3 26946.9 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:36725.47 Median:2904.08 stddev:101405.48 (3491.8%) stddev-sans-first:101653.17 17:27:18 INFO - PROCESS | 1654 | Values: 351.4 375.0 380.3 383.7 398.6 17091.3 17233.0 19884.9 20951.7 21147.5 19435.3 20746.3 21284.0 21481.5 21722.6 5534.2 6056.4 6224.5 6253.3 6261.9 5643.0 6043.3 6202.3 6249.8 6269.9 6023.6 6102.5 6107.4 6173.2 6187.4 4973.4 6110.7 6168.1 6169.2 6171.6 5823.8 5930.6 5938.2 5939.6 5954.3 18532.8 22447.6 24997.9 25755.5 25987.7 2279.3 2439.4 2729.7 2793.9 3014.3 9698.0 10021.6 10306.5 10619.8 16432.6 1918.2 1921.2 1925.5 1977.7 2016.5 106445.5 115604.0 132763.7 139250.3 141457.0 18328.7 19310.6 20523.6 21589.4 21601.5 34788.7 35048.1 35144.3 35232.8 35244.3 9037.5 10466.4 10512.7 10697.9 10978.5 7772.1 8150.2 8850.0 8881.0 9006.2 8158.3 8166.0 9606.6 9985.1 10014.5 3342.4 3606.4 3874.1 3883.7 3899.4 830.2 854.6 882.6 895.0 1000.4 17274.7 21609.5 21789.2 21921.0 22121.1 927.3 942.7 965.4 973.8 1028.5 10504.4 10729.1 11325.6 11387.4 11415.3 595567.0 599695.0 604551.0 609089.0 626666.9 92598.0 136465.0 138748.6 138916.0 140703.0 984.0 996.7 1030.0 1030.3 1032.2 16012.4 18689.5 18925.6 19338.4 19380.6 49880.8 52442.2 53625.5 55737.4 56261.0 77723.6 78040.6 80129.0 80335.2 80556.0 7935.9 8126.7 8134.6 8157.7 8275.1 12064.6 12581.8 12842.6 13216.5 13929.5 10011.5 10704.5 10896.6 11215.7 11665.8 11407.1 11453.6 11568.6 11701.6 11723.3 11602.5 11746.8 11855.2 11893.3 11909.5 8207.3 8300.3 8354.6 8355.3 8416.2 9395.7 11433.9 11509.7 11514.7 11531.8 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5714.45 Median:4982.69 stddev:3188.83 (64.0%) stddev-sans-first:3180.77 17:27:18 INFO - PROCESS | 1654 | Values: 1332.8 1443.3 1547.6 1817.3 1833.0 7998.9 8592.2 8626.4 9107.1 9139.4 8754.7 8892.0 8910.1 8912.3 8922.4 2353.8 2393.9 2396.5 2399.8 2401.1 2337.7 2388.3 2397.3 2407.6 2418.3 2024.6 2392.5 2401.2 2405.7 2409.8 2374.6 2377.8 2388.9 2394.7 2402.5 2362.8 2380.7 2383.2 2384.6 2399.1 9017.1 9108.3 9114.6 9121.3 9121.8 5313.1 5374.2 5396.2 5431.8 5460.9 3566.6 3683.5 3712.4 3720.5 3740.6 1125.1 1131.8 1139.6 1144.9 1796.2 11596.9 11788.8 11840.8 11869.2 11908.8 4359.8 4637.4 4680.3 4709.6 4721.2 9153.9 9269.7 9282.5 9299.7 9300.3 5242.3 5257.7 5264.9 5273.4 5277.8 4446.8 4721.7 4883.9 4925.7 4934.4 3737.2 3760.5 3791.6 3886.4 3887.5 1192.9 1198.1 1200.1 1208.3 1208.8 823.5 874.7 906.0 930.9 941.2 5683.5 5755.3 5991.7 6034.4 6067.4 431.6 441.3 445.8 908.8 957.6 3894.4 3991.4 4020.7 4022.5 4106.6 8598.9 10131.7 10660.3 11003.7 11031.3 9670.6 10508.4 10813.7 10981.7 11009.8 7190.8 7416.7 8029.8 8314.5 8352.7 5920.4 5971.4 6058.8 6059.8 6129.6 8201.6 9741.3 9972.0 10044.7 10158.6 10062.5 10100.4 10464.9 10466.4 10471.5 6913.8 7393.3 7422.8 7638.9 7676.1 8478.3 8484.9 8492.7 8535.4 8574.7 7535.0 7683.6 7724.4 7800.4 7831.3 7431.6 7503.9 7560.2 7606.8 7652.0 6956.5 7086.4 7097.0 7118.0 7121.5 4892.4 5046.2 5063.8 5079.2 5114.8 4943.4 4955.0 5010.4 5073.9 5188.2 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4674.77 Median:5116.73 stddev:1507.23 (29.5%) stddev-sans-first:1475.28 17:27:18 INFO - PROCESS | 1654 | Values: 301.4 307.9 314.2 314.3 315.3 4139.9 4504.5 5361.8 5517.7 5603.4 5082.8 5214.2 5567.0 5577.3 5606.7 3588.8 3743.7 4104.9 4269.0 4279.0 3903.8 4028.2 4278.9 4286.5 4295.5 3467.0 3520.3 3605.5 4083.3 4156.2 3739.7 4102.4 4181.5 4184.7 4199.4 3316.4 3402.5 3613.8 3621.9 3630.5 4452.8 4935.6 5030.3 5180.7 5499.8 3913.5 4175.9 4450.0 4851.5 4858.2 5339.5 5789.6 5922.4 5935.5 5984.6 3805.1 3854.8 3930.4 3972.9 3989.5 5592.6 6201.4 6224.8 6231.7 6241.9 3533.8 3697.6 4015.8 4031.6 4078.2 2960.4 3372.8 3991.6 4045.2 4073.1 4205.8 4761.8 4767.8 4775.5 4777.5 5215.7 5360.7 5691.6 5937.4 6024.6 1303.9 1401.6 1422.4 1425.5 1441.9 935.5 938.8 956.9 964.5 986.3 4137.7 4343.2 4633.7 4663.7 4682.5 4654.1 5112.0 5112.5 5121.0 5149.3 3884.6 4158.6 4654.7 4675.4 4717.7 2306.3 3190.0 3225.2 3233.8 3246.2 6333.8 6335.5 6381.1 6386.0 6427.9 6085.4 6246.8 6262.4 6292.4 6317.5 5150.7 6360.1 6376.1 6381.0 6390.7 5787.7 5838.7 5840.3 6064.8 6165.4 5133.8 6002.1 6022.8 6073.2 6165.7 5038.0 5544.7 5824.4 6356.7 6380.3 3295.8 3728.2 3978.7 4014.4 4039.2 5915.5 6128.4 6163.3 6186.9 6187.5 5797.9 5816.1 5865.5 5990.6 5991.6 5511.4 5993.8 5995.2 6047.3 6050.9 5603.2 5876.7 5905.8 5928.5 5944.5 5267.6 6006.3 6029.2 6056.8 6087.8 5072.1 5757.6 5786.3 5861.9 5914.9 17:27:18 INFO - PROCESS | 1654 | 17:27:18 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:26080.12 Median:3266.75 stddev:42749.17 (1308.6%) stddev-sans-first:42826.77 17:27:18 INFO - PROCESS | 1654 | Values: 745.5 756.9 769.7 801.4 813.0 15364.5 15940.3 15971.3 17210.3 17897.1 15977.2 16215.3 16221.7 16265.8 16268.2 687.5 854.8 883.5 883.7 886.1 853.4 867.3 882.0 884.6 887.0 899.4 922.3 924.8 925.5 925.7 905.9 917.9 920.2 922.3 922.6 665.8 675.9 680.2 680.3 681.5 15047.5 15312.0 15386.8 15428.5 15464.1 11441.9 14348.7 14411.1 14424.8 14524.9 11920.0 11949.7 11985.5 12016.6 12111.9 3779.4 3837.2 3861.5 3886.3 3897.0 119104.0 121133.0 122617.0 123565.4 124099.0 10893.4 11020.7 11164.2 11167.1 11428.0 22820.9 22824.2 22832.7 22840.2 22903.9 8035.4 8078.3 8130.8 8234.9 8369.0 4533.6 4556.4 4587.6 4597.4 4624.7 2947.9 3585.6 3625.1 3629.0 3687.7 619.7 659.7 662.4 666.1 669.2 574.8 676.8 690.7 691.3 693.7 9645.3 9658.8 9660.5 9837.3 9846.2 645.7 679.9 686.1 692.0 694.9 4740.3 4764.7 4784.9 4810.6 4815.3 154864.7 159449.0 160701.0 169039.0 170278.0 110871.4 137619.0 140439.0 141114.3 148108.0 116493.0 124317.4 124554.0 127608.0 131184.0 7707.1 8190.6 8873.7 9049.0 9239.2 46527.0 46540.0 50986.0 61376.4 63122.4 77792.6 78526.8 87647.0 100078.5 100920.5 13254.5 13292.9 13334.4 13796.6 13876.2 14972.9 15036.8 15047.2 15064.3 15572.8 13929.0 13955.5 14272.1 14379.4 14564.8 13926.5 14123.9 14125.0 14424.9 14595.4 13443.8 13755.4 13869.4 13945.9 14301.0 11474.5 11496.3 11583.0 11883.9 11899.8 7676.6 8815.7 10493.2 11654.1 11770.2 17:27:18 INFO - PROCESS | 1654 | -------- Summary: end -------- 17:27:18 INFO - PROCESS | 1654 | 17:27:19 INFO - TEST-INFO | 1654: exit 0 17:27:19 INFO - TEST-OK | dromaeo_css | took 1112577ms 17:27:19 INFO - TEST-START | kraken 17:27:19 INFO - operating with platform_type : mac_ 17:27:19 INFO - Initialising browser for kraken test... 17:27:19 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp3w1bi_/profile http://localhost:49267/getInfo.html) 17:27:21 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:27:21 INFO - PROCESS | 1666 | colorDepth:24 17:27:21 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:27:21 INFO - PROCESS | 1666 | __metrics 17:27:22 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:27:22 INFO - TEST-INFO | 1666: exit 0 17:27:22 INFO - Browser initialized. 17:27:22 INFO - Running cycle 1/1 for kraken test... 17:27:22 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp3w1bi_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:34 INFO - PROCESS | 1668 | RSS: Main: 239665152 17:27:34 INFO - PROCESS | 1668 | 17:27:38 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 17:27:38 INFO - PROCESS | 1668 | RSS: Main: 252559360 17:27:38 INFO - PROCESS | 1668 | 17:27:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 17:27:42 INFO - PROCESS | 1668 | RSS: Main: 261275648 17:27:42 INFO - PROCESS | 1668 | 17:27:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 17:27:46 INFO - PROCESS | 1668 | RSS: Main: 264462336 17:27:46 INFO - PROCESS | 1668 | 17:27:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 17:27:48 INFO - PROCESS | 1668 | RSS: Main: 266776576 17:27:48 INFO - PROCESS | 1668 | 17:27:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:27:51 INFO - PROCESS | 1668 | RSS: Main: 267325440 17:27:51 INFO - PROCESS | 1668 | 17:27:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 17:27:55 INFO - PROCESS | 1668 | RSS: Main: 267325440 17:27:55 INFO - PROCESS | 1668 | 17:27:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 17:27:58 INFO - PROCESS | 1668 | RSS: Main: 267538432 17:27:58 INFO - PROCESS | 1668 | 17:28:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 17:28:02 INFO - PROCESS | 1668 | RSS: Main: 268009472 17:28:02 INFO - PROCESS | 1668 | 17:28:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:04 INFO - PROCESS | 1668 | RSS: Main: 267411456 17:28:04 INFO - PROCESS | 1668 | 17:28:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:07 INFO - PROCESS | 1668 | RSS: Main: 267628544 17:28:07 INFO - PROCESS | 1668 | 17:28:09 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:10 INFO - PROCESS | 1668 | RSS: Main: 267976704 17:28:10 INFO - PROCESS | 1668 | 17:28:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:14 INFO - PROCESS | 1668 | RSS: Main: 268070912 17:28:14 INFO - PROCESS | 1668 | 17:28:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:17 INFO - PROCESS | 1668 | RSS: Main: 268136448 17:28:17 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 17:28:19 INFO - PROCESS | 1668 | RSS: Main: 269201408 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | __start_tp_report 17:28:19 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 17:28:19 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 17:28:19 INFO - PROCESS | 1668 | |i|pagename|runs| 17:28:19 INFO - PROCESS | 1668 | |0;ai-astar;140;174;112;117;117;118;118;118;141;173 17:28:19 INFO - PROCESS | 1668 | |1;audio-beat-detection;139;112;134;163;108;132;134;113;159;132 17:28:19 INFO - PROCESS | 1668 | |2;audio-dft;204;272;221;266;205;189;195;200;199;198 17:28:19 INFO - PROCESS | 1668 | |3;audio-fft;70;80;77;144;60;59;58;64;151;85 17:28:19 INFO - PROCESS | 1668 | |4;audio-oscillator;72;76;121;73;74;96;116;71;73;117 17:28:19 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;90;86;89;88;98;122;91;92;89;86 17:28:19 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;96;117;138;150;150;96;96;95;98 17:28:19 INFO - PROCESS | 1668 | |7;imaging-desaturate;151;144;89;147;141;110;113;129;146;110 17:28:19 INFO - PROCESS | 1668 | |8;json-parse-financial;55;59;60;58;58;59;57;56;56;59 17:28:19 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;68;67;72;71;84;95;103;68;71;68 17:28:19 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;88;89;86;88;90;89;88;90;88;127 17:28:19 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;150;134;162;153;161;153;155;157;172;170 17:28:19 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;180;171;171;170;175;169;150;229;230;170 17:28:19 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;67;69;70;70;67;70;68;67;69;68 17:28:19 INFO - PROCESS | 1668 | __end_tp_report 17:28:19 INFO - PROCESS | 1668 | __start_cc_report 17:28:19 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1045 17:28:19 INFO - PROCESS | 1668 | __end_cc_report 17:28:19 INFO - PROCESS | 1668 | __startTimestamp1471048099644__endTimestamp 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | ------- Summary: start ------- 17:28:19 INFO - PROCESS | 1668 | Number of tests: 14 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:132.80 Median:129.00 stddev:23.62 (18.3%) stddev-sans-first:24.91 17:28:19 INFO - PROCESS | 1668 | Values: 140.0 174.0 112.0 117.0 117.0 118.0 118.0 118.0 141.0 173.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:134.00 stddev:18.50 (13.8%) stddev-sans-first:19.48 17:28:19 INFO - PROCESS | 1668 | Values: 139.0 112.0 134.0 163.0 108.0 132.0 134.0 113.0 159.0 132.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:214.90 Median:204.50 stddev:29.73 (14.5%) stddev-sans-first:31.27 17:28:19 INFO - PROCESS | 1668 | Values: 204.0 272.0 221.0 266.0 205.0 189.0 195.0 200.0 199.0 198.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:84.80 Median:67.00 stddev:34.35 (51.3%) stddev-sans-first:36.02 17:28:19 INFO - PROCESS | 1668 | Values: 70.0 80.0 77.0 144.0 60.0 59.0 58.0 64.0 151.0 85.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:73.00 stddev:21.36 (29.3%) stddev-sans-first:21.76 17:28:19 INFO - PROCESS | 1668 | Values: 72.0 76.0 121.0 73.0 74.0 96.0 116.0 71.0 73.0 117.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:93.10 Median:89.50 stddev:10.72 (12.0%) stddev-sans-first:11.31 17:28:19 INFO - PROCESS | 1668 | Values: 90.0 86.0 89.0 88.0 98.0 122.0 91.0 92.0 89.0 86.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:113.10 Median:95.50 stddev:23.85 (25.0%) stddev-sans-first:24.38 17:28:19 INFO - PROCESS | 1668 | Values: 95.0 96.0 117.0 138.0 150.0 150.0 96.0 96.0 95.0 98.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:128.00 Median:145.00 stddev:21.17 (14.6%) stddev-sans-first:20.76 17:28:19 INFO - PROCESS | 1668 | Values: 151.0 144.0 89.0 147.0 141.0 110.0 113.0 129.0 146.0 110.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.50 stddev:1.64 (2.8%) stddev-sans-first:1.41 17:28:19 INFO - PROCESS | 1668 | Values: 55.0 59.0 60.0 58.0 58.0 59.0 57.0 56.0 56.0 59.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:71.00 stddev:12.86 (18.1%) stddev-sans-first:13.25 17:28:19 INFO - PROCESS | 1668 | Values: 68.0 67.0 72.0 71.0 84.0 95.0 103.0 68.0 71.0 68.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:88.50 stddev:12.25 (13.8%) stddev-sans-first:12.89 17:28:19 INFO - PROCESS | 1668 | Values: 88.0 89.0 86.0 88.0 90.0 89.0 88.0 90.0 88.0 127.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:159.00 stddev:10.79 (6.8%) stddev-sans-first:11.17 17:28:19 INFO - PROCESS | 1668 | Values: 150.0 134.0 162.0 153.0 161.0 153.0 155.0 157.0 172.0 170.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:173.00 stddev:26.43 (15.3%) stddev-sans-first:28.03 17:28:19 INFO - PROCESS | 1668 | Values: 180.0 171.0 171.0 170.0 175.0 169.0 150.0 229.0 230.0 170.0 17:28:19 INFO - PROCESS | 1668 | 17:28:19 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.27 (1.8%) stddev-sans-first:1.22 17:28:19 INFO - PROCESS | 1668 | Values: 67.0 69.0 70.0 70.0 67.0 70.0 68.0 67.0 69.0 68.0 17:28:19 INFO - PROCESS | 1668 | -------- Summary: end -------- 17:28:19 INFO - PROCESS | 1668 | 17:28:20 INFO - TEST-INFO | 1668: exit 0 17:28:20 INFO - TEST-OK | kraken | took 61524ms 17:28:20 INFO - SUITE-END | took 1174s 17:28:20 INFO - Completed test suite (00:19:34) 17:28:20 INFO - javascript benchmark 17:28:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7508.940200884213, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2940.323725543125, 3410.471376936574, 3425.554677891877, 3427.228873503462, 3442.60410052844, 4436.112777444512, 5704.0, 5736.110902810071, 5757.596968212221, 5815.360310365862, 5817.301923769153, 5827.271591051119, 5853.7365818538165, 5856.502197313233, 5868.61853979491, 5233.188855727369, 5266.657667251617, 5326.520613144816, 5363.275957745713, 5398.946010539903, 5169.302144210521, 5203.843884683447, 5218.139007063849, 5297.268238292452, 5370.865728356803, 4251.447311849471, 5207.3490813648295, 5209.1404918188455, 5225.399079105894, 5269.077911365495, 4305.827766889321, 5290.947090529084, 5291.1534154535475, 5317.574594032507, 5325.866853328698, 5221.973890130563, 5241.082810508184, 5260.842174734764, 5276.2085687146855, 5315.7873685052555, 4803.678988278217, 5384.73076346185, 5636.915446268309, 5654.0, 5875.970620146914, 5041.949580504222, 5324.281222035014, 6099.085137229406, 6135.87728245437, 6259.812205633838, 5564.360098588673, 6045.395460453963, 6181.6600086995195, 6218.253809542839, 6238.87522249557, 5755.3381361143165, 5896.525868532867, 5930.258717660293, 5943.138244954457, 5959.910601340984, 6209.037599172136, 6217.222847144107, 6225.470834979077, 6301.590396624205, 6305.684715764193, 6185.938140618626, 6215.285242197115, 6232.532560058014, 6236.064590311399, 6243.469305109116, 6135.814547850547, 6218.22272215973, 6237.719302631393, 6239.594426362272, 6267.717952692049, 6122.672617327995, 6163.784267550704, 6202.627842329474, 6239.0, 6271.184745982993, 6168.167297414881, 6201.0, 6235.657038862906, 6256.593321434092, 6261.906071408933, 4678.578927896506, 4865.245886887538, 4908.239222920453, 4948.430930443045, 4949.851504454872, 3738.5700644425697, 4405.140997505519, 4437.64498840092, 4448.043670610834, 4496.235639941217, 5814.447627475468, 5815.924054050014, 5907.822765317047, 5916.171735956969, 5946.078357854453, 5334.653247538898, 6184.103305020837, 6195.411435913581, 6270.153529273581, 6279.717412716439, 5892.057270836645, 5937.168796368512, 5947.762089516457, 5997.96069336419, 5999.940000600025, 4965.602751779849, 5196.870078248074, 5464.28964234647, 5468.644538105011, 5479.178123281539, 6207.689615519296, 6249.156363890998, 6344.6827658616885, 6351.777687780906, 6361.936380636227, 5069.847904562869, 6235.127082208585, 6241.906371404341, 6244.250689917239, 6278.780242691484, 6287.71705273273, 6329.050642403492, 6336.366363363627, 6357.237131544244, 6357.586756860789, 6088.117223002729, 6130.63216207029, 6176.66028368426, 6182.536309776695, 6185.350538193605, 6091.360407157184, 6156.0, 6206.348333424925, 6228.719707613078, 6233.875322493615, 6098.9390106100145, 6170.845728856814, 6222.471089957223, 6233.158523599256, 6251.78118765841, 6074.574779765374, 6111.37903775109, 6193.876122477615, 6221.844453888689, 6227.532935029982, 5939.0, 5972.193753843349, 6111.7740652348275, 6118.938810611837, 6138.051223665275, 6149.661768602769, 6184.6212143875855, 6223.439890409885, 6233.75064997395, 6251.562390632612, 6006.939930600813, 6008.279006519246, 6103.969480152571, 6104.26748790148, 6122.571420000735], "value": 5683.434585057254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [519.470140456734, 532.7336331834083, 537.8628449745314, 539.9595030372723, 543.2204786131898, 31265.687343126563, 31904.36191276173, 31914.68085319146, 31968.36063278733, 32171.356572868528, 41645.16709665805, 42232.78883605578, 42273.57726422735, 42311.153776924446, 42401.15197696044, 8203.26170644642, 8854.690085846996, 9671.61313547459, 9868.950655246714, 9880.654177103803, 9046.86429703555, 9083.546632538795, 9774.755631109208, 9782.070703283176, 9801.362911410772, 9683.0, 9794.706158815246, 9836.655717049905, 9846.064623860722, 9869.407835529892, 9802.852957205612, 9807.901920980841, 9843.360181588174, 9848.31061825669, 9864.506774661239, 8472.576371181478, 9682.370645908064, 9707.854382184272, 9743.928167901526, 9795.02049795022, 39486.80256598699, 39823.0, 39830.20339593221, 39996.20007599861, 40048.39927401091, 2676.2907829425217, 3311.817850018248, 3355.39602871483, 3417.5044618530424, 3539.345221134098, 28654.283642908886, 30325.545116823265, 30703.0, 31119.22201944947, 31479.898203562996, 3140.764442666786, 3153.353562519678, 3158.952615710766, 3236.78620517306, 3255.6744325567493, 424519.0, 429491.0, 429787.0, 432360.0, 432518.0, 33539.0, 33561.160970975434, 33579.83210083934, 33616.0, 33820.83089584586, 34698.653013470044, 35072.89562626251, 35708.0, 36209.45685814715, 36645.63354366476, 13573.049886508046, 16561.585960351087, 16565.006099633818, 16593.419230327123, 16594.336226551044, 12644.557440489538, 12674.493020279086, 12750.872491274968, 12794.040446966515, 12817.0, 18854.0, 18918.81081189198, 18935.526611834815, 18970.81029189718, 18988.43034708961, 7981.201879812089, 8083.0, 8089.797755056171, 8094.109647938722, 8097.473664211808, 870.5125129927261, 935.3826474526779, 986.8174387738292, 1011.4993078426079, 1017.8524114003576, 29716.405671886874, 30847.0, 30874.845625771726, 31168.064958051295, 31298.530522042187, 993.562832353762, 1042.4318746283293, 1043.5199808088212, 1062.123747907979, 1064.808334499782, 13796.724065518634, 14639.121652700873, 14833.70332593342, 15615.3753849847, 15857.0, 592491.0, 661179.0, 665814.6709266423, 678016.0, 680453.0, 48723.5127648719, 57342.42657573454, 57496.71251643798, 57968.0, 58394.708026460445, 1337.531863847665, 1347.238810072306, 1398.4615922869566, 1401.3833913078213, 1407.9225642589552, 27762.0, 28536.286592835346, 29114.854425727735, 29665.25836854096, 30127.397452050398, 50063.749681251364, 51038.489615103375, 51043.0, 51111.2333315008, 51156.74421627868, 537770.0, 629905.8504707447, 631841.0, 632016.0, 636745.0, 26355.86822065954, 26806.329841754112, 26837.597436038865, 26845.731542685106, 26956.865215673795, 46766.53233467758, 47374.0, 47506.76246618745, 48601.75699121482, 48904.0, 39086.02284942899, 39472.0, 39556.80221598873, 39742.0, 41047.0, 38388.80805595954, 38578.421323679606, 39312.0, 39748.80125599354, 40026.79986600048, 38721.4191787129, 38736.0, 38748.80625596854, 40227.0, 40285.39571906365, 33411.498827518095, 35376.11559711028, 35620.64379356277, 35877.0, 36174.457383138746, 25842.870785646704, 26308.473830523664, 26611.86694066517, 26943.32641683895, 26946.86526567433], "value": 19279.697130089004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4412084785193, 374.9831257593409, 380.26988182689234, 383.6585438959325, 398.61334505529646, 17091.31634734609, 17233.0, 19884.90057549712, 20951.68572471414, 21147.47131321718, 19435.31976380827, 20746.33274417586, 21284.0, 21481.46296342588, 21722.565548689017, 5534.225208470817, 6056.394360563952, 6224.502039836825, 6253.28087269963, 6261.87476250477, 5643.012472817261, 6043.335233124375, 6202.3487533808975, 6249.843753906166, 6269.937300627003, 6023.578349515536, 6102.511799056065, 6107.358727333611, 6173.166622505949, 6187.412195841411, 4973.403191617029, 6110.725017374229, 6168.136460895478, 6169.167162433059, 6171.567990240685, 5823.767049318022, 5930.644161350333, 5938.168656388109, 5939.613925094855, 5954.315253745832, 18532.81467185338, 22447.551048979094, 24997.87501062501, 25755.48489030209, 25987.74012259891, 2279.3048120323297, 2439.353571303606, 2729.6997330293652, 2793.9022134225406, 3014.261505931039, 9697.951510242403, 10021.649242276559, 10306.484675766256, 10619.78760424795, 16432.589185270343, 1918.24229429376, 1921.1738952250528, 1925.5378709109852, 1977.713231581427, 2016.5059560407647, 106445.46777266065, 115604.0, 132763.67236327706, 139250.30374848162, 141457.0, 18328.725069123975, 19310.613787724447, 20523.563350565317, 21589.352319430443, 21601.459963500725, 34788.652113479046, 35048.12379690528, 35144.297114057576, 35232.823835880656, 35244.29511409809, 9037.457752534869, 10466.424346660855, 10512.684619461428, 10697.946510267555, 10978.451077446096, 7772.106207786064, 8150.184981501921, 8850.0, 8880.955595221982, 9006.189442950166, 8158.347332213409, 8165.959170204111, 9606.615735370646, 9985.051420115078, 10014.499275036365, 3342.3983682937305, 3606.404943184398, 3874.1283211277237, 3883.650471457582, 3899.4150877368056, 830.1864173110265, 854.594067817794, 882.571952602987, 894.9550277615617, 1000.3697670467559, 17274.740878886827, 21609.459763506038, 21789.23737669174, 21921.0, 22121.115155393927, 927.3184209605935, 942.6700654770913, 965.3821554205314, 973.7711637765119, 1028.5114570579065, 10504.369737815756, 10729.141668666489, 11325.60360387399, 11387.37369444672, 11415.315081095161, 595567.0, 599695.0, 604551.0, 609089.0, 626666.8666656638, 92598.0, 136465.0, 138748.6125138756, 138916.0, 140703.0, 983.9950800246096, 996.6960077176531, 1030.0, 1030.340582027503, 1032.1639472027682, 16012.439564615182, 18689.53276168107, 18925.621487570446, 19338.4198474046, 19380.57742782152, 49880.75298117576, 52442.21336680029, 53625.46374536361, 55737.44262557485, 56261.0, 77723.611381945, 78040.60979695065, 80129.0, 80335.19664803277, 80556.0, 7935.920640793749, 8126.674933002614, 8134.593270336578, 8157.653987092301, 8275.131111233233, 12064.638060858188, 12581.811272831097, 12842.587315395485, 13216.537421190213, 13929.512467063603, 10011.54948027326, 10704.501369808077, 10896.61861834832, 11215.66353009411, 11665.825012624988, 11407.144464165387, 11453.599124030952, 11568.595099171489, 11701.590444334408, 11723.296602203895, 11602.47788849487, 11746.823797642872, 11855.17013809025, 11893.286402815858, 11909.52361905514, 8207.261346478606, 8300.252977232078, 8354.58227088631, 8355.289800366794, 8416.2004609562, 9395.718128456158, 11433.942830286129, 11509.712257193638, 11514.654560363202, 11531.769364612828], "value": 10605.826675299428, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.8134061231428, 1443.3360654099115, 1547.5976246175992, 1817.291256410001, 1832.9725054124199, 7998.92001079989, 8592.226699597035, 8626.396152269344, 9107.134822191898, 9139.405938613985, 8754.6935857245, 8891.95554022229, 8910.064443233448, 8912.331575131875, 8922.375433719642, 2353.8352315337934, 2393.8803059847023, 2396.5446565152565, 2399.796017338528, 2401.075585899424, 2337.731160916491, 2388.283514945518, 2397.3407312988893, 2407.614781634939, 2418.2745176447083, 2024.5748392837522, 2392.4975755091364, 2401.1955994741784, 2405.7113146422453, 2409.795167410772, 2374.643803429482, 2377.785999260066, 2388.940276493093, 2394.7006624171977, 2402.483466054789, 2362.751911049332, 2380.6548050532747, 2383.225451728178, 2384.5588566115325, 2399.076355603088, 9017.053209412983, 9108.271338292921, 9114.635414583408, 9121.31590130743, 9121.771955701095, 5313.123334649778, 5374.247605335257, 5396.163594642837, 5431.755570999275, 5460.918086228709, 3566.5898421681577, 3683.521142251517, 3712.3874560697454, 3720.4560107555603, 3740.5511338639267, 1125.1224045244721, 1131.8415421840948, 1139.5555733264034, 1144.862616486027, 1796.1827368547279, 11596.942015289955, 11788.764224715544, 11840.822387664191, 11869.169158158933, 11908.761824763544, 4359.782010899442, 4637.373954516097, 4680.3447517347595, 4709.576138147515, 4721.15019296523, 9153.908460915438, 9269.675561355454, 9282.489463079595, 9299.67451139207, 9300.34897557178, 5242.292290540804, 5257.658252213594, 5264.92102618461, 5273.419923808378, 5277.788888444419, 4446.82212711488, 4721.7403042832975, 4883.926741098886, 4925.655204135748, 4934.407871055496, 3737.1965027519213, 3760.5487341519192, 3791.563970143414, 3886.4170374443493, 3887.5140607424073, 1192.9105317101253, 1198.053537705203, 1200.0699457920182, 1208.3354155214597, 1208.8065909454444, 823.5305875650942, 874.7375787263923, 905.9728208153766, 930.8696782450462, 941.1999800169801, 5683.4884860361935, 5755.3381361144, 5991.670458124845, 6034.366391528914, 6067.423594758491, 431.5878336188932, 441.31816343748983, 445.792706391523, 908.8273228086642, 957.5875583514261, 3894.357431023849, 3991.381335892941, 4020.718549701551, 4022.5374081980362, 4106.589341065869, 8598.882145321193, 10131.696049118538, 10660.307080039773, 11003.669889903316, 11031.338119712844, 9670.613175472903, 10508.42203678805, 10813.729656758487, 10981.725456863482, 11009.83485247722, 7190.8202294942, 7416.7404140854815, 8029.755387914883, 8314.459560128693, 8352.66589336432, 5920.3783602722815, 5971.373005834324, 6058.787942421994, 6059.848503787441, 6129.601575897553, 8201.630926608197, 9741.318107732674, 9971.950140249251, 10044.748881278027, 10158.593656253666, 10062.496875156066, 10100.393976361442, 10464.895351046696, 10466.424346661006, 10471.476426178508, 6913.792586222421, 7393.260673932778, 7422.777316680508, 7638.923610763822, 7676.117246516499, 8478.279346255636, 8484.939382577179, 8492.660293588187, 8535.402521823413, 8574.699885503978, 7534.962325188559, 7683.577403242875, 7724.382049436144, 7800.4149688774705, 7831.334336581454, 7431.591262480615, 7503.88744168827, 7560.243975602396, 7606.847863042597, 7652.04349456318, 6956.513044087068, 7086.39765619928, 7096.964515177598, 7117.9678946553495, 7121.537100088478, 4892.363992681071, 5046.212843725184, 5063.822766203165, 5079.16193828029, 5114.846554603368, 4943.3573635427165, 4954.9752251238515, 5010.398752149766, 5073.898522029613, 5188.169892817131], "value": 4569.324507505802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.38818199055925, 307.852230929154, 314.16902293433867, 314.3163619128395, 315.3094722557599, 4139.855105071323, 4504.527024662412, 5361.839144825652, 5517.724113794309, 5603.383627800944, 5082.822101226458, 5214.165733482643, 5566.972165139179, 5577.274954255941, 5606.719664016803, 3588.7667301625443, 3743.727132774849, 4104.9121982674615, 4268.97865510672, 4278.957210427887, 3903.7657740535515, 4028.2346354192755, 4278.935815962763, 4286.542575524321, 4295.52749197588, 3467.0, 3520.3135388599108, 3605.4952306677087, 4083.3262511685684, 4156.210320039198, 3739.719521035933, 4102.384642303648, 4181.477315335583, 4184.7070705050655, 4199.370094485821, 3316.436205845012, 3402.4726167444087, 3613.8373773180006, 3621.94567081494, 3630.546181727284, 4452.79774460897, 4935.629827762897, 5030.346055012825, 5180.715060671661, 5499.780008799643, 3913.5108111486065, 4175.895602609929, 4450.020995381044, 4851.539103785135, 4858.202465087905, 5339.519443250126, 5789.565782566325, 5922.437368449991, 5935.52515798735, 5984.581079324449, 3805.086779173006, 3854.768713877176, 3930.390789427643, 3972.940405893914, 3989.4614227079264, 5592.6085174037835, 6201.441870231656, 6224.782132625336, 6231.719572619198, 6241.87516249677, 3533.8056406897867, 3697.630236976335, 4015.8393664253103, 4031.649397451828, 4078.225137223977, 2960.378320552665, 3372.8482218299746, 3991.6207960243732, 4045.199886050738, 4073.1446396256524, 4205.810738516774, 4761.785719642625, 4767.831881189131, 4775.498572649891, 4777.522247775264, 5215.6609820361555, 5360.713428777065, 5691.573132015115, 5937.4359435854385, 6024.638521688713, 1303.89568834493, 1401.6005438449993, 1422.3741553716332, 1425.4939496478808, 1441.942322307117, 935.5135329628555, 938.8263171313329, 956.9043095690514, 964.5322018820866, 986.2652324018652, 4137.689673274516, 4343.1747967886, 4633.652476064309, 4663.720176789336, 4682.508336624674, 4654.138984287918, 5111.977604479045, 5112.488751124858, 5120.974395128075, 5149.266781583322, 3884.6309600587897, 4158.6465150461945, 4654.650901182425, 4675.381786199739, 4717.716936983792, 2306.2850516339654, 3190.0, 3225.177579717157, 3233.757468189848, 3246.204679853451, 6333.841653958596, 6335.497478495969, 6381.074744162071, 6385.96807015962, 6427.871442571216, 6085.421884920926, 6246.750129994749, 6262.436380725757, 6292.370762923671, 6317.46301564363, 5150.665206761549, 6360.109584658151, 6376.075469056961, 6380.968095159587, 6390.7443702251385, 5787.681677507778, 5838.678872661874, 5840.269966254218, 6064.848378790565, 6165.3526379731275, 5133.820316288912, 6002.069679199731, 6022.759089636365, 6073.210482637229, 6165.722542485689, 5037.974810125926, 5544.7227638618715, 5824.359320474659, 6356.713947872265, 6380.266269379081, 3295.7857739246874, 3728.2357116791536, 3978.701597380266, 4014.417909403179, 4039.2325458162854, 5915.526757859275, 6128.448439640454, 6163.322034576283, 6186.8863604549815, 6187.474064704551, 5797.884042319214, 5816.127580862735, 5865.530757539302, 5990.610610310316, 5991.554855957755, 5511.382093505553, 5993.760249589967, 5995.1906492624685, 6047.334793172836, 6050.9394906050375, 5603.187537807076, 5876.676782776988, 5905.822825315247, 5928.466438020599, 5944.47359872044, 5267.5522580579545, 6006.309274433496, 6029.1559181715475, 6056.818295451144, 6087.847803804941, 5072.1123803335, 5757.5681823864215, 5786.276715410574, 5861.853453663693, 5914.8946802927085], "value": 4204.0270101267415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.4930647159931, 756.9053868266467, 769.699817071342, 801.430984001359, 812.9918700812991, 15364.462243821468, 15940.282687279072, 15971.281292341844, 17210.311587536515, 17897.10514474274, 15977.201139943014, 16215.27031283592, 16221.675566488693, 16265.83734162658, 16268.186590670479, 687.4775170870149, 854.7649396415973, 883.5184824270756, 883.7437143228456, 886.1138861138861, 853.4111463090479, 867.3364875869964, 881.9559022048904, 884.6107712606465, 887.0464250930244, 899.3749344205747, 922.3220932614523, 924.7549399409162, 925.4632313258328, 925.6806401791371, 905.8912930448322, 917.9082091790767, 920.1764420843341, 922.349743430883, 922.5663937949187, 665.7836203233968, 675.9290274521154, 680.1837794646444, 680.3128839871715, 681.4548361310981, 15047.548573542812, 15312.0, 15386.769198462032, 15428.537143885702, 15464.149471779048, 11441.942790286079, 14348.713025739531, 14411.135331880016, 14424.78362824548, 14524.927375363055, 11920.0, 11949.701257468545, 11985.460654270579, 12016.63950081499, 12111.939440302831, 3779.4141908004303, 3837.2325534893134, 3861.4593956846065, 3886.300465916134, 3896.980515097435, 119104.0, 121133.0, 122617.0, 123565.38217308855, 124099.0, 10893.400862952614, 11020.669379918616, 11164.162687798447, 11167.106631469464, 11427.971482566609, 22820.885895570416, 22824.201152959566, 22832.65751013736, 22840.200592979167, 22903.885480572822, 8035.437519373705, 8078.313343365762, 8130.75607731769, 8234.876476852853, 8368.953880764904, 4533.637309015271, 4556.430446194226, 4587.61005314552, 4597.42532183477, 4624.653151013687, 2947.852607369623, 3585.6414358564457, 3625.093726568358, 3629.020164555608, 3687.668109870071, 619.6831732568293, 659.6713600988518, 662.4071456046811, 666.0874601795474, 669.1735706402588, 574.7528562717988, 676.7766637009873, 690.7271627707128, 691.3259571917441, 693.7467824244114, 9645.324827262164, 9658.806823863484, 9660.516974151264, 9837.311388202757, 9846.212303015742, 645.6771614192903, 679.911611490513, 686.1080595226186, 691.9550229235084, 694.8922916947881, 4740.28895665646, 4764.666473346832, 4784.928226076611, 4810.63920205986, 4815.30178124177, 154864.67702984464, 159449.0, 160701.0, 169039.0, 170278.0, 110871.44564277127, 137619.0, 140439.0, 141114.2944285272, 148108.0, 116493.0, 124317.37841310736, 124554.0, 127608.0, 131184.0, 7707.075150981918, 8190.64854299034, 8873.73378798637, 9049.0, 9239.214666753402, 46527.0, 46540.0, 50986.0, 61376.38623613707, 63122.36877631165, 77792.61103694445, 78526.82209766743, 87647.0, 100078.4996075044, 100920.49539752254, 13254.53609123676, 13292.86707132955, 13334.399952002377, 13796.586102416944, 13876.23680697531, 14972.948535147343, 15036.849631503545, 15047.172405517802, 15064.32210550506, 15572.766408503654, 13929.0, 13955.511557095453, 14272.072315299472, 14379.42482300738, 14564.781528276872, 13926.51257205993, 14123.858761412665, 14125.0, 14424.855751442352, 14595.416183352547, 13443.798343024668, 13755.38100785487, 13869.445222191, 13945.860541394457, 14301.0, 11474.483648235682, 11496.252743571642, 11583.0, 11883.940580297043, 11899.82150267764, 7676.577788221478, 8815.691450799191, 10493.16269983647, 11654.064178048879, 11770.17608767378], "value": 8028.852507428068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1621.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 174.0, 112.0, 117.0, 117.0, 118.0, 118.0, 118.0, 141.0, 173.0], "value": 132.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 112.0, 134.0, 163.0, 108.0, 132.0, 134.0, 113.0, 159.0, 132.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 272.0, 221.0, 266.0, 205.0, 189.0, 195.0, 200.0, 199.0, 198.0], "value": 214.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 77.0, 144.0, 60.0, 59.0, 58.0, 64.0, 151.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 121.0, 73.0, 74.0, 96.0, 116.0, 71.0, 73.0, 117.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 88.0, 98.0, 122.0, 91.0, 92.0, 89.0, 86.0], "value": 93.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 117.0, 138.0, 150.0, 150.0, 96.0, 96.0, 95.0, 98.0], "value": 113.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 144.0, 89.0, 147.0, 141.0, 110.0, 113.0, 129.0, 146.0, 110.0], "value": 128.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 60.0, 58.0, 58.0, 59.0, 57.0, 56.0, 56.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 72.0, 71.0, 84.0, 95.0, 103.0, 68.0, 71.0, 68.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 86.0, 88.0, 90.0, 89.0, 88.0, 90.0, 88.0, 127.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 162.0, 153.0, 161.0, 153.0, 155.0, 157.0, 172.0, 170.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 171.0, 171.0, 170.0, 175.0, 169.0, 150.0, 229.0, 230.0, 170.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 70.0, 67.0, 70.0, 68.0, 67.0, 69.0, 68.0], "value": 68.5, "unit": "score"}]}]} 17:28:20 INFO - Return code: 0 17:28:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:28:20 ERROR - # TBPL SUCCESS # 17:28:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:28:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:28:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:28:21 INFO - 2016-08-12 17:28:21.011 screenresolution[1673:10883] starting screenresolution argv=screenresolution get 17:28:21 INFO - 2016-08-12 17:28:21.013 screenresolution[1673:10883] Display 0: 1600x1200x32@60 17:28:21 INFO - 2016-08-12 17:28:21.020 screenresolution[1674:10886] starting screenresolution argv=screenresolution list 17:28:21 INFO - Available Modes on Display 0 17:28:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:28:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:28:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:28:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:28:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:28:21 INFO - Intel Iris: 17:28:21 INFO - Chipset Model: Intel Iris 17:28:21 INFO - Type: GPU 17:28:21 INFO - Bus: Built-In 17:28:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:28:21 INFO - Vendor: Intel (0x8086) 17:28:21 INFO - Device ID: 0x0a2e 17:28:21 INFO - Revision ID: 0x0009 17:28:21 INFO - Displays: 17:28:21 INFO - Display: 17:28:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:28:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:28:21 INFO - Display Serial Number: 1600x1200 60 17:28:21 INFO - Main Display: Yes 17:28:21 INFO - Mirror: Off 17:28:21 INFO - Online: Yes 17:28:21 INFO - Rotation: Supported 17:28:21 INFO - Return code: 0 17:28:21 INFO - Running post-action listener: _resource_record_post_action 17:28:21 INFO - [mozharness: 2016-08-13 00:28:21.262848Z] Finished run-tests step (success) 17:28:21 INFO - Running post-run listener: _resource_record_post_run 17:28:21 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 36724736; Write bytes: 708533248; Read time: 231; Write time: 2385 17:28:21 INFO - TinderboxPrint: CPU usage
54.6% 17:28:21 INFO - TinderboxPrint: I/O read bytes / time
36,724,736 / 231 17:28:21 INFO - TinderboxPrint: I/O write bytes / time
708,533,248 / 2,385 17:28:21 INFO - TinderboxPrint: CPU idle
2,195.6 (45.4%) 17:28:21 INFO - TinderboxPrint: CPU system
983.1 (20.3%) 17:28:21 INFO - TinderboxPrint: CPU user
1,658.9 (34.3%) 17:28:21 INFO - TinderboxPrint: Swap in / out
441,991,168 / 0 17:28:21 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 396204544; Write bytes: 389826048; Read time: 29555; Write time: 861 17:28:21 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 34750464; Write bytes: 300754432; Read time: 214; Write time: 1473 17:28:21 INFO - Running post-run listener: _upload_blobber_files 17:28:21 INFO - Blob upload gear active. 17:28:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:21 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 17:28:21 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:28:21 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:28:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:23 INFO - (blobuploader) - INFO - Done attempting. 17:28:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:28:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:24 INFO - (blobuploader) - INFO - Done attempting. 17:28:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:28:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:26 INFO - (blobuploader) - INFO - Done attempting. 17:28:26 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:26 INFO - Return code: 0 17:28:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/018489150426a1005a6c30f2fdf9f12e147c8e10917fd0161399485ef3f31caa3c9346ac2511130ab4145aa0df57e489b754445d2f6fe2dde6546ae7b24d188b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a8d229126cb415fcd64ab2cd6d69483a9b6f56400631110c5ef5d4919b859af62898171a6a479c73de19b895517900d80346170403a9a37365d5c6e08a31f66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66d887a7cf5aeb0262ce30b455ea8ff80530d911aa7f3b3daceb0f458408336e22827469de10f462bce06ab3a2d25104a4019d759fb8b617901258a01777e67"} 17:28:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:26 INFO - Contents: 17:28:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/018489150426a1005a6c30f2fdf9f12e147c8e10917fd0161399485ef3f31caa3c9346ac2511130ab4145aa0df57e489b754445d2f6fe2dde6546ae7b24d188b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a8d229126cb415fcd64ab2cd6d69483a9b6f56400631110c5ef5d4919b859af62898171a6a479c73de19b895517900d80346170403a9a37365d5c6e08a31f66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66d887a7cf5aeb0262ce30b455ea8ff80530d911aa7f3b3daceb0f458408336e22827469de10f462bce06ab3a2d25104a4019d759fb8b617901258a01777e67"} 17:28:26 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:26 INFO - Copying logs to upload dir... 17:28:26 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.915015 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-12 17:28:26.746340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 17:28:26.749805) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/018489150426a1005a6c30f2fdf9f12e147c8e10917fd0161399485ef3f31caa3c9346ac2511130ab4145aa0df57e489b754445d2f6fe2dde6546ae7b24d188b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a8d229126cb415fcd64ab2cd6d69483a9b6f56400631110c5ef5d4919b859af62898171a6a479c73de19b895517900d80346170403a9a37365d5c6e08a31f66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66d887a7cf5aeb0262ce30b455ea8ff80530d911aa7f3b3daceb0f458408336e22827469de10f462bce06ab3a2d25104a4019d759fb8b617901258a01777e67"} build_url:https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/eLURQTyjR6yPsLlSgJAeNA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/018489150426a1005a6c30f2fdf9f12e147c8e10917fd0161399485ef3f31caa3c9346ac2511130ab4145aa0df57e489b754445d2f6fe2dde6546ae7b24d188b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a8d229126cb415fcd64ab2cd6d69483a9b6f56400631110c5ef5d4919b859af62898171a6a479c73de19b895517900d80346170403a9a37365d5c6e08a31f66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c66d887a7cf5aeb0262ce30b455ea8ff80530d911aa7f3b3daceb0f458408336e22827469de10f462bce06ab3a2d25104a4019d759fb8b617901258a01777e67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 17:28:26.782366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:28:26.782684) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.evDl12ZbZ6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.iAcvRwC0FH/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004697 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 17:28:26.829971) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 17:28:26.830251) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 17:28:26.830544) ========= ========= Total master_lag: 0.17 =========