builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0241 starttime: 1487854865.49 results: success (0) buildid: 20170223030204 builduid: f8a1a2ec24c7498cb4c5b0cf0a6adc49 revision: 32dcdde1fc64fc39a9065dc4218265dbc727673f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:05.486242) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:05.486684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:05.486958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:05.576861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:05.577257) ========= 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.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 --2017-02-23 05:01:05-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.1M=0s 2017-02-23 05:01:06 (72.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.685575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:06.286127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:06.286647) ========= 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.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.029249 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:06.383791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 05:01:06.384193) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32dcdde1fc64fc39a9065dc4218265dbc727673f --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 32dcdde1fc64fc39a9065dc4218265dbc727673f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 2017-02-23 05:01:06,499 truncating revision to first 12 chars 2017-02-23 05:01:06,499 Setting DEBUG logging. 2017-02-23 05:01:06,499 attempt 1/10 2017-02-23 05:01:06,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32dcdde1fc64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 05:01:08,155 unpacking tar archive at: mozilla-central-32dcdde1fc64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.933892 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 05:01:08.340159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:08.340474) ========= script_repo_revision: 32dcdde1fc64fc39a9065dc4218265dbc727673f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:08.341365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:08.341631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 05:01:08.359385) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-23 05:01:08.359776) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:01:08 INFO - MultiFileLogger online at 20170223 05:01:08 in /builds/slave/test 05:01:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:01:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:08 INFO - {'append_to_log': False, 05:01:08 INFO - 'base_work_dir': '/builds/slave/test', 05:01:08 INFO - 'blob_upload_branch': 'Firefox', 05:01:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:08 INFO - 'branch': 'Firefox', 05:01:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:08 INFO - 'config_files': ('talos/mac_config.py',), 05:01:08 INFO - 'default_actions': ('clobber', 05:01:08 INFO - 'read-buildbot-config', 05:01:08 INFO - 'download-and-extract', 05:01:08 INFO - 'populate-webroot', 05:01:08 INFO - 'create-virtualenv', 05:01:08 INFO - 'install', 05:01:08 INFO - 'run-tests'), 05:01:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:08 INFO - 'download_minidump_stackwalk': True, 05:01:08 INFO - 'download_symbols': 'ondemand', 05:01:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:08 INFO - 'gecko_profile': False, 05:01:08 INFO - 'gecko_profile_interval': 0, 05:01:08 INFO - 'installer_path': 'installer.exe', 05:01:08 INFO - 'log_level': 'info', 05:01:08 INFO - 'log_name': 'talos', 05:01:08 INFO - 'log_to_console': True, 05:01:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:01:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:01:08 INFO - 'opt_config_files': (), 05:01:08 INFO - 'pip_index': False, 05:01:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:08 INFO - 'cmd': ('bash', 05:01:08 INFO - '-c', 05:01:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:08 INFO - 'enabled': True, 05:01:08 INFO - 'halt_on_failure': False, 05:01:08 INFO - 'name': 'check_screen_resolution'},), 05:01:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:01:08 INFO - 'cmd': ('bash', 05:01:08 INFO - '-c', 05:01:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:01:08 INFO - 'enabled': True, 05:01:08 INFO - 'halt_on_failure': False, 05:01:08 INFO - 'name': 'check_screen_resolution'},), 05:01:08 INFO - 'run_cmd_checks_enabled': True, 05:01:08 INFO - 'suite': 'dromaeojs', 05:01:08 INFO - 'system_bits': '32', 05:01:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:08 INFO - 'title': 't-yosemite-r7-0241', 05:01:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:08 INFO - 'use_talos_json': True, 05:01:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:08 INFO - 'work_dir': 'build'} 05:01:08 INFO - [mozharness: 2017-02-23 13:01:08.581610Z] Running clobber step. 05:01:08 INFO - Running pre-action listener: _resource_record_pre_action 05:01:08 INFO - Running main action method: clobber 05:01:08 INFO - rmtree: /builds/slave/test/build 05:01:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:10 INFO - Running post-action listener: _resource_record_post_action 05:01:10 INFO - [mozharness: 2017-02-23 13:01:10.850664Z] Finished clobber step (success) 05:01:10 INFO - [mozharness: 2017-02-23 13:01:10.850788Z] Running read-buildbot-config step. 05:01:10 INFO - Running pre-action listener: _resource_record_pre_action 05:01:10 INFO - Running main action method: read_buildbot_config 05:01:10 INFO - Using buildbot properties: 05:01:10 INFO - { 05:01:10 INFO - "project": "", 05:01:10 INFO - "product": "firefox", 05:01:10 INFO - "script_repo_revision": "production", 05:01:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:01:10 INFO - "repository": "", 05:01:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:01:10 INFO - "buildid": "20170223030204", 05:01:10 INFO - "stage_platform": "macosx64", 05:01:10 INFO - "basedir": "/builds/slave/test", 05:01:10 INFO - "nightly_build": "True", 05:01:10 INFO - "buildnumber": 3, 05:01:10 INFO - "slavename": "t-yosemite-r7-0241", 05:01:10 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:01:10 INFO - "platform": "yosemite_r7", 05:01:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:01:10 INFO - "branch": "mozilla-central", 05:01:10 INFO - "repo_path": "mozilla-central", 05:01:10 INFO - "revision": "32dcdde1fc64fc39a9065dc4218265dbc727673f", 05:01:10 INFO - "pgo_build": "False", 05:01:10 INFO - "builduid": "f8a1a2ec24c7498cb4c5b0cf0a6adc49", 05:01:10 INFO - "slavebuilddir": "test" 05:01:10 INFO - } 05:01:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 05:01:10 INFO - Running post-action listener: _resource_record_post_action 05:01:10 INFO - [mozharness: 2017-02-23 13:01:10.855172Z] Finished read-buildbot-config step (success) 05:01:10 INFO - [mozharness: 2017-02-23 13:01:10.855436Z] Running download-and-extract step. 05:01:10 INFO - Running pre-action listener: _resource_record_pre_action 05:01:10 INFO - Running main action method: download_and_extract 05:01:10 INFO - mkdir: /builds/slave/test/build/tests 05:01: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')]} 05:01:10 INFO - trying https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 05:01:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:01:11 INFO - Downloaded 1199 bytes. 05:01:11 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:01:11 INFO - Using the following test package requirements: 05:01:11 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:01:11 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:01:11 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:01:11 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'jsshell-mac.zip'], 05:01:11 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:01:11 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:01:11 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:01:11 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:01:11 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:01:11 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:01:11 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:01:11 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:01:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:01:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:01:11 INFO - Fetch https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:01:13 INFO - Expected file size: 51471076 05:01:13 INFO - Obtained file size: 51471076 05:01:29 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:01:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:01:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:01:29 INFO - Fetch https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:01:31 INFO - Expected file size: 51471076 05:01:31 INFO - Obtained file size: 51471076 05:01:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 05:01:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:01:47 INFO - Fetch https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:01:48 INFO - Expected file size: 14404319 05:01:48 INFO - Obtained file size: 14404319 05:01: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')]} 05:01:48 INFO - trying https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:01:48 INFO - Downloading https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:01:51 INFO - Downloaded 75006729 bytes. 05:01:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:01:51 INFO - mkdir: /builds/slave/test/properties 05:01:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:01:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:01:51 INFO - Contents: 05:01:51 INFO - build_url:https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:01:51 INFO - Running post-action listener: _resource_record_post_action 05:01:51 INFO - Running post-action listener: set_extra_try_arguments 05:01:51 INFO - [mozharness: 2017-02-23 13:01:51.758001Z] Finished download-and-extract step (success) 05:01:51 INFO - [mozharness: 2017-02-23 13:01:51.758111Z] Running populate-webroot step. 05:01:51 INFO - Running pre-action listener: _resource_record_pre_action 05:01:51 INFO - Running main action method: populate_webroot 05:01:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:01:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:01:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:01:51 INFO - '--tppagecycles', 05:01:51 INFO - '7'], 05:01:51 INFO - 'tests': ['tsvgm']}}, 05:01:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:01:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:01:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:01:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:01:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:01:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['damp', 'tps']}, 05:01:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'tests': ['damp', 'tps']}, 05:01:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['dromaeo_dom']}, 05:01:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:01:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['basic_compositor_video']}, 05:01:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:01:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'other-e10s': {'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['a11yr', 05:01:51 INFO - 'ts_paint', 05:01:51 INFO - 'tpaint', 05:01:51 INFO - 'sessionrestore', 05:01:51 INFO - 'sessionrestore_no_auto_restore', 05:01:51 INFO - 'tabpaint']}, 05:01:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['tsvgx', 05:01:51 INFO - 'tsvgr_opacity', 05:01:51 INFO - 'tart', 05:01:51 INFO - 'tscrollx', 05:01:51 INFO - 'cart', 05:01:51 INFO - 'tsvg_static']}, 05:01:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:01:51 INFO - 'tsvgr_opacity', 05:01:51 INFO - 'tart', 05:01:51 INFO - 'tscrollx', 05:01:51 INFO - 'cart', 05:01:51 INFO - 'tsvg_static']}, 05:01:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'talos_options': ['--disable-e10s'], 05:01:51 INFO - 'tests': ['tp5o']}, 05:01:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:01:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'talos_options': ['--disable-e10s', 05:01:51 INFO - '--xperf_path', 05:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:51 INFO - 'tests': ['tp5n']}, 05:01:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:01:51 INFO - 'talos_options': ['--xperf_path', 05:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:01:51 INFO - 'tests': ['tp5n']}}, 05:01:51 INFO - 'talos.zip': {'path': '', 05:01:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:01:51 INFO - Running post-action listener: _resource_record_post_action 05:01:51 INFO - [mozharness: 2017-02-23 13:01:51.776276Z] Finished populate-webroot step (success) 05:01:51 INFO - [mozharness: 2017-02-23 13:01:51.776407Z] Running create-virtualenv step. 05:01:51 INFO - Running pre-action listener: _resource_record_pre_action 05:01:51 INFO - Running main action method: create_virtualenv 05:01:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:01:51 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 05:01:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:01:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:01:51 INFO - Using real prefix '/tools/python27' 05:01:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:01:52 INFO - Installing distribute.............................................................................................................................................................................................done. 05:01:55 INFO - Installing pip.................done. 05:01:55 INFO - Return code: 0 05:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:01:55 INFO - Reading from file tmpfile_stdout 05:01:55 INFO - Output received: 05:01:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:01:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:01: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', 'pip>=1.5'] in /builds/slave/test/build 05:01: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 pip>=1.5 05:01:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:01:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:55 INFO - 'HOME': '/Users/cltbld', 05:01:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:55 INFO - 'LOGNAME': 'cltbld', 05:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:55 INFO - 'MOZ_NO_REMOTE': '1', 05:01:55 INFO - 'NO_EM_RESTART': '1', 05:01:55 INFO - 'PAGER': '/bin/cat', 05:01:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:55 INFO - 'PWD': '/builds/slave/test', 05:01:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:55 INFO - 'SHELL': '/bin/bash', 05:01:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:01:55 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:01:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:55 INFO - 'USER': 'cltbld', 05:01:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:55 INFO - 'XPC_FLAGS': '0x0', 05:01:55 INFO - 'XPC_SERVICE_NAME': '0', 05:01:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 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 05:01:56 INFO - Cleaning up... 05:01:56 INFO - Return code: 0 05:01:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:01:56 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')]} 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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')]} 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:56 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:01:56 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 05:01:56 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 05:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:56 INFO - 'HOME': '/Users/cltbld', 05:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:56 INFO - 'LOGNAME': 'cltbld', 05:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:56 INFO - 'MOZ_NO_REMOTE': '1', 05:01:56 INFO - 'NO_EM_RESTART': '1', 05:01:56 INFO - 'PAGER': '/bin/cat', 05:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:56 INFO - 'PWD': '/builds/slave/test', 05:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:56 INFO - 'SHELL': '/bin/bash', 05:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:01:56 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:56 INFO - 'USER': 'cltbld', 05:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:56 INFO - 'XPC_FLAGS': '0x0', 05:01:56 INFO - 'XPC_SERVICE_NAME': '0', 05:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:56 INFO - Downloading/unpacking psutil>=3.1.1 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:00 INFO - Installing collected packages: psutil 05:02:00 INFO - Running setup.py install for psutil 05:02:00 INFO - building 'psutil._psutil_osx' extension 05:02:00 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 05:02:01 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 05:02:01 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 05:02:01 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 05:02:01 INFO - building 'psutil._psutil_posix' extension 05:02:01 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 05:02:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:02:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:02:01 INFO - ^ 05:02:01 INFO - 1 warning generated. 05:02:01 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 05:02:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:01 INFO - Successfully installed psutil 05:02:01 INFO - Cleaning up... 05:02:01 INFO - Return code: 0 05:02:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:01 INFO - 'HOME': '/Users/cltbld', 05:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:01 INFO - 'LOGNAME': 'cltbld', 05:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:01 INFO - 'MOZ_NO_REMOTE': '1', 05:02:01 INFO - 'NO_EM_RESTART': '1', 05:02:01 INFO - 'PAGER': '/bin/cat', 05:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:01 INFO - 'PWD': '/builds/slave/test', 05:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:01 INFO - 'SHELL': '/bin/bash', 05:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:01 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:01 INFO - 'USER': 'cltbld', 05:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:01 INFO - 'XPC_FLAGS': '0x0', 05:02:01 INFO - 'XPC_SERVICE_NAME': '0', 05:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:04 INFO - Installing collected packages: mozsystemmonitor 05:02:04 INFO - Running setup.py install for mozsystemmonitor 05:02:04 INFO - Successfully installed mozsystemmonitor 05:02:04 INFO - Cleaning up... 05:02:05 INFO - Return code: 0 05:02:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:05 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:05 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 05:02:05 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 05:02:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:05 INFO - 'HOME': '/Users/cltbld', 05:02:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:05 INFO - 'LOGNAME': 'cltbld', 05:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:05 INFO - 'MOZ_NO_REMOTE': '1', 05:02:05 INFO - 'NO_EM_RESTART': '1', 05:02:05 INFO - 'PAGER': '/bin/cat', 05:02:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:05 INFO - 'PWD': '/builds/slave/test', 05:02:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:05 INFO - 'SHELL': '/bin/bash', 05:02:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:05 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:05 INFO - 'USER': 'cltbld', 05:02:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:05 INFO - 'XPC_FLAGS': '0x0', 05:02:05 INFO - 'XPC_SERVICE_NAME': '0', 05:02:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:05 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:05 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 05:02:05 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 05:02:05 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 05:02:05 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 05:02:05 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 05:02:05 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 05:02:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02: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 05:02:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:08 INFO - warning: no files found matching '*.txt' 05:02:08 INFO - no previously-included directories found matching 'build' 05:02:08 INFO - no previously-included directories found matching 'dist' 05:02:08 INFO - no previously-included directories found matching '.git*' 05:02:08 INFO - Installing collected packages: jsonschema, functools32 05:02:08 INFO - Running setup.py install for functools32 05:02:08 INFO - warning: no files found matching '*.txt' 05:02:08 INFO - no previously-included directories found matching 'build' 05:02:08 INFO - no previously-included directories found matching 'dist' 05:02:08 INFO - no previously-included directories found matching '.git*' 05:02:08 INFO - Successfully installed jsonschema functools32 05:02:08 INFO - Cleaning up... 05:02:08 INFO - Return code: 0 05:02:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02:08 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')]} 05:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 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')]} 05:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:08 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 05:02:08 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 05:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:08 INFO - 'HOME': '/Users/cltbld', 05:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:08 INFO - 'LOGNAME': 'cltbld', 05:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:08 INFO - 'MOZ_NO_REMOTE': '1', 05:02:08 INFO - 'NO_EM_RESTART': '1', 05:02:08 INFO - 'PAGER': '/bin/cat', 05:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:08 INFO - 'PWD': '/builds/slave/test', 05:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:08 INFO - 'SHELL': '/bin/bash', 05:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:08 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:08 INFO - 'USER': 'cltbld', 05:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:08 INFO - 'XPC_FLAGS': '0x0', 05:02:08 INFO - 'XPC_SERVICE_NAME': '0', 05:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:08 INFO - Cleaning up... 05:02:08 INFO - Return code: 0 05:02:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02:08 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')]} 05:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 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')]} 05:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:08 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:08 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 05:02:08 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 05:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:08 INFO - 'HOME': '/Users/cltbld', 05:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:08 INFO - 'LOGNAME': 'cltbld', 05:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:08 INFO - 'MOZ_NO_REMOTE': '1', 05:02:08 INFO - 'NO_EM_RESTART': '1', 05:02:08 INFO - 'PAGER': '/bin/cat', 05:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:08 INFO - 'PWD': '/builds/slave/test', 05:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:08 INFO - 'SHELL': '/bin/bash', 05:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:08 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:08 INFO - 'USER': 'cltbld', 05:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:08 INFO - 'XPC_FLAGS': '0x0', 05:02:08 INFO - 'XPC_SERVICE_NAME': '0', 05:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:13 INFO - Downloading docopt-0.6.1.tar.gz 05:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:13 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:13 INFO - Running setup.py install for blobuploader 05:02:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:13 INFO - Running setup.py install for requests 05:02:13 INFO - Running setup.py install for docopt 05:02:13 INFO - Successfully installed blobuploader requests docopt 05:02:13 INFO - Cleaning up... 05:02:14 INFO - Return code: 0 05:02:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:14 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:14 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 05:02:14 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 05:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:14 INFO - 'HOME': '/Users/cltbld', 05:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:14 INFO - 'LOGNAME': 'cltbld', 05:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:14 INFO - 'MOZ_NO_REMOTE': '1', 05:02:14 INFO - 'NO_EM_RESTART': '1', 05:02:14 INFO - 'PAGER': '/bin/cat', 05:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:14 INFO - 'PWD': '/builds/slave/test', 05:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:14 INFO - 'SHELL': '/bin/bash', 05:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:14 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:14 INFO - 'USER': 'cltbld', 05:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:14 INFO - 'XPC_FLAGS': '0x0', 05:02:14 INFO - 'XPC_SERVICE_NAME': '0', 05:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-pzUxT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-lQMi8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ZqCOf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-vA4S1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-xy7WF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-NHPlsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:14 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Fja6pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-A3mLcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Tw6lHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Ehwa92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-uiDzTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-v87wNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Q4Aasy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-0qz89l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-y0yQ2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Vu8WVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:15 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-gvWMay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:16 INFO - Running setup.py install for manifestparser 05:02:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:16 INFO - Running setup.py install for mozcrash 05:02:16 INFO - Running setup.py install for mozdebug 05:02:16 INFO - Running setup.py install for mozdevice 05:02:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:16 INFO - Running setup.py install for mozfile 05:02:16 INFO - Running setup.py install for mozhttpd 05:02:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:16 INFO - Running setup.py install for mozinfo 05:02:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Running setup.py install for mozInstall 05:02:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Running setup.py install for mozleak 05:02:17 INFO - Running setup.py install for mozlog 05:02:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Running setup.py install for moznetwork 05:02:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Running setup.py install for mozprocess 05:02:17 INFO - Running setup.py install for mozprofile 05:02:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:18 INFO - Running setup.py install for mozrunner 05:02:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:18 INFO - Running setup.py install for mozscreenshot 05:02:18 INFO - Running setup.py install for moztest 05:02:18 INFO - Running setup.py install for mozversion 05:02:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:18 INFO - Cleaning up... 05:02:18 INFO - Return code: 0 05:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:18 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:18 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 05:02:18 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 05:02:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:18 INFO - 'HOME': '/Users/cltbld', 05:02:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PAGER': '/bin/cat', 05:02:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test', 05:02:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:18 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - 'XPC_FLAGS': '0x0', 05:02:18 INFO - 'XPC_SERVICE_NAME': '0', 05:02:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:18 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-nr2tNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-CFQTI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-g_su2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Z1_m5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-fC3frc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-a0uH5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-zo5pQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Xk88Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-SSiZyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:19 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-tPoa2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:19 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-BH32F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:20 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-p1a1y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ePCmqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:20 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Z84BX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-4c5Z_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:20 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-KdaFDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 05:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:20 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-A6VPri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:20 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)) 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:20 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)) 05:02:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - Downloading blessings-1.6.tar.gz 05:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:23 INFO - Installing collected packages: blessings 05:02:23 INFO - Running setup.py install for blessings 05:02:23 INFO - Successfully installed blessings 05:02:23 INFO - Cleaning up... 05:02:23 INFO - Return code: 0 05:02:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:24 INFO - Reading from file tmpfile_stdout 05:02:24 INFO - Current package versions: 05:02:24 INFO - blessings == 1.6 05:02:24 INFO - blobuploader == 1.2.4 05:02:24 INFO - docopt == 0.6.1 05:02:24 INFO - functools32 == 3.2.3-2 05:02:24 INFO - jsonschema == 2.5.1 05:02:24 INFO - manifestparser == 1.1 05:02:24 INFO - mozInstall == 1.12 05:02:24 INFO - mozcrash == 1.0 05:02:24 INFO - mozdebug == 0.1 05:02:24 INFO - mozdevice == 0.49 05:02:24 INFO - mozfile == 1.2 05:02:24 INFO - mozhttpd == 0.7 05:02:24 INFO - mozinfo == 0.9 05:02:24 INFO - mozleak == 0.1 05:02:24 INFO - mozlog == 3.4 05:02:24 INFO - moznetwork == 0.27 05:02:24 INFO - mozprocess == 0.25 05:02:24 INFO - mozprofile == 0.28 05:02:24 INFO - mozrunner == 6.13 05:02:24 INFO - mozscreenshot == 0.1 05:02:24 INFO - mozsystemmonitor == 0.3 05:02:24 INFO - moztest == 0.8 05:02:24 INFO - mozversion == 1.4 05:02:24 INFO - psutil == 3.1.1 05:02:24 INFO - requests == 1.2.3 05:02:24 INFO - wsgiref == 0.1.2 05:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:24 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')]} 05:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:24 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')]} 05:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:24 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:24 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 05:02:24 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 05:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:24 INFO - 'HOME': '/Users/cltbld', 05:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:24 INFO - 'LOGNAME': 'cltbld', 05:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:24 INFO - 'MOZ_NO_REMOTE': '1', 05:02:24 INFO - 'NO_EM_RESTART': '1', 05:02:24 INFO - 'PAGER': '/bin/cat', 05:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:24 INFO - 'PWD': '/builds/slave/test', 05:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:24 INFO - 'SHELL': '/bin/bash', 05:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:24 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:24 INFO - 'USER': 'cltbld', 05:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:24 INFO - 'XPC_FLAGS': '0x0', 05:02:24 INFO - 'XPC_SERVICE_NAME': '0', 05:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 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)) 05:02:24 INFO - Cleaning up... 05:02:24 INFO - Return code: 0 05:02:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:24 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')]} 05:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:24 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')]} 05:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:24 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 0x10c7feb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c801768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33845f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, '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.nbGLzhv8JA/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.ci4oVgQODx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 05:02:24 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 05:02:24 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 05:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:24 INFO - 'HOME': '/Users/cltbld', 05:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:24 INFO - 'LOGNAME': 'cltbld', 05:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:24 INFO - 'MOZ_NO_REMOTE': '1', 05:02:24 INFO - 'NO_EM_RESTART': '1', 05:02:24 INFO - 'PAGER': '/bin/cat', 05:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:24 INFO - 'PWD': '/builds/slave/test', 05:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:24 INFO - 'SHELL': '/bin/bash', 05:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:24 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:24 INFO - 'USER': 'cltbld', 05:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:24 INFO - 'XPC_FLAGS': '0x0', 05:02:24 INFO - 'XPC_SERVICE_NAME': '0', 05:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:24 INFO - Cleaning up... 05:02:24 INFO - Return code: 0 05:02:24 INFO - Running post-action listener: _resource_record_post_action 05:02:24 INFO - Running post-action listener: _start_resource_monitoring 05:02:24 INFO - Starting resource monitoring. 05:02:24 INFO - [mozharness: 2017-02-23 13:02:24.578995Z] Finished create-virtualenv step (success) 05:02:24 INFO - [mozharness: 2017-02-23 13:02:24.579934Z] Running install step. 05:02:24 INFO - Running pre-action listener: _resource_record_pre_action 05:02:24 INFO - Running main action method: install 05:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:24 INFO - Reading from file tmpfile_stdout 05:02:24 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:24 INFO - Reading from file tmpfile_stdout 05:02:24 INFO - Output received: 05:02:24 INFO - Usage: mozinstall [options] installer 05:02:24 INFO - Options: 05:02:24 INFO - -h, --help show this help message and exit 05:02:24 INFO - -d DEST, --destination=DEST 05:02:24 INFO - Directory to install application into. [default: 05:02:24 INFO - "/builds/slave/test"] 05:02:24 INFO - --app=APP Application being installed. [default: firefox] 05:02:24 INFO - mkdir: /builds/slave/test/build/application 05:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:02:45 INFO - Reading from file tmpfile_stdout 05:02:45 INFO - Output received: 05:02:45 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:02:45 INFO - Running post-action listener: _resource_record_post_action 05:02:45 INFO - [mozharness: 2017-02-23 13:02:45.214614Z] Finished install step (success) 05:02:45 INFO - [mozharness: 2017-02-23 13:02:45.214779Z] Running run-tests step. 05:02:45 INFO - Running pre-action listener: _resource_record_pre_action 05:02:45 INFO - Running main action method: run_tests 05:02:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:45 INFO - 2017-02-23 05:02:45.229 screenresolution[1632:9785] starting screenresolution argv=screenresolution get 05:02:45 INFO - 2017-02-23 05:02:45.232 screenresolution[1632:9785] Display 0: 1600x1200x32@60 05:02:45 INFO - 2017-02-23 05:02:45.237 screenresolution[1633:9788] starting screenresolution argv=screenresolution list 05:02:45 INFO - Available Modes on Display 0 05:02:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:45 INFO - Intel Iris: 05:02:45 INFO - Chipset Model: Intel Iris 05:02:45 INFO - Type: GPU 05:02:45 INFO - Bus: Built-In 05:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:45 INFO - Vendor: Intel (0x8086) 05:02:45 INFO - Device ID: 0x0a2e 05:02:45 INFO - Revision ID: 0x0009 05:02:45 INFO - Displays: 05:02:45 INFO - Display: 05:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:45 INFO - Display Serial Number: 1600x1200 60 05:02:45 INFO - Main Display: Yes 05:02:45 INFO - Mirror: Off 05:02:45 INFO - Online: Yes 05:02:45 INFO - Rotation: Supported 05:02:45 INFO - Return code: 0 05:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:45 INFO - Python 2.7.3 05:02:45 INFO - Return code: 0 05:02:45 INFO - grabbing minidump binary from tooltool 05:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:45 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 0x10c5dcd30>, '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 0x10c503db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5d1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:45 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 05:02:45 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 05:02:45 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 05:02:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:45 INFO - Return code: 0 05:02:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:02:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:45 INFO - ENV: RUST_BACKTRACE is now 1 05:02:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:02:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nbGLzhv8JA/Render', 05:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:02:45 INFO - 'HOME': '/Users/cltbld', 05:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:02:45 INFO - 'LOGNAME': 'cltbld', 05:02:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:45 INFO - 'MOZ_NO_REMOTE': '1', 05:02:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:45 INFO - 'NO_EM_RESTART': '1', 05:02:45 INFO - 'PAGER': '/bin/cat', 05:02:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:45 INFO - 'PWD': '/builds/slave/test', 05:02:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:02:45 INFO - 'RUST_BACKTRACE': '1', 05:02:45 INFO - 'SHELL': '/bin/bash', 05:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ci4oVgQODx/Listeners', 05:02:45 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 05:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:02:45 INFO - 'USER': 'cltbld', 05:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:45 INFO - 'XPC_FLAGS': '0x0', 05:02:45 INFO - 'XPC_SERVICE_NAME': '0', 05:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:02:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:02:45 INFO - mozversion application_buildid: 20170223030204 05:02:45 INFO - mozversion application_changeset: 32dcdde1fc64fc39a9065dc4218265dbc727673f 05:02:45 INFO - mozversion application_display_name: Nightly 05:02:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:45 INFO - mozversion application_name: Firefox 05:02:45 INFO - mozversion application_remotingname: firefox 05:02:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:02:45 INFO - mozversion application_vendor: Mozilla 05:02:45 INFO - mozversion application_version: 54.0a1 05:02:45 INFO - mozversion platform_buildid: 20170223030204 05:02:45 INFO - mozversion platform_changeset: 32dcdde1fc64fc39a9065dc4218265dbc727673f 05:02:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:02:45 INFO - mozversion platform_version: 54.0a1 05:02:45 INFO - using testdate: 1487854965 05:02:45 INFO - actual date: 1487854965 05:02:45 INFO - starting webserver on 'localhost:49246' 05:02:45 INFO - SUITE-START | Running 2 tests 05:02:45 INFO - TEST-START | dromaeo_css 05:02:45 INFO - operating with platform_type : mac_ 05:02:45 INFO - Initialising browser for dromaeo_css test... 05:02:45 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpsH1449/profile http://localhost:49246/getInfo.html) 05:02:48 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:02:48 INFO - PROCESS | 1643 | colorDepth:24 05:02:48 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:02:48 INFO - PROCESS | 1643 | __metrics 05:02:48 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:02:48 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:02:49 INFO - TEST-INFO | 1643: exit 0 05:02:49 INFO - Browser initialized. 05:02:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:02:49 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpsH1449/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:01 INFO - PROCESS | 1647 | RSS: Main: 232304640 05:03:01 INFO - PROCESS | 1647 | 05:06:05 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 05:06:07 INFO - PROCESS | 1647 | RSS: Main: 440954880 05:06:07 INFO - PROCESS | 1647 | 05:07:51 INFO - PROCESS | 1647 | ************************* 05:07:51 INFO - PROCESS | 1647 | A coding exception was thrown and uncaught in a Task. 05:07:51 INFO - PROCESS | 1647 | 05:07:51 ERROR - PROCESS | 1647 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:07:51 INFO - PROCESS | 1647 | Full stack: 05:07:51 INFO - PROCESS | 1647 | ************************* 05:09:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 05:09:11 INFO - PROCESS | 1647 | RSS: Main: 380043264 05:09:11 INFO - PROCESS | 1647 | 05:12:13 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 05:12:14 INFO - PROCESS | 1647 | RSS: Main: 348327936 05:12:14 INFO - PROCESS | 1647 | 05:15:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 05:15:17 INFO - PROCESS | 1647 | RSS: Main: 349028352 05:15:17 INFO - PROCESS | 1647 | 05:18:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 05:18:21 INFO - PROCESS | 1647 | RSS: Main: 343248896 05:18:21 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 05:21:25 INFO - PROCESS | 1647 | RSS: Main: 471781376 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | __start_tp_report 05:21:25 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 05:21:25 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 05:21:25 INFO - PROCESS | 1647 | |i|pagename|runs| 05:21:25 INFO - PROCESS | 1647 | |0;dojo.html;3329.084501762016;3341.582302212225;3359.009092317766;3369.326134773046;3401.7448691348154;5483.314585676791;5544.1960915667205;5660.8301750947485;5681.005823980808;5863.355030946598;5537.390887002426;5579.442055794419;5593.272874526316;5600.887982240352;5601.663900165993;5073.873153171164;5080.745962701869;5107.208382700687;5110.310108135392;5156.458571849958;5175.896482070356;5187.610929180308;5190.974045129769;5194.688318700871;5200.271961925334;5166.147585648364;5168.431472538018;5169.353830771153;5173.327467429229;5178.896422071575;5188.014277287322;5200.699825043739;5207.114790485626;5208.895822083575;5209.6874187548865;5028.245763135523;5148.665336753099;5162.74186290684;5167.224916262553;5168.689878607258;5676.290463692038;5741.770329186827;5759.424057594249;5762.106873434583;5769.826905192851;6205.782797602107;6209.5032397408095;6210.192674952273;6224.346443623445;6226.377362263737;5036.622253331015;6093.329733729286;6109.951287404306;6114.510839132859;6136.110264011693;4748.833790817304;5395.352557693062;5664.40523745005;5724.1413787931315;5837.182794408786;6226.941419958618;6254.21822272216;6264.310925798159;6270.59241149333;6274.498040156776;6161.7535298588455;6164.506839452833;6173.259208894961;6179.752809887644;6192;5350.785968561292;5997.010493268562;6049.758009679564;6119.99004232014;6140.754369825157;5917.7928772493615;6064.241969753781;6065.393460653988;6078.149059131725;6084.908726369108;6064.636121832616;6099.2985806632805;6100.254632272244;6109.495762817132;6128.78549250783;4860.854174374775;4872.488388719134;4876.366072410564;4877.853664390074;4880.95119048805;3426.623071462137;4344.044310251739;4359.38968544404;4418.182636212311;4452.354408610798;5773.191753154561;5776.191333213354;5778.855528611818;5779.855503612359;5808.912866307009;6270.498360131179;6278.121063051177;6294.339094395023;6298.212723409574;6310.0534919761485;5578;5615.803446879339;5626.521745651584;5790.247267855236;5811.535077193899;5331.280277162534;5333.7866485340155;5338.439463856317;5341.172118321589;5347.625666203407;6199.287081985539;6304.747810087545;6307.653079080603;6323.683815809191;6324.146240257598;6104.755809767559;6114.449699526886;6130.275842464065;6154.969225153845;6245.500359971101;6261.56169068179;6265.248170219603;6266.968665156645;6270.184875966095;6274.623522588659;5417.3378676689745;6207.193064901534;6208.192934918432;6209.130721699056;6221.502279817513;5063.316452278895;6048.7278072487725;6114.174586430775;6282.874342513215;6303.842403939938;5177.404598471224;5975.103734439869;5977.970110149421;5978.850528736642;5982.730777115127;5944.732487038007;5969.940300597113;6016.639001659914;6032.366601506954;6064.363241859542;4296.699231053921;4470.8435204767675;5862.915360658121;5903.144044113666;5917.881642367214;6112.5412656287845;6147;6154.015357542772;6155.47678447337;6161.353057929032;5945.375735547878;5949.6430214187285;5961.672108034099;5965.224520812267;5992.370801065826 05:21:25 INFO - PROCESS | 1647 | |1;ext.html;433.89803396201887;459.9168957106013;463.849248994077;486.68608747357956;502.7863158157783;27153.59269610955;29351.945363824514;29380.70619293809;29457.558136627915;40182.799086004605;40912.77261682147;43430;43601.78199109008;43613;43699;9142.725718228447;9355.204807591328;9357.391769534992;9365.48489833059;9366.578503967337;7349.669264883067;7606.277403646644;9078.45529268246;9204.539773011356;9229.446233226028;7549.811254718621;7606.885896711526;7641.808954776119;10890.727731806728;11250.212485126045;11190.888091119106;11242.550297988071;11245.943770281096;11256.774864502746;11261.943690281578;9245.445273283625;11099.167562432769;11103.056240219592;11126.554937802479;11140.387278699669;27998.44003119926;28701.56947645787;28714.856425717946;39301.60698393008;39730.404043939365;3106.642736085334;3700.6299370063048;3756.267527832074;3788.3370410178386;3916.8445308634023;28827.56758648622;28936.565951510533;29105.272368190752;29893.70106298931;30556.388872222433;3086.9845650771604;3260.7065364117343;3273.8035717857006;3273.9508907366408;3302.256992176741;445460;446818.76590617164;446862;447311;456002;62132;62471;62477;62543.6872815633;62732.05901911475;64456.67771661111;65295.67352163209;65472.03583892491;65525.34474655193;65678.67160664166;15336.693266134838;15561.066336019874;15576.299066542033;15622.921885390728;15655.295511702001;11884.286942783461;11965.40172991347;11967;11970.581029664094;11996.400179990966;16348.509544713677;17267.91366043162;17302.480925572254;17302.567435814206;17535.64928701419;6614.636195009224;6639.136912201479;6641.103451034145;6686.899696504556;6693.497987650946;775.4378075895044;852.4885068958699;861.4831101339272;874.1346067393235;882.7748924024332;25512;29001.019621496773;29330;29443.558346624817;29751.851240743657;946.186279799372;990.3760630802549;997.1972562087444;1053.5311786255197;1177.9469923853276;14768.556943291718;14889.70220595582;14950.551483455514;15143.697126057417;15298.311575979107;588742;593429;594869;594907;595993;58901;59181.70409147927;59270.11094833581;59419.108713369336;59483;1326.4296352568294;1383.6125884752284;1384.0934188107008;1392.1090502078678;1392.7423426666098;27531.862340688167;28299;28718.569221461275;28763.28091797722;28779.712202877705;49820;50151.49848501614;50212.748936255084;50233;50350.2447463281;469151;471710;472060;473228.6338568285;473953;37043.62956370402;38018.057652505;38041;38209.04477388087;38314;42745.931351716456;43281.783591083105;44206;44797;45232.77383613061;34341;34987.82506087453;35297.52888302317;36297.81851090727;36755.63244367629;31001.555164746213;31581.526277105404;32472;33705.494417583264;37052.62947370492;34698.826505867306;35427.46858797069;36419.63580364163;36447.27105457929;36472.27055458929;26800.731992679823;29771.553426698185;31932.8403357991;32053;32098.67901320957;23337.533249334578;23493.647595286428;23836.642450363604;23910.88044559766;23962.760372396053 05:21:25 INFO - PROCESS | 1647 | |2;jquery.html;322.646497941137;336.9090345606686;384.42528420012087;395.9524857017158;415.6010230179028;13473.528426505074;13630.386632601532;14594.927025364872;20641.896790516028;21237.57524849506;17929.820701792978;18454.16956236969;20203.090860911256;21280.255191068314;21386.786132138674;5849.9707501462435;6125.234345706786;6130.2643682758135;6132.662703551303;6133.325334213233;4368.0390314131;6059.697015149247;6083.330833608299;6098.329183789801;6120.26556813183;5775.018246898037;6068.362821903703;6071.967765479879;6072.240969878765;6078.331383547807;5916.526677865761;5926.199963004982;5959.702014899238;5964.97017514914;5995.400459953991;5032.094223039851;5170.06122703986;5218.843434696965;5228.5555727763185;5267.209918512215;23323.4169145771;25420.745792542024;25765;26071;26267.080652177272;2548.490301939601;2573.768360847514;2594.299539124445;2621.5936529837904;2628.1195799407224;10236.74408139795;10576.894231057668;10780.188570943676;13580.86419135806;14000.87992960571;1719.4841547535689;1729.6713624411323;1740.225599608175;1742.268247336122;1754.7104727719911;128483;132479;133025;134006.65993340136;135262;9596.376235544667;11699.181057326075;11845;11872.88127118735;12049.277043377426;15578.298976546082;15614.843851561565;15616.921915390578;15642;15647.765283520755;8218.424710270223;8413.873791893126;8428.072911979678;8514.48913065218;8559.26103646827;8037.557934313669;8058.234467725557;8235.95882020586;8243.381746369047;8266.586670666442;4594.563516465931;4685.929711054337;4689.788959496831;4712.88217794551;4892.657513973988;1953.5702145527962;2000.7295367441488;2006.8795872247713;2012.3459875540507;2013.3054096336741;1026.5431882812227;1027.814993301198;1041.1098510773331;1052.4959614679456;1055.6252530351614;18776.342828001227;18914.959677217885;21256.468588285108;21304.36086917364;21321.573568528853;980.2109302011949;994.6369575105034;1015.2639336480992;1047.1675018360422;1061.580675633136;10601.734956626146;10678.839817402744;11013.176282691284;11111.999920007238;11117.55529778816;561031;565299.1735041299;570336;725887;727808;96453;144806;152250.23874880554;153290.70063948826;158321;1009.6718566465928;1018.3177271228295;1065.2064212161988;1068.086785798147;1070.4915165296422;18887.150078246235;19173.90413047926;19449.8055019448;19461;19462.902685486482;54018.459815401344;55426.72286638541;55787.72106139443;55810.88378232494;55969.444125042595;80990.19009809826;81374.59312703398;81385;81599.18400815917;81698;8014.438989270929;8132.430729848854;8296.211859873303;8304.211099945496;8603.483790972561;10717.624883129052;10882.29265097766;12630.557930472389;13192.955091960377;13443.731125377633;9249.30630202724;10625.574977000833;11014.944925275322;11104.056155226895;11262.943685281522;9974.052465015811;10049;10426.218033647356;10622.36265824053;11016.228863979444;11099.445027748741;11313.983535844985;11349.7085845104;11440.027597654293;11585.362805045803;8059.194080591894;8273.917260827555;8291.83416331658;8411.242988131098;8607.784805379915;8959.328050396116;10729.46352682347;11017.11863050938;11086.445677715921;11164.776704466027 05:21:25 INFO - PROCESS | 1647 | |3;mootools.html;1249.175544140867;1256.484841215101;1419.3045407750199;1440.7190597833423;1444.3500424808833;7333.046703928489;7681.846363072736;8226.83546329073;8466.66133354665;8475.91524084759;8379.162083791618;8484.787880302996;8489.363297752663;8490.6179221935;8491.830163396744;2209.1826024371007;2253.785890340415;2255.030336955109;2256.5599708056934;2258.5369999150216;1967.301607929186;2025.230412443277;2035.847311451647;2048.7336646236045;2050.3028970150144;2004.7093171490126;2197.0333053456507;2272.6591011348264;2276.8633881967053;2295.7015587973624;2276.897539610713;2285.8628482291033;2286.474110954473;2287.2109122352763;2287.897044632979;2057.9382618521468;2192.2217612747404;2195.7913998170147;2302.0791683326634;2312.664663623765;8472.78818029548;8520.318374530023;8523.95738021306;8550.144985501462;8564.015138259118;5055.5702765265;5227.66020208689;5228.8692782680355;5234.92147617786;5235.188545775411;3235.530848027023;3407.16524451511;3422.2984288221105;3479.9478007829903;3483.2511010132944;1187.3825610682397;1202.7774861650535;1206.6681662542783;1269.1306455078209;1274.222724138275;10774.084202842767;10879.673609791718;10893.618723344724;10899.727506812314;10913.563457461612;4371.956280437155;4656.115338085753;4700.2009658358165;4729;4740.4311482621615;9530;9547.856782148274;9550.665726699672;9578.952105239428;9585.808283834283;5260.947390526046;5265.262863199156;5272.657277276965;5275.947240527622;5291.470852914677;4606.401167848226;4651.604613607814;4677.4854765975715;4778.1638213312535;4792.353032340589;3345.5985281765857;3720.7581507201944;3780.8487660493274;3848.1534062506203;3858.2862170498547;982.1995074014656;1153.1236260441956;1168.9590864319707;1169.0939521870619;1172.2204733852063;733.4081238293418;858.3862538285156;867.3624885708999;889.9320815021999;946.9289803264783;5217.739113044333;5281.815136470205;5359.115745901882;5550.72246387679;5553.666779993213;981.8723565936383;985.2856678907734;990.5592011554933;1033.4987531047436;1043.3635482355758;3515.3672338978718;3518.82405879705;3549.396602577568;3596.1908570571413;3683.355412802749;9536.856947145798;10038.498075096217;10044.648437304806;10050.346727462691;10061.949690251502;9964.850527242097;9973.451460169616;9978.650747223957;9981.951895051061;9986.30095893295;7793.688252469951;7874.251946065;7890.368770498347;7894.289513943658;7919.247671471201;5128.333316668958;5383.40782513931;5487.6158668892795;5493.2034854946605;5516.862078447911;8876;9385.530723463937;9386.389884657476;9390.201832844285;9390.436573805593;8873.556322183736;9314.6274149036;9331.580078896603;9471.66849160276;9493.24054075686;7155.713771449084;7309.853802924018;7324.743633972786;7329.083864516935;7338.669759860926;6606.6036037837885;7974;7983.72056978003;7989.041315042232;8001.439899207;6891.310868913069;7026.191987921455;7049.894251586128;7248.347648711641;7268.309510596485;6408.1349017881985;7105.18290396611;7121.857562848818;7156.069710937545;7176.7846964591145;5369.892602148013;6335.461485773761;6390.265119511316;6486.221653401433;6489.8702025960165;4546.249868771748;4695.9530404695515;4878.9512104878495;4905.386826646669;4933.901321973469;3467.8266086696067;4976.576990955809;5051.949480505148;5114.590832733446;5192.740362981911 05:21:25 INFO - PROCESS | 1647 | |4;prototype.html;349.8705478972781;359.3746880428054;361.5372323426014;366.6883149323077;368.6737237544772;4389.539098394671;4825.573842571774;5066.974665126674;5103.642745007851;5124.128898087325;4351.390805287262;4403.515613282536;5035.949640503594;5076.263941728447;5117.437081920985;3705.3511187521494;3807;3904.472896159025;3914.9804250978705;3952.861649842256;3395.405803984293;3851.8844434667003;3853.133045064852;3896.5129358830145;3907.101366685664;3274.476083826576;3387.508811222371;3858.649472684552;3862.613738626143;3869.7678139311593;3182.204448887778;3347.3472672828807;3717.070732316921;3873.2640798248244;3888.3389823730035;2655.893764249447;2828.5332920068163;3304.322613864152;3320.3857286401853;3341.496326653016;3909.9609003910164;4881.755912204376;4898.951010489885;4927.285543596158;4957.330760347343;4375.840402293363;4394.846180383671;4406.867793966154;4409.735415875058;4410.29435290352;4662.277347011219;5053.595712343041;5199.220116982445;5266.499682530153;5368.32895888014;3640.5995340512522;3653.5433070866143;3660.4509323601405;3675.4854320394898;3685.649863262986;5245.26566280721;5409.756560954727;5457.645253058538;5563.638363506399;5682.232898558683;3037.6202974628172;3146.3707258548384;3538.168530395355;3576.5350504434778;3604.1530240393486;3740.738148329591;3741.4659989404213;3743.794091325003;3746.363118269846;3755.8497660093835;4320.848770293024;4335.653147748172;4350.0647360817575;4354.412154359185;4356.956430435655;4083.6324730773777;5019.272205530251;5259.973700131475;5329.786808527693;5360.544353729977;1113.8663360396642;1133.7868480725708;1187.7980743273665;1198.6224339333082;1211.4790640024873;802.827392110699;828.5443006346605;838.3837879158814;841.9960494024183;842.7556008757392;4033.3664865729424;4311.09467011931;4730.716157030521;4776.402949631296;4806.711597304103;4896.898197905442;5012.248162775612;5214.582833373321;5218.66078704883;5235.345581802275;4161.62545370912;4358.607725304738;4771.971911937413;4774.880627984328;4811.941372897957;2174.3911704722705;2237.5567758795487;2553.348896031537;2572.9450925120987;2777.1668499450084;4294.871153865389;4868.391451068616;4936.8765780855765;5426.186072089139;5490.203920431595;4515.322701594721;4920.261960705922;5095.694258344512;5342;5344.412114667383;5290.788368465295;5318.282031925641;5425.864353391197;5436.864078398072;5461;4714.858554243378;5272.9736351318;5432.674039557639;5474.2609747683555;5487.832306239093;5120.513551212629;5393.244945707683;5394.784208631768;5402.028259685108;5457.263269458573;4599.356090147315;4840.95159048405;5101.9489805101475;5326.927302874648;5361.68638683525;2906.549484829855;3130.3426280481353;3215.3408551247408;3260.3805276997296;3554.5556805399324;4576.565226303496;4978.402591688876;4993.400791904995;5446.400895901527;5484.040292948638;4389.40742999691;4490.483594386687;4744.857654270378;4892.339534162842;5257.7371131442505;4658.650601204856;4662.510436404129;4747.477777444547;5202.869928251824;5255.3168088148295;4947.975260123676;5128.640825220291;5179.637425380187;5196.168613021899;5227.947720522899;4893.7063776173545;5165.509276618715;5249.7112658804135;5303.337082864642;5306.54894333986;4110.116324990141;4378.496472905656;4920.286558449076;5146.536811686966;5183.81856635016 05:21:25 INFO - PROCESS | 1647 | |5;yui.html;712.896629988652;743.8326376565274;762.6796745366945;805;813.8697808350665;14187.64530886727;14657.926710366433;14666.633334166638;14668.486602968898;14674.339654715537;12309.936262462792;12658.303793291365;13615.25116118613;13711.108777929428;13711.794323085162;870.8824308718321;873.6243415331405;894.8299823033602;897.3270047464401;897.6723495923974;906.8277027364779;907.7412937312868;910.3718434280358;912.4753266871543;914.2457472585111;851.2296371783515;907.732218995398;919.1589695428675;944.8299306124894;950.8906475755308;935.4854829843592;944.5466176235411;946.8059047895234;946.9100435458621;947.5309721687809;701.0605788243778;702.596007295807;703.4688809948456;704.0389867830374;706.2372637551483;14848;15120.39518419262;15254.313555890012;15288.464903728427;15305;13714.588562343046;13867.4453021879;13873.37569809361;13954.893174559887;14159.292035398188;10477.63328283514;10592.629257975934;10596.470176491144;10632.043116119508;11023.779524409547;3135.2318681922848;3616.059824445637;3680.6687398134027;3795.525559305087;3798.2403519295976;103975.4801225989;104215;104822.42766358434;104864;106694.46652766687;9151.725448236564;10620.734481638021;10884.129269658408;10978.615748448767;11145.888541114486;20319.39041828718;21413.464663383227;21576.676349854766;22074.11703531873;22082.558348832932;7689.231076892378;7778.727744528915;7855.175206603224;7972.043354797345;8052.355811535181;4038.1519880825354;4052.3516237401873;4110.77390743512;4126.958730412717;4204.663626909901;3613;3709.684676802502;3721.3859713147026;3722.590515043343;3724.65912271582;674.5244602555186;680.6303531328881;681.6659836679991;709.8970649255829;713.2119008495641;641.9279802729453;657.789507357641;664.6495709538198;678.9927943621874;751.2862780358681;7676.731314404081;8463.74608761738;9273.489958052372;9548.761280968032;9862.556184971694;636.4526507203801;657.904573932028;679.7145199016425;721.538215542043;721.6067243352386;4358.820227230904;4741.312509686076;4742.596879265301;4748.928766068511;4841.95158048415;83099.92250193794;96828.51585742027;97088;99956;100835.49582252042;50310.74844625754;57802.13296800551;66537.33462665312;66829.66585167043;80307;54349.48890897722;59302;73383.16542086384;76462.8530572053;77885.61057194791;9217.939936907072;9730.318877678777;10237;10262.58949642006;10310.484475776331;42742.87085549754;43442.52870690185;43474;44199.13809481019;49150;57989.710051449474;61518.69240653947;63251.683741581;63371.366286336546;63977.36022639714;12480.135502030183;12616.243025418504;12822.102452828585;13118.409671564994;13245.470181192644;14107.717845642825;14283.642908926944;14376.712465750836;14400.567982960529;14400.855991439952;13268.734625307632;13358.933205333911;13406.865931340952;13430.127041742255;13539.729205416033;13249.735005300034;13412.530561430303;13448.967704355673;13656.317184140951;14082.859171408154;12896.355182241037;13095.626551174973;13125.60623181306;13370.264635445144;13689.86310136886;10261.507419813075;10520.631777887736;10739.988377925833;10833.187510936868;11149.007994966265;9783;10466.529006194587;11263.718407039889;11305.773884522428;11337.433128343715 05:21:25 INFO - PROCESS | 1647 | __end_tp_report 05:21:25 INFO - PROCESS | 1647 | __start_cc_report 05:21:25 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2253 05:21:25 INFO - PROCESS | 1647 | __end_cc_report 05:21:25 INFO - PROCESS | 1647 | __startTimestamp1487856085601__endTimestamp 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | ------- Summary: start ------- 05:21:25 INFO - PROCESS | 1647 | Number of tests: 6 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5646.92 Median:5863.36 stddev:669.49 (11.4%) stddev-sans-first:646.38 05:21:25 INFO - PROCESS | 1647 | Values: 3329.1 3341.6 3359.0 3369.3 3401.7 5483.3 5544.2 5660.8 5681.0 5863.4 5537.4 5579.4 5593.3 5600.9 5601.7 5073.9 5080.7 5107.2 5110.3 5156.5 5175.9 5187.6 5191.0 5194.7 5200.3 5166.1 5168.4 5169.4 5173.3 5178.9 5188.0 5200.7 5207.1 5208.9 5209.7 5028.2 5148.7 5162.7 5167.2 5168.7 5676.3 5741.8 5759.4 5762.1 5769.8 6205.8 6209.5 6210.2 6224.3 6226.4 5036.6 6093.3 6110.0 6114.5 6136.1 4748.8 5395.4 5664.4 5724.1 5837.2 6226.9 6254.2 6264.3 6270.6 6274.5 6161.8 6164.5 6173.3 6179.8 6192.0 5350.8 5997.0 6049.8 6120.0 6140.8 5917.8 6064.2 6065.4 6078.1 6084.9 6064.6 6099.3 6100.3 6109.5 6128.8 4860.9 4872.5 4876.4 4877.9 4881.0 3426.6 4344.0 4359.4 4418.2 4452.4 5773.2 5776.2 5778.9 5779.9 5808.9 6270.5 6278.1 6294.3 6298.2 6310.1 5578.0 5615.8 5626.5 5790.2 5811.5 5331.3 5333.8 5338.4 5341.2 5347.6 6199.3 6304.7 6307.7 6323.7 6324.1 6104.8 6114.4 6130.3 6155.0 6245.5 6261.6 6265.2 6267.0 6270.2 6274.6 5417.3 6207.2 6208.2 6209.1 6221.5 5063.3 6048.7 6114.2 6282.9 6303.8 5177.4 5975.1 5978.0 5978.9 5982.7 5944.7 5969.9 6016.6 6032.4 6064.4 4296.7 4470.8 5862.9 5903.1 5917.9 6112.5 6147.0 6154.0 6155.5 6161.4 5945.4 5949.6 5961.7 5965.2 5992.4 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:64203.67 Median:20372.13 stddev:135630.37 (665.8%) stddev-sans-first:135926.34 05:21:25 INFO - PROCESS | 1647 | Values: 433.9 459.9 463.8 486.7 502.8 27153.6 29351.9 29380.7 29457.6 40182.8 40912.8 43430.0 43601.8 43613.0 43699.0 9142.7 9355.2 9357.4 9365.5 9366.6 7349.7 7606.3 9078.5 9204.5 9229.4 7549.8 7606.9 7641.8 10890.7 11250.2 11190.9 11242.6 11245.9 11256.8 11261.9 9245.4 11099.2 11103.1 11126.6 11140.4 27998.4 28701.6 28714.9 39301.6 39730.4 3106.6 3700.6 3756.3 3788.3 3916.8 28827.6 28936.6 29105.3 29893.7 30556.4 3087.0 3260.7 3273.8 3274.0 3302.3 445460.0 446818.8 446862.0 447311.0 456002.0 62132.0 62471.0 62477.0 62543.7 62732.1 64456.7 65295.7 65472.0 65525.3 65678.7 15336.7 15561.1 15576.3 15622.9 15655.3 11884.3 11965.4 11967.0 11970.6 11996.4 16348.5 17267.9 17302.5 17302.6 17535.6 6614.6 6639.1 6641.1 6686.9 6693.5 775.4 852.5 861.5 874.1 882.8 25512.0 29001.0 29330.0 29443.6 29751.9 946.2 990.4 997.2 1053.5 1177.9 14768.6 14889.7 14950.6 15143.7 15298.3 588742.0 593429.0 594869.0 594907.0 595993.0 58901.0 59181.7 59270.1 59419.1 59483.0 1326.4 1383.6 1384.1 1392.1 1392.7 27531.9 28299.0 28718.6 28763.3 28779.7 49820.0 50151.5 50212.7 50233.0 50350.2 469151.0 471710.0 472060.0 473228.6 473953.0 37043.6 38018.1 38041.0 38209.0 38314.0 42745.9 43281.8 44206.0 44797.0 45232.8 34341.0 34987.8 35297.5 36297.8 36755.6 31001.6 31581.5 32472.0 33705.5 37052.6 34698.8 35427.5 36419.6 36447.3 36472.3 26800.7 29771.6 31932.8 32053.0 32098.7 23337.5 23493.6 23836.6 23910.9 23962.8 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:36770.71 Median:21312.97 stddev:106509.36 (499.7%) stddev-sans-first:106772.98 05:21:25 INFO - PROCESS | 1647 | Values: 322.6 336.9 384.4 396.0 415.6 13473.5 13630.4 14594.9 20641.9 21237.6 17929.8 18454.2 20203.1 21280.3 21386.8 5850.0 6125.2 6130.3 6132.7 6133.3 4368.0 6059.7 6083.3 6098.3 6120.3 5775.0 6068.4 6072.0 6072.2 6078.3 5916.5 5926.2 5959.7 5965.0 5995.4 5032.1 5170.1 5218.8 5228.6 5267.2 23323.4 25420.7 25765.0 26071.0 26267.1 2548.5 2573.8 2594.3 2621.6 2628.1 10236.7 10576.9 10780.2 13580.9 14000.9 1719.5 1729.7 1740.2 1742.3 1754.7 128483.0 132479.0 133025.0 134006.7 135262.0 9596.4 11699.2 11845.0 11872.9 12049.3 15578.3 15614.8 15616.9 15642.0 15647.8 8218.4 8413.9 8428.1 8514.5 8559.3 8037.6 8058.2 8236.0 8243.4 8266.6 4594.6 4685.9 4689.8 4712.9 4892.7 1953.6 2000.7 2006.9 2012.3 2013.3 1026.5 1027.8 1041.1 1052.5 1055.6 18776.3 18915.0 21256.5 21304.4 21321.6 980.2 994.6 1015.3 1047.2 1061.6 10601.7 10678.8 11013.2 11112.0 11117.6 561031.0 565299.2 570336.0 725887.0 727808.0 96453.0 144806.0 152250.2 153290.7 158321.0 1009.7 1018.3 1065.2 1068.1 1070.5 18887.2 19173.9 19449.8 19461.0 19462.9 54018.5 55426.7 55787.7 55810.9 55969.4 80990.2 81374.6 81385.0 81599.2 81698.0 8014.4 8132.4 8296.2 8304.2 8603.5 10717.6 10882.3 12630.6 13193.0 13443.7 9249.3 10625.6 11014.9 11104.1 11262.9 9974.1 10049.0 10426.2 10622.4 11016.2 11099.4 11314.0 11349.7 11440.0 11585.4 8059.2 8273.9 8291.8 8411.2 8607.8 8959.3 10729.5 11017.1 11086.4 11164.8 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5404.43 Median:5235.06 stddev:3004.97 (57.4%) stddev-sans-first:2997.17 05:21:25 INFO - PROCESS | 1647 | Values: 1249.2 1256.5 1419.3 1440.7 1444.4 7333.0 7681.8 8226.8 8466.7 8475.9 8379.2 8484.8 8489.4 8490.6 8491.8 2209.2 2253.8 2255.0 2256.6 2258.5 1967.3 2025.2 2035.8 2048.7 2050.3 2004.7 2197.0 2272.7 2276.9 2295.7 2276.9 2285.9 2286.5 2287.2 2287.9 2057.9 2192.2 2195.8 2302.1 2312.7 8472.8 8520.3 8524.0 8550.1 8564.0 5055.6 5227.7 5228.9 5234.9 5235.2 3235.5 3407.2 3422.3 3479.9 3483.3 1187.4 1202.8 1206.7 1269.1 1274.2 10774.1 10879.7 10893.6 10899.7 10913.6 4372.0 4656.1 4700.2 4729.0 4740.4 9530.0 9547.9 9550.7 9579.0 9585.8 5260.9 5265.3 5272.7 5275.9 5291.5 4606.4 4651.6 4677.5 4778.2 4792.4 3345.6 3720.8 3780.8 3848.2 3858.3 982.2 1153.1 1169.0 1169.1 1172.2 733.4 858.4 867.4 889.9 946.9 5217.7 5281.8 5359.1 5550.7 5553.7 981.9 985.3 990.6 1033.5 1043.4 3515.4 3518.8 3549.4 3596.2 3683.4 9536.9 10038.5 10044.6 10050.3 10061.9 9964.9 9973.5 9978.7 9982.0 9986.3 7793.7 7874.3 7890.4 7894.3 7919.2 5128.3 5383.4 5487.6 5493.2 5516.9 8876.0 9385.5 9386.4 9390.2 9390.4 8873.6 9314.6 9331.6 9471.7 9493.2 7155.7 7309.9 7324.7 7329.1 7338.7 6606.6 7974.0 7983.7 7989.0 8001.4 6891.3 7026.2 7049.9 7248.3 7268.3 6408.1 7105.2 7121.9 7156.1 7176.8 5369.9 6335.5 6390.3 6486.2 6489.9 4546.2 4696.0 4879.0 4905.4 4933.9 3467.8 4976.6 5051.9 5114.6 5192.7 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4186.47 Median:4722.79 stddev:1294.10 (27.4%) stddev-sans-first:1265.29 05:21:25 INFO - PROCESS | 1647 | Values: 349.9 359.4 361.5 366.7 368.7 4389.5 4825.6 5067.0 5103.6 5124.1 4351.4 4403.5 5035.9 5076.3 5117.4 3705.4 3807.0 3904.5 3915.0 3952.9 3395.4 3851.9 3853.1 3896.5 3907.1 3274.5 3387.5 3858.6 3862.6 3869.8 3182.2 3347.3 3717.1 3873.3 3888.3 2655.9 2828.5 3304.3 3320.4 3341.5 3910.0 4881.8 4899.0 4927.3 4957.3 4375.8 4394.8 4406.9 4409.7 4410.3 4662.3 5053.6 5199.2 5266.5 5368.3 3640.6 3653.5 3660.5 3675.5 3685.6 5245.3 5409.8 5457.6 5563.6 5682.2 3037.6 3146.4 3538.2 3576.5 3604.2 3740.7 3741.5 3743.8 3746.4 3755.8 4320.8 4335.7 4350.1 4354.4 4357.0 4083.6 5019.3 5260.0 5329.8 5360.5 1113.9 1133.8 1187.8 1198.6 1211.5 802.8 828.5 838.4 842.0 842.8 4033.4 4311.1 4730.7 4776.4 4806.7 4896.9 5012.2 5214.6 5218.7 5235.3 4161.6 4358.6 4772.0 4774.9 4811.9 2174.4 2237.6 2553.3 2572.9 2777.2 4294.9 4868.4 4936.9 5426.2 5490.2 4515.3 4920.3 5095.7 5342.0 5344.4 5290.8 5318.3 5425.9 5436.9 5461.0 4714.9 5273.0 5432.7 5474.3 5487.8 5120.5 5393.2 5394.8 5402.0 5457.3 4599.4 4841.0 5101.9 5326.9 5361.7 2906.5 3130.3 3215.3 3260.4 3554.6 4576.6 4978.4 4993.4 5446.4 5484.0 4389.4 4490.5 4744.9 4892.3 5257.7 4658.7 4662.5 4747.5 5202.9 5255.3 4948.0 5128.6 5179.6 5196.2 5227.9 4893.7 5165.5 5249.7 5303.3 5306.5 4110.1 4378.5 4920.3 5146.5 5183.8 05:21:25 INFO - PROCESS | 1647 | 05:21:25 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:18840.85 Median:4165.81 stddev:26530.63 (636.9%) stddev-sans-first:26570.14 05:21:25 INFO - PROCESS | 1647 | Values: 712.9 743.8 762.7 805.0 813.9 14187.6 14657.9 14666.6 14668.5 14674.3 12309.9 12658.3 13615.3 13711.1 13711.8 870.9 873.6 894.8 897.3 897.7 906.8 907.7 910.4 912.5 914.2 851.2 907.7 919.2 944.8 950.9 935.5 944.5 946.8 946.9 947.5 701.1 702.6 703.5 704.0 706.2 14848.0 15120.4 15254.3 15288.5 15305.0 13714.6 13867.4 13873.4 13954.9 14159.3 10477.6 10592.6 10596.5 10632.0 11023.8 3135.2 3616.1 3680.7 3795.5 3798.2 103975.5 104215.0 104822.4 104864.0 106694.5 9151.7 10620.7 10884.1 10978.6 11145.9 20319.4 21413.5 21576.7 22074.1 22082.6 7689.2 7778.7 7855.2 7972.0 8052.4 4038.2 4052.4 4110.8 4127.0 4204.7 3613.0 3709.7 3721.4 3722.6 3724.7 674.5 680.6 681.7 709.9 713.2 641.9 657.8 664.6 679.0 751.3 7676.7 8463.7 9273.5 9548.8 9862.6 636.5 657.9 679.7 721.5 721.6 4358.8 4741.3 4742.6 4748.9 4842.0 83099.9 96828.5 97088.0 99956.0 100835.5 50310.7 57802.1 66537.3 66829.7 80307.0 54349.5 59302.0 73383.2 76462.9 77885.6 9217.9 9730.3 10237.0 10262.6 10310.5 42742.9 43442.5 43474.0 44199.1 49150.0 57989.7 61518.7 63251.7 63371.4 63977.4 12480.1 12616.2 12822.1 13118.4 13245.5 14107.7 14283.6 14376.7 14400.6 14400.9 13268.7 13358.9 13406.9 13430.1 13539.7 13249.7 13412.5 13449.0 13656.3 14082.9 12896.4 13095.6 13125.6 13370.3 13689.9 10261.5 10520.6 10740.0 10833.2 11149.0 9783.0 10466.5 11263.7 11305.8 11337.4 05:21:25 INFO - PROCESS | 1647 | -------- Summary: end -------- 05:21:25 INFO - PROCESS | 1647 | 05:21:26 INFO - TEST-INFO | 1647: exit 0 05:21:26 INFO - TEST-OK | dromaeo_css | took 1120489ms 05:21:26 INFO - TEST-START | kraken 05:21:26 INFO - operating with platform_type : mac_ 05:21:26 INFO - Initialising browser for kraken test... 05:21:26 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiAuw7s/profile http://localhost:49246/getInfo.html) 05:21:28 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:21:28 INFO - PROCESS | 1655 | colorDepth:24 05:21:28 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:21:28 INFO - PROCESS | 1655 | __metrics 05:21:28 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:21:28 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:29 INFO - TEST-INFO | 1655: exit 0 05:21:29 INFO - Browser initialized. 05:21:29 INFO - Running cycle 1/1 for kraken test... 05:21:29 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpiAuw7s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:41 INFO - PROCESS | 1657 | RSS: Main: 232001536 05:21:41 INFO - PROCESS | 1657 | 05:21:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:45 INFO - PROCESS | 1657 | RSS: Main: 283742208 05:21:45 INFO - PROCESS | 1657 | 05:21:47 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 05:21:48 INFO - PROCESS | 1657 | RSS: Main: 285868032 05:21:48 INFO - PROCESS | 1657 | 05:21:51 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 05:21:52 INFO - PROCESS | 1657 | RSS: Main: 380203008 05:21:52 INFO - PROCESS | 1657 | 05:21:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 05:21:55 INFO - PROCESS | 1657 | RSS: Main: 282185728 05:21:55 INFO - PROCESS | 1657 | 05:21:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:21:57 INFO - PROCESS | 1657 | RSS: Main: 284594176 05:21:57 INFO - PROCESS | 1657 | 05:22:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:01 INFO - PROCESS | 1657 | RSS: Main: 324931584 05:22:01 INFO - PROCESS | 1657 | 05:22:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:05 INFO - PROCESS | 1657 | RSS: Main: 327888896 05:22:05 INFO - PROCESS | 1657 | 05:22:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 05:22:08 INFO - PROCESS | 1657 | RSS: Main: 325935104 05:22:08 INFO - PROCESS | 1657 | 05:22:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:10 INFO - PROCESS | 1657 | RSS: Main: 300978176 05:22:10 INFO - PROCESS | 1657 | 05:22:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:13 INFO - PROCESS | 1657 | RSS: Main: 304402432 05:22:13 INFO - PROCESS | 1657 | 05:22:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:16 INFO - PROCESS | 1657 | RSS: Main: 306778112 05:22:16 INFO - PROCESS | 1657 | 05:22:19 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:20 INFO - PROCESS | 1657 | RSS: Main: 324988928 05:22:20 INFO - PROCESS | 1657 | 05:22:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:23 INFO - PROCESS | 1657 | RSS: Main: 318877696 05:22:23 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 05:22:25 INFO - PROCESS | 1657 | RSS: Main: 363925504 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | __start_tp_report 05:22:25 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 05:22:25 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 05:22:25 INFO - PROCESS | 1657 | |i|pagename|runs| 05:22:25 INFO - PROCESS | 1657 | |0;ai-astar;115;116;114;115;114;114;113;113;114;112 05:22:25 INFO - PROCESS | 1657 | |1;audio-beat-detection;134;110;111;145;115;110;111;110;129;111 05:22:25 INFO - PROCESS | 1657 | |2;audio-dft;199;263;192;185;181;184;186;188;186;183 05:22:25 INFO - PROCESS | 1657 | |3;audio-fft;80;56;66;109;90;72;60;61;77;58 05:22:25 INFO - PROCESS | 1657 | |4;audio-oscillator;88;70;85;85;102;100;105;67;67;84 05:22:25 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;89;89;90;89;89;89;89;89;90;89 05:22:25 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;96;96;96;96;137;102;95;151;95 05:22:25 INFO - PROCESS | 1657 | |7;imaging-desaturate;88;89;85;86;86;89;88;86;91;88 05:22:25 INFO - PROCESS | 1657 | |8;json-parse-financial;60;57;57;58;57;59;59;59;58;59 05:22:25 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;66;73;74;76;74;69;70;71;69;69 05:22:25 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;89;89;87;85;109;101;86;87;88;92 05:22:25 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;135;149;132;134;142;131;145;156;205;153 05:22:25 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;173;175;173;173;175;173;172;165;174;172 05:22:25 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;66;67;68;68;68;68;69;66;65;66 05:22:25 INFO - PROCESS | 1657 | __end_tp_report 05:22:25 INFO - PROCESS | 1657 | __start_cc_report 05:22:25 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2163 05:22:25 INFO - PROCESS | 1657 | __end_cc_report 05:22:25 INFO - PROCESS | 1657 | __startTimestamp1487856145552__endTimestamp 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | ------- Summary: start ------- 05:22:25 INFO - PROCESS | 1657 | Number of tests: 14 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:1.17 05:22:25 INFO - PROCESS | 1657 | Values: 115.0 116.0 114.0 115.0 114.0 114.0 113.0 113.0 114.0 112.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:113.00 stddev:12.69 (11.2%) stddev-sans-first:12.18 05:22:25 INFO - PROCESS | 1657 | Values: 134.0 110.0 111.0 145.0 115.0 110.0 111.0 110.0 129.0 111.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:194.70 Median:187.00 stddev:24.54 (13.1%) stddev-sans-first:25.98 05:22:25 INFO - PROCESS | 1657 | Values: 199.0 263.0 192.0 185.0 181.0 184.0 186.0 188.0 186.0 183.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:72.90 Median:69.00 stddev:16.76 (24.3%) stddev-sans-first:17.57 05:22:25 INFO - PROCESS | 1657 | Values: 80.0 56.0 66.0 109.0 90.0 72.0 60.0 61.0 77.0 58.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:77.00 stddev:14.13 (18.3%) stddev-sans-first:14.95 05:22:25 INFO - PROCESS | 1657 | Values: 88.0 70.0 85.0 85.0 102.0 100.0 105.0 67.0 67.0 84.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:89.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 05:22:25 INFO - PROCESS | 1657 | Values: 89.0 89.0 90.0 89.0 89.0 89.0 89.0 89.0 90.0 89.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:96.00 stddev:20.34 (21.2%) stddev-sans-first:21.31 05:22:25 INFO - PROCESS | 1657 | Values: 97.0 96.0 96.0 96.0 96.0 137.0 102.0 95.0 151.0 95.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:87.60 Median:88.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 05:22:25 INFO - PROCESS | 1657 | Values: 88.0 89.0 85.0 86.0 86.0 89.0 88.0 86.0 91.0 88.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:1.06 (1.8%) stddev-sans-first:0.93 05:22:25 INFO - PROCESS | 1657 | Values: 60.0 57.0 57.0 58.0 57.0 59.0 59.0 59.0 58.0 59.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:3.07 (4.3%) stddev-sans-first:2.65 05:22:25 INFO - PROCESS | 1657 | Values: 66.0 73.0 74.0 76.0 74.0 69.0 70.0 71.0 69.0 69.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.50 stddev:7.70 (8.8%) stddev-sans-first:8.13 05:22:25 INFO - PROCESS | 1657 | Values: 89.0 89.0 87.0 85.0 109.0 101.0 86.0 87.0 88.0 92.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:147.00 stddev:21.84 (14.9%) stddev-sans-first:22.64 05:22:25 INFO - PROCESS | 1657 | Values: 135.0 149.0 132.0 134.0 142.0 131.0 145.0 156.0 205.0 153.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:2.84 (1.6%) stddev-sans-first:3.00 05:22:25 INFO - PROCESS | 1657 | Values: 173.0 175.0 173.0 173.0 175.0 173.0 172.0 165.0 174.0 172.0 05:22:25 INFO - PROCESS | 1657 | 05:22:25 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 05:22:25 INFO - PROCESS | 1657 | Values: 66.0 67.0 68.0 68.0 68.0 68.0 69.0 66.0 65.0 66.0 05:22:25 INFO - PROCESS | 1657 | -------- Summary: end -------- 05:22:25 INFO - PROCESS | 1657 | 05:22:26 INFO - TEST-INFO | 1657: exit 0 05:22:26 INFO - TEST-OK | kraken | took 60255ms 05:22:26 INFO - SUITE-END | took 1180s 05:22:26 INFO - Completed test suite (00:19:40) 05:22:26 INFO - javascript benchmark 05:22:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7085.53795843253, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.084501762016, 3341.582302212225, 3359.009092317766, 3369.326134773046, 3401.7448691348154, 5483.314585676791, 5544.1960915667205, 5660.8301750947485, 5681.005823980808, 5863.355030946598, 5537.390887002426, 5579.442055794419, 5593.272874526316, 5600.887982240352, 5601.663900165993, 5073.873153171164, 5080.745962701869, 5107.208382700687, 5110.310108135392, 5156.458571849958, 5175.896482070356, 5187.610929180308, 5190.974045129769, 5194.688318700871, 5200.271961925334, 5166.147585648364, 5168.431472538018, 5169.353830771153, 5173.327467429229, 5178.896422071575, 5188.014277287322, 5200.699825043739, 5207.114790485626, 5208.895822083575, 5209.6874187548865, 5028.245763135523, 5148.665336753099, 5162.74186290684, 5167.224916262553, 5168.689878607258, 5676.290463692038, 5741.770329186827, 5759.424057594249, 5762.106873434583, 5769.826905192851, 6205.782797602107, 6209.5032397408095, 6210.192674952273, 6224.346443623445, 6226.377362263737, 5036.622253331015, 6093.329733729286, 6109.951287404306, 6114.510839132859, 6136.110264011693, 4748.833790817304, 5395.352557693062, 5664.40523745005, 5724.1413787931315, 5837.182794408786, 6226.941419958618, 6254.21822272216, 6264.310925798159, 6270.59241149333, 6274.498040156776, 6161.7535298588455, 6164.506839452833, 6173.259208894961, 6179.752809887644, 6192.0, 5350.785968561292, 5997.010493268562, 6049.758009679564, 6119.99004232014, 6140.754369825157, 5917.7928772493615, 6064.241969753781, 6065.393460653988, 6078.149059131725, 6084.908726369108, 6064.636121832616, 6099.2985806632805, 6100.254632272244, 6109.495762817132, 6128.78549250783, 4860.854174374775, 4872.488388719134, 4876.366072410564, 4877.853664390074, 4880.95119048805, 3426.623071462137, 4344.044310251739, 4359.38968544404, 4418.182636212311, 4452.354408610798, 5773.191753154561, 5776.191333213354, 5778.855528611818, 5779.855503612359, 5808.912866307009, 6270.498360131179, 6278.121063051177, 6294.339094395023, 6298.212723409574, 6310.0534919761485, 5578.0, 5615.803446879339, 5626.521745651584, 5790.247267855236, 5811.535077193899, 5331.280277162534, 5333.7866485340155, 5338.439463856317, 5341.172118321589, 5347.625666203407, 6199.287081985539, 6304.747810087545, 6307.653079080603, 6323.683815809191, 6324.146240257598, 6104.755809767559, 6114.449699526886, 6130.275842464065, 6154.969225153845, 6245.500359971101, 6261.56169068179, 6265.248170219603, 6266.968665156645, 6270.184875966095, 6274.623522588659, 5417.3378676689745, 6207.193064901534, 6208.192934918432, 6209.130721699056, 6221.502279817513, 5063.316452278895, 6048.7278072487725, 6114.174586430775, 6282.874342513215, 6303.842403939938, 5177.404598471224, 5975.103734439869, 5977.970110149421, 5978.850528736642, 5982.730777115127, 5944.732487038007, 5969.940300597113, 6016.639001659914, 6032.366601506954, 6064.363241859542, 4296.699231053921, 4470.8435204767675, 5862.915360658121, 5903.144044113666, 5917.881642367214, 6112.5412656287845, 6147.0, 6154.015357542772, 6155.47678447337, 6161.353057929032, 5945.375735547878, 5949.6430214187285, 5961.672108034099, 5965.224520812267, 5992.370801065826], "value": 5605.392408324238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.89803396201887, 459.9168957106013, 463.849248994077, 486.68608747357956, 502.7863158157783, 27153.59269610955, 29351.945363824514, 29380.70619293809, 29457.558136627915, 40182.799086004605, 40912.77261682147, 43430.0, 43601.78199109008, 43613.0, 43699.0, 9142.725718228447, 9355.204807591328, 9357.391769534992, 9365.48489833059, 9366.578503967337, 7349.669264883067, 7606.277403646644, 9078.45529268246, 9204.539773011356, 9229.446233226028, 7549.811254718621, 7606.885896711526, 7641.808954776119, 10890.727731806728, 11250.212485126045, 11190.888091119106, 11242.550297988071, 11245.943770281096, 11256.774864502746, 11261.943690281578, 9245.445273283625, 11099.167562432769, 11103.056240219592, 11126.554937802479, 11140.387278699669, 27998.44003119926, 28701.56947645787, 28714.856425717946, 39301.60698393008, 39730.404043939365, 3106.642736085334, 3700.6299370063048, 3756.267527832074, 3788.3370410178386, 3916.8445308634023, 28827.56758648622, 28936.565951510533, 29105.272368190752, 29893.70106298931, 30556.388872222433, 3086.9845650771604, 3260.7065364117343, 3273.8035717857006, 3273.9508907366408, 3302.256992176741, 445460.0, 446818.76590617164, 446862.0, 447311.0, 456002.0, 62132.0, 62471.0, 62477.0, 62543.6872815633, 62732.05901911475, 64456.67771661111, 65295.67352163209, 65472.03583892491, 65525.34474655193, 65678.67160664166, 15336.693266134838, 15561.066336019874, 15576.299066542033, 15622.921885390728, 15655.295511702001, 11884.286942783461, 11965.40172991347, 11967.0, 11970.581029664094, 11996.400179990966, 16348.509544713677, 17267.91366043162, 17302.480925572254, 17302.567435814206, 17535.64928701419, 6614.636195009224, 6639.136912201479, 6641.103451034145, 6686.899696504556, 6693.497987650946, 775.4378075895044, 852.4885068958699, 861.4831101339272, 874.1346067393235, 882.7748924024332, 25512.0, 29001.019621496773, 29330.0, 29443.558346624817, 29751.851240743657, 946.186279799372, 990.3760630802549, 997.1972562087444, 1053.5311786255197, 1177.9469923853276, 14768.556943291718, 14889.70220595582, 14950.551483455514, 15143.697126057417, 15298.311575979107, 588742.0, 593429.0, 594869.0, 594907.0, 595993.0, 58901.0, 59181.70409147927, 59270.11094833581, 59419.108713369336, 59483.0, 1326.4296352568294, 1383.6125884752284, 1384.0934188107008, 1392.1090502078678, 1392.7423426666098, 27531.862340688167, 28299.0, 28718.569221461275, 28763.28091797722, 28779.712202877705, 49820.0, 50151.49848501614, 50212.748936255084, 50233.0, 50350.2447463281, 469151.0, 471710.0, 472060.0, 473228.6338568285, 473953.0, 37043.62956370402, 38018.057652505, 38041.0, 38209.04477388087, 38314.0, 42745.931351716456, 43281.783591083105, 44206.0, 44797.0, 45232.77383613061, 34341.0, 34987.82506087453, 35297.52888302317, 36297.81851090727, 36755.63244367629, 31001.555164746213, 31581.526277105404, 32472.0, 33705.494417583264, 37052.62947370492, 34698.826505867306, 35427.46858797069, 36419.63580364163, 36447.27105457929, 36472.27055458929, 26800.731992679823, 29771.553426698185, 31932.8403357991, 32053.0, 32098.67901320957, 23337.533249334578, 23493.647595286428, 23836.642450363604, 23910.88044559766, 23962.760372396053], "value": 19177.691980184896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.646497941137, 336.9090345606686, 384.42528420012087, 395.9524857017158, 415.6010230179028, 13473.528426505074, 13630.386632601532, 14594.927025364872, 20641.896790516028, 21237.57524849506, 17929.820701792978, 18454.16956236969, 20203.090860911256, 21280.255191068314, 21386.786132138674, 5849.9707501462435, 6125.234345706786, 6130.2643682758135, 6132.662703551303, 6133.325334213233, 4368.0390314131, 6059.697015149247, 6083.330833608299, 6098.329183789801, 6120.26556813183, 5775.018246898037, 6068.362821903703, 6071.967765479879, 6072.240969878765, 6078.331383547807, 5916.526677865761, 5926.199963004982, 5959.702014899238, 5964.97017514914, 5995.400459953991, 5032.094223039851, 5170.06122703986, 5218.843434696965, 5228.5555727763185, 5267.209918512215, 23323.4169145771, 25420.745792542024, 25765.0, 26071.0, 26267.080652177272, 2548.490301939601, 2573.768360847514, 2594.299539124445, 2621.5936529837904, 2628.1195799407224, 10236.74408139795, 10576.894231057668, 10780.188570943676, 13580.86419135806, 14000.87992960571, 1719.4841547535689, 1729.6713624411323, 1740.225599608175, 1742.268247336122, 1754.7104727719911, 128483.0, 132479.0, 133025.0, 134006.65993340136, 135262.0, 9596.376235544667, 11699.181057326075, 11845.0, 11872.88127118735, 12049.277043377426, 15578.298976546082, 15614.843851561565, 15616.921915390578, 15642.0, 15647.765283520755, 8218.424710270223, 8413.873791893126, 8428.072911979678, 8514.48913065218, 8559.26103646827, 8037.557934313669, 8058.234467725557, 8235.95882020586, 8243.381746369047, 8266.586670666442, 4594.563516465931, 4685.929711054337, 4689.788959496831, 4712.88217794551, 4892.657513973988, 1953.5702145527962, 2000.7295367441488, 2006.8795872247713, 2012.3459875540507, 2013.3054096336741, 1026.5431882812227, 1027.814993301198, 1041.1098510773331, 1052.4959614679456, 1055.6252530351614, 18776.342828001227, 18914.959677217885, 21256.468588285108, 21304.36086917364, 21321.573568528853, 980.2109302011949, 994.6369575105034, 1015.2639336480992, 1047.1675018360422, 1061.580675633136, 10601.734956626146, 10678.839817402744, 11013.176282691284, 11111.999920007238, 11117.55529778816, 561031.0, 565299.1735041299, 570336.0, 725887.0, 727808.0, 96453.0, 144806.0, 152250.23874880554, 153290.70063948826, 158321.0, 1009.6718566465928, 1018.3177271228295, 1065.2064212161988, 1068.086785798147, 1070.4915165296422, 18887.150078246235, 19173.90413047926, 19449.8055019448, 19461.0, 19462.902685486482, 54018.459815401344, 55426.72286638541, 55787.72106139443, 55810.88378232494, 55969.444125042595, 80990.19009809826, 81374.59312703398, 81385.0, 81599.18400815917, 81698.0, 8014.438989270929, 8132.430729848854, 8296.211859873303, 8304.211099945496, 8603.483790972561, 10717.624883129052, 10882.29265097766, 12630.557930472389, 13192.955091960377, 13443.731125377633, 9249.30630202724, 10625.574977000833, 11014.944925275322, 11104.056155226895, 11262.943685281522, 9974.052465015811, 10049.0, 10426.218033647356, 10622.36265824053, 11016.228863979444, 11099.445027748741, 11313.983535844985, 11349.7085845104, 11440.027597654293, 11585.362805045803, 8059.194080591894, 8273.917260827555, 8291.83416331658, 8411.242988131098, 8607.784805379915, 8959.328050396116, 10729.46352682347, 11017.11863050938, 11086.445677715921, 11164.776704466027], "value": 9715.666634014106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.175544140867, 1256.484841215101, 1419.3045407750199, 1440.7190597833423, 1444.3500424808833, 7333.046703928489, 7681.846363072736, 8226.83546329073, 8466.66133354665, 8475.91524084759, 8379.162083791618, 8484.787880302996, 8489.363297752663, 8490.6179221935, 8491.830163396744, 2209.1826024371007, 2253.785890340415, 2255.030336955109, 2256.5599708056934, 2258.5369999150216, 1967.301607929186, 2025.230412443277, 2035.847311451647, 2048.7336646236045, 2050.3028970150144, 2004.7093171490126, 2197.0333053456507, 2272.6591011348264, 2276.8633881967053, 2295.7015587973624, 2276.897539610713, 2285.8628482291033, 2286.474110954473, 2287.2109122352763, 2287.897044632979, 2057.9382618521468, 2192.2217612747404, 2195.7913998170147, 2302.0791683326634, 2312.664663623765, 8472.78818029548, 8520.318374530023, 8523.95738021306, 8550.144985501462, 8564.015138259118, 5055.5702765265, 5227.66020208689, 5228.8692782680355, 5234.92147617786, 5235.188545775411, 3235.530848027023, 3407.16524451511, 3422.2984288221105, 3479.9478007829903, 3483.2511010132944, 1187.3825610682397, 1202.7774861650535, 1206.6681662542783, 1269.1306455078209, 1274.222724138275, 10774.084202842767, 10879.673609791718, 10893.618723344724, 10899.727506812314, 10913.563457461612, 4371.956280437155, 4656.115338085753, 4700.2009658358165, 4729.0, 4740.4311482621615, 9530.0, 9547.856782148274, 9550.665726699672, 9578.952105239428, 9585.808283834283, 5260.947390526046, 5265.262863199156, 5272.657277276965, 5275.947240527622, 5291.470852914677, 4606.401167848226, 4651.604613607814, 4677.4854765975715, 4778.1638213312535, 4792.353032340589, 3345.5985281765857, 3720.7581507201944, 3780.8487660493274, 3848.1534062506203, 3858.2862170498547, 982.1995074014656, 1153.1236260441956, 1168.9590864319707, 1169.0939521870619, 1172.2204733852063, 733.4081238293418, 858.3862538285156, 867.3624885708999, 889.9320815021999, 946.9289803264783, 5217.739113044333, 5281.815136470205, 5359.115745901882, 5550.72246387679, 5553.666779993213, 981.8723565936383, 985.2856678907734, 990.5592011554933, 1033.4987531047436, 1043.3635482355758, 3515.3672338978718, 3518.82405879705, 3549.396602577568, 3596.1908570571413, 3683.355412802749, 9536.856947145798, 10038.498075096217, 10044.648437304806, 10050.346727462691, 10061.949690251502, 9964.850527242097, 9973.451460169616, 9978.650747223957, 9981.951895051061, 9986.30095893295, 7793.688252469951, 7874.251946065, 7890.368770498347, 7894.289513943658, 7919.247671471201, 5128.333316668958, 5383.40782513931, 5487.6158668892795, 5493.2034854946605, 5516.862078447911, 8876.0, 9385.530723463937, 9386.389884657476, 9390.201832844285, 9390.436573805593, 8873.556322183736, 9314.6274149036, 9331.580078896603, 9471.66849160276, 9493.24054075686, 7155.713771449084, 7309.853802924018, 7324.743633972786, 7329.083864516935, 7338.669759860926, 6606.6036037837885, 7974.0, 7983.72056978003, 7989.041315042232, 8001.439899207, 6891.310868913069, 7026.191987921455, 7049.894251586128, 7248.347648711641, 7268.309510596485, 6408.1349017881985, 7105.18290396611, 7121.857562848818, 7156.069710937545, 7176.7846964591145, 5369.892602148013, 6335.461485773761, 6390.265119511316, 6486.221653401433, 6489.8702025960165, 4546.249868771748, 4695.9530404695515, 4878.9512104878495, 4905.386826646669, 4933.901321973469, 3467.8266086696067, 4976.576990955809, 5051.949480505148, 5114.590832733446, 5192.740362981911], "value": 4360.290018571692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8705478972781, 359.3746880428054, 361.5372323426014, 366.6883149323077, 368.6737237544772, 4389.539098394671, 4825.573842571774, 5066.974665126674, 5103.642745007851, 5124.128898087325, 4351.390805287262, 4403.515613282536, 5035.949640503594, 5076.263941728447, 5117.437081920985, 3705.3511187521494, 3807.0, 3904.472896159025, 3914.9804250978705, 3952.861649842256, 3395.405803984293, 3851.8844434667003, 3853.133045064852, 3896.5129358830145, 3907.101366685664, 3274.476083826576, 3387.508811222371, 3858.649472684552, 3862.613738626143, 3869.7678139311593, 3182.204448887778, 3347.3472672828807, 3717.070732316921, 3873.2640798248244, 3888.3389823730035, 2655.893764249447, 2828.5332920068163, 3304.322613864152, 3320.3857286401853, 3341.496326653016, 3909.9609003910164, 4881.755912204376, 4898.951010489885, 4927.285543596158, 4957.330760347343, 4375.840402293363, 4394.846180383671, 4406.867793966154, 4409.735415875058, 4410.29435290352, 4662.277347011219, 5053.595712343041, 5199.220116982445, 5266.499682530153, 5368.32895888014, 3640.5995340512522, 3653.5433070866143, 3660.4509323601405, 3675.4854320394898, 3685.649863262986, 5245.26566280721, 5409.756560954727, 5457.645253058538, 5563.638363506399, 5682.232898558683, 3037.6202974628172, 3146.3707258548384, 3538.168530395355, 3576.5350504434778, 3604.1530240393486, 3740.738148329591, 3741.4659989404213, 3743.794091325003, 3746.363118269846, 3755.8497660093835, 4320.848770293024, 4335.653147748172, 4350.0647360817575, 4354.412154359185, 4356.956430435655, 4083.6324730773777, 5019.272205530251, 5259.973700131475, 5329.786808527693, 5360.544353729977, 1113.8663360396642, 1133.7868480725708, 1187.7980743273665, 1198.6224339333082, 1211.4790640024873, 802.827392110699, 828.5443006346605, 838.3837879158814, 841.9960494024183, 842.7556008757392, 4033.3664865729424, 4311.09467011931, 4730.716157030521, 4776.402949631296, 4806.711597304103, 4896.898197905442, 5012.248162775612, 5214.582833373321, 5218.66078704883, 5235.345581802275, 4161.62545370912, 4358.607725304738, 4771.971911937413, 4774.880627984328, 4811.941372897957, 2174.3911704722705, 2237.5567758795487, 2553.348896031537, 2572.9450925120987, 2777.1668499450084, 4294.871153865389, 4868.391451068616, 4936.8765780855765, 5426.186072089139, 5490.203920431595, 4515.322701594721, 4920.261960705922, 5095.694258344512, 5342.0, 5344.412114667383, 5290.788368465295, 5318.282031925641, 5425.864353391197, 5436.864078398072, 5461.0, 4714.858554243378, 5272.9736351318, 5432.674039557639, 5474.2609747683555, 5487.832306239093, 5120.513551212629, 5393.244945707683, 5394.784208631768, 5402.028259685108, 5457.263269458573, 4599.356090147315, 4840.95159048405, 5101.9489805101475, 5326.927302874648, 5361.68638683525, 2906.549484829855, 3130.3426280481353, 3215.3408551247408, 3260.3805276997296, 3554.5556805399324, 4576.565226303496, 4978.402591688876, 4993.400791904995, 5446.400895901527, 5484.040292948638, 4389.40742999691, 4490.483594386687, 4744.857654270378, 4892.339534162842, 5257.7371131442505, 4658.650601204856, 4662.510436404129, 4747.477777444547, 5202.869928251824, 5255.3168088148295, 4947.975260123676, 5128.640825220291, 5179.637425380187, 5196.168613021899, 5227.947720522899, 4893.7063776173545, 5165.509276618715, 5249.7112658804135, 5303.337082864642, 5306.54894333986, 4110.116324990141, 4378.496472905656, 4920.286558449076, 5146.536811686966, 5183.81856635016], "value": 3793.668609750991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.896629988652, 743.8326376565274, 762.6796745366945, 805.0, 813.8697808350665, 14187.64530886727, 14657.926710366433, 14666.633334166638, 14668.486602968898, 14674.339654715537, 12309.936262462792, 12658.303793291365, 13615.25116118613, 13711.108777929428, 13711.794323085162, 870.8824308718321, 873.6243415331405, 894.8299823033602, 897.3270047464401, 897.6723495923974, 906.8277027364779, 907.7412937312868, 910.3718434280358, 912.4753266871543, 914.2457472585111, 851.2296371783515, 907.732218995398, 919.1589695428675, 944.8299306124894, 950.8906475755308, 935.4854829843592, 944.5466176235411, 946.8059047895234, 946.9100435458621, 947.5309721687809, 701.0605788243778, 702.596007295807, 703.4688809948456, 704.0389867830374, 706.2372637551483, 14848.0, 15120.39518419262, 15254.313555890012, 15288.464903728427, 15305.0, 13714.588562343046, 13867.4453021879, 13873.37569809361, 13954.893174559887, 14159.292035398188, 10477.63328283514, 10592.629257975934, 10596.470176491144, 10632.043116119508, 11023.779524409547, 3135.2318681922848, 3616.059824445637, 3680.6687398134027, 3795.525559305087, 3798.2403519295976, 103975.4801225989, 104215.0, 104822.42766358434, 104864.0, 106694.46652766687, 9151.725448236564, 10620.734481638021, 10884.129269658408, 10978.615748448767, 11145.888541114486, 20319.39041828718, 21413.464663383227, 21576.676349854766, 22074.11703531873, 22082.558348832932, 7689.231076892378, 7778.727744528915, 7855.175206603224, 7972.043354797345, 8052.355811535181, 4038.1519880825354, 4052.3516237401873, 4110.77390743512, 4126.958730412717, 4204.663626909901, 3613.0, 3709.684676802502, 3721.3859713147026, 3722.590515043343, 3724.65912271582, 674.5244602555186, 680.6303531328881, 681.6659836679991, 709.8970649255829, 713.2119008495641, 641.9279802729453, 657.789507357641, 664.6495709538198, 678.9927943621874, 751.2862780358681, 7676.731314404081, 8463.74608761738, 9273.489958052372, 9548.761280968032, 9862.556184971694, 636.4526507203801, 657.904573932028, 679.7145199016425, 721.538215542043, 721.6067243352386, 4358.820227230904, 4741.312509686076, 4742.596879265301, 4748.928766068511, 4841.95158048415, 83099.92250193794, 96828.51585742027, 97088.0, 99956.0, 100835.49582252042, 50310.74844625754, 57802.13296800551, 66537.33462665312, 66829.66585167043, 80307.0, 54349.48890897722, 59302.0, 73383.16542086384, 76462.8530572053, 77885.61057194791, 9217.939936907072, 9730.318877678777, 10237.0, 10262.58949642006, 10310.484475776331, 42742.87085549754, 43442.52870690185, 43474.0, 44199.13809481019, 49150.0, 57989.710051449474, 61518.69240653947, 63251.683741581, 63371.366286336546, 63977.36022639714, 12480.135502030183, 12616.243025418504, 12822.102452828585, 13118.409671564994, 13245.470181192644, 14107.717845642825, 14283.642908926944, 14376.712465750836, 14400.567982960529, 14400.855991439952, 13268.734625307632, 13358.933205333911, 13406.865931340952, 13430.127041742255, 13539.729205416033, 13249.735005300034, 13412.530561430303, 13448.967704355673, 13656.317184140951, 14082.859171408154, 12896.355182241037, 13095.626551174973, 13125.60623181306, 13370.264635445144, 13689.86310136886, 10261.507419813075, 10520.631777887736, 10739.988377925833, 10833.187510936868, 11149.007994966265, 9783.0, 10466.529006194587, 11263.718407039889, 11305.773884522428, 11337.433128343715], "value": 7323.805632139252, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 110.0, 111.0, 145.0, 115.0, 110.0, 111.0, 110.0, 129.0, 111.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 263.0, 192.0, 185.0, 181.0, 184.0, 186.0, 188.0, 186.0, 183.0], "value": 194.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 66.0, 109.0, 90.0, 72.0, 60.0, 61.0, 77.0, 58.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 85.0, 102.0, 100.0, 105.0, 67.0, 67.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 89.0, 89.0, 89.0, 89.0, 89.0, 90.0, 89.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 137.0, 102.0, 95.0, 151.0, 95.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 85.0, 86.0, 86.0, 89.0, 88.0, 86.0, 91.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 58.0, 57.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 74.0, 76.0, 74.0, 69.0, 70.0, 71.0, 69.0, 69.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 87.0, 85.0, 109.0, 101.0, 86.0, 87.0, 88.0, 92.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 149.0, 132.0, 134.0, 142.0, 131.0, 145.0, 156.0, 205.0, 153.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 173.0, 175.0, 173.0, 172.0, 165.0, 174.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 66.0, 65.0, 66.0], "value": 67.1, "unit": "score"}]}]} 05:22:26 INFO - Return code: 0 05:22:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:26 ERROR - # TBPL SUCCESS # 05:22:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:26 INFO - 2017-02-23 05:22:26.902 screenresolution[1661:12545] starting screenresolution argv=screenresolution get 05:22:26 INFO - 2017-02-23 05:22:26.905 screenresolution[1661:12545] Display 0: 1600x1200x32@60 05:22:26 INFO - 2017-02-23 05:22:26.912 screenresolution[1662:12548] starting screenresolution argv=screenresolution list 05:22:26 INFO - Available Modes on Display 0 05:22:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:27 INFO - Intel Iris: 05:22:27 INFO - Chipset Model: Intel Iris 05:22:27 INFO - Type: GPU 05:22:27 INFO - Bus: Built-In 05:22:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:27 INFO - Vendor: Intel (0x8086) 05:22:27 INFO - Device ID: 0x0a2e 05:22:27 INFO - Revision ID: 0x0009 05:22:27 INFO - Displays: 05:22:27 INFO - Display: 05:22:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:27 INFO - Display Serial Number: 1600x1200 60 05:22:27 INFO - Main Display: Yes 05:22:27 INFO - Mirror: Off 05:22:27 INFO - Online: Yes 05:22:27 INFO - Rotation: Supported 05:22:27 INFO - Return code: 0 05:22:27 INFO - Running post-action listener: _resource_record_post_action 05:22:27 INFO - [mozharness: 2017-02-23 13:22:27.150892Z] Finished run-tests step (success) 05:22:27 INFO - Running post-run listener: _resource_record_post_run 05:22:27 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32529408; Write bytes: 514770944; Read time: 197; Write time: 1610 05:22:27 INFO - TinderboxPrint: CPU usage
54.0% 05:22:27 INFO - TinderboxPrint: I/O read bytes / time
32,529,408 / 197 05:22:27 INFO - TinderboxPrint: I/O write bytes / time
514,770,944 / 1,610 05:22:27 INFO - TinderboxPrint: CPU idle
2,213.3 (46.0%) 05:22:27 INFO - TinderboxPrint: CPU system
961.7 (20.0%) 05:22:27 INFO - TinderboxPrint: CPU user
1,634.6 (34.0%) 05:22:27 INFO - TinderboxPrint: Swap in / out
238,845,952 / 0 05:22:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204198400; Write bytes: 201822208; Read time: 15564; Write time: 449 05:22:27 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30723072; Write bytes: 302319616; Read time: 181; Write time: 1127 05:22:27 INFO - Running post-run listener: _upload_blobber_files 05:22:27 INFO - Blob upload gear active. 05:22:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:27 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 05:22:27 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'] 05:22:27 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 05:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:29 INFO - (blobuploader) - INFO - Done attempting. 05:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:30 INFO - (blobuploader) - INFO - Done attempting. 05:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:31 INFO - (blobuploader) - INFO - Done attempting. 05:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:33 INFO - (blobuploader) - INFO - Done attempting. 05:22:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:33 INFO - Return code: 0 05:22:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6003dfb93281fe60fb28e1d5b52fc35e5afecc717be228196b56591685b0d632566faddfe46bc19fa53ae6136f82bf5ed48e1cc7b7d4015673c03315b1c98c30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4925bf336ae37594732726b9e3c5a1b4d5a0a00b689a8dc24d7231ae951af3c0c4aaaadd16b635f0d9312b525eecfdf906df335b7ab1e0121f28258112ab32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b7a82a418329110ae1ade698bc9e6d69f79d0800cfca3ab43bd4ea111c51209511389b8483ed431abfdc8a208f7f1248aba9ad87b99d338e08613dc81db0df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c972b62b9547b7891ab1fc7cf772c669938be1a9857b563a95232fcb63b9a410932ac3aae24f505214f7c74040441862e7701e51e8d5808f79d87de3a21cd6b"} 05:22:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:33 INFO - Contents: 05:22:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6003dfb93281fe60fb28e1d5b52fc35e5afecc717be228196b56591685b0d632566faddfe46bc19fa53ae6136f82bf5ed48e1cc7b7d4015673c03315b1c98c30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4925bf336ae37594732726b9e3c5a1b4d5a0a00b689a8dc24d7231ae951af3c0c4aaaadd16b635f0d9312b525eecfdf906df335b7ab1e0121f28258112ab32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b7a82a418329110ae1ade698bc9e6d69f79d0800cfca3ab43bd4ea111c51209511389b8483ed431abfdc8a208f7f1248aba9ad87b99d338e08613dc81db0df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c972b62b9547b7891ab1fc7cf772c669938be1a9857b563a95232fcb63b9a410932ac3aae24f505214f7c74040441862e7701e51e8d5808f79d87de3a21cd6b"} 05:22:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:33 INFO - Copying logs to upload dir... 05:22:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.187981 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-23 05:22:33.585333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 05:22:33.588328) ========= 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.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6003dfb93281fe60fb28e1d5b52fc35e5afecc717be228196b56591685b0d632566faddfe46bc19fa53ae6136f82bf5ed48e1cc7b7d4015673c03315b1c98c30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4925bf336ae37594732726b9e3c5a1b4d5a0a00b689a8dc24d7231ae951af3c0c4aaaadd16b635f0d9312b525eecfdf906df335b7ab1e0121f28258112ab32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b7a82a418329110ae1ade698bc9e6d69f79d0800cfca3ab43bd4ea111c51209511389b8483ed431abfdc8a208f7f1248aba9ad87b99d338e08613dc81db0df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c972b62b9547b7891ab1fc7cf772c669938be1a9857b563a95232fcb63b9a410932ac3aae24f505214f7c74040441862e7701e51e8d5808f79d87de3a21cd6b"} build_url:https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/TSLyfZQaTHaNAXIVP1DKeA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6003dfb93281fe60fb28e1d5b52fc35e5afecc717be228196b56591685b0d632566faddfe46bc19fa53ae6136f82bf5ed48e1cc7b7d4015673c03315b1c98c30", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4925bf336ae37594732726b9e3c5a1b4d5a0a00b689a8dc24d7231ae951af3c0c4aaaadd16b635f0d9312b525eecfdf906df335b7ab1e0121f28258112ab32b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47b7a82a418329110ae1ade698bc9e6d69f79d0800cfca3ab43bd4ea111c51209511389b8483ed431abfdc8a208f7f1248aba9ad87b99d338e08613dc81db0df", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c972b62b9547b7891ab1fc7cf772c669938be1a9857b563a95232fcb63b9a410932ac3aae24f505214f7c74040441862e7701e51e8d5808f79d87de3a21cd6b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 05:22:33.620981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:22:33.621303) ========= 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.nbGLzhv8JA/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.ci4oVgQODx/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005275 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 05:22:33.669534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 05:22:33.669816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 05:22:33.670134) ========= ========= Total master_lag: 0.22 =========